builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1468456080.7 results: success (0) buildid: 20160713143006 builduid: 9e60eb45167040969243f9260c444e5b revision: 34a128489d8895e2f1ef58f43e2b4d196be6e544 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.696933) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.697715) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.698001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.726951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.727290) ========= 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=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 17:28:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-07-13 17:28:01 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071396 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.813295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.813631) ========= 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=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:00.864087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 17:28:00.864405) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34a128489d8895e2f1ef58f43e2b4d196be6e544 --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 34a128489d8895e2f1ef58f43e2b4d196be6e544 --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=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 17:28:01,738 truncating revision to first 12 chars 2016-07-13 17:28:01,738 Setting DEBUG logging. 2016-07-13 17:28:01,738 attempt 1/10 2016-07-13 17:28:01,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34a128489d88?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 17:28:02,755 unpacking tar archive at: fx-team-34a128489d88/testing/mozharness/ program finished with exit code 0 elapsedTime=1.349478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 17:28:02.228749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:02.229082) ========= script_repo_revision: 34a128489d8895e2f1ef58f43e2b4d196be6e544 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:02.229514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:02.229793) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:28:02.239940) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-13 17:28:02.240358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:28:03 INFO - MultiFileLogger online at 20160713 17:28:03 in /builds/slave/test 17:28:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:28:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:28:03 INFO - {'append_to_log': False, 17:28:03 INFO - 'base_work_dir': '/builds/slave/test', 17:28:03 INFO - 'blob_upload_branch': 'Fx-Team', 17:28:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:28:03 INFO - 'branch': 'Fx-Team', 17:28:03 INFO - 'buildbot_json_path': 'buildprops.json', 17:28:03 INFO - 'config_files': ('talos/linux_config.py',), 17:28:03 INFO - 'default_actions': ('clobber', 17:28:03 INFO - 'read-buildbot-config', 17:28:03 INFO - 'download-and-extract', 17:28:03 INFO - 'populate-webroot', 17:28:03 INFO - 'create-virtualenv', 17:28:03 INFO - 'install', 17:28:03 INFO - 'run-tests'), 17:28:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:28:03 INFO - 'download_minidump_stackwalk': True, 17:28:03 INFO - 'download_symbols': 'ondemand', 17:28:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:28:03 INFO - 'tooltool.py': '/tools/tooltool.py', 17:28:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:28:03 INFO - '/tools/misc-python/virtualenv.py')}, 17:28:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:28:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:28:03 INFO - 'installer_path': 'installer.exe', 17:28:03 INFO - 'log_level': 'info', 17:28:03 INFO - 'log_name': 'talos', 17:28:03 INFO - 'log_to_console': True, 17:28:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:28:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:28:03 INFO - 'opt_config_files': (), 17:28:03 INFO - 'pip_index': False, 17:28:03 INFO - 'sps_profile': False, 17:28:03 INFO - 'sps_profile_interval': 0, 17:28:03 INFO - 'suite': 'dromaeojs', 17:28:03 INFO - 'system_bits': '32', 17:28:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:28:03 INFO - 'title': 'talos-linux64-ix-007', 17:28:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:28:03 INFO - 'use_talos_json': True, 17:28:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:28:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:28:03 INFO - 'work_dir': 'build'} 17:28:03 INFO - ##### 17:28:03 INFO - ##### Running clobber step. 17:28:03 INFO - ##### 17:28:03 INFO - Running pre-action listener: _resource_record_pre_action 17:28:03 INFO - Running main action method: clobber 17:28:03 INFO - rmtree: /builds/slave/test/build 17:28:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:28:03 INFO - Running post-action listener: _resource_record_post_action 17:28:03 INFO - ##### 17:28:03 INFO - ##### Finished clobber step (success) 17:28:03 INFO - ##### 17:28:03 INFO - ##### 17:28:03 INFO - ##### Running read-buildbot-config step. 17:28:03 INFO - ##### 17:28:03 INFO - Running pre-action listener: _resource_record_pre_action 17:28:03 INFO - Running main action method: read_buildbot_config 17:28:03 INFO - Using buildbot properties: 17:28:03 INFO - { 17:28:03 INFO - "project": "", 17:28:03 INFO - "product": "firefox", 17:28:03 INFO - "script_repo_revision": "production", 17:28:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:28:03 INFO - "repository": "", 17:28:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:28:03 INFO - "buildid": "20160713143006", 17:28:03 INFO - "pgo_build": "True", 17:28:03 INFO - "basedir": "/builds/slave/test", 17:28:03 INFO - "buildnumber": 282, 17:28:03 INFO - "slavename": "talos-linux64-ix-007", 17:28:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:28:03 INFO - "platform": "ubuntu64_hw", 17:28:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:28:03 INFO - "branch": "fx-team", 17:28:03 INFO - "repo_path": "integration/fx-team", 17:28:03 INFO - "revision": "34a128489d8895e2f1ef58f43e2b4d196be6e544", 17:28:03 INFO - "stage_platform": "linux64-pgo", 17:28:03 INFO - "builduid": "9e60eb45167040969243f9260c444e5b", 17:28:03 INFO - "slavebuilddir": "test" 17:28:03 INFO - } 17:28:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:28:03 INFO - Running post-action listener: _resource_record_post_action 17:28:03 INFO - ##### 17:28:03 INFO - ##### Finished read-buildbot-config step (success) 17:28:03 INFO - ##### 17:28:03 INFO - ##### 17:28:03 INFO - ##### Running download-and-extract step. 17:28:03 INFO - ##### 17:28:03 INFO - Running pre-action listener: _resource_record_pre_action 17:28:03 INFO - Running main action method: download_and_extract 17:28:03 INFO - mkdir: /builds/slave/test/build/tests 17:28: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')]} 17:28:03 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:08 INFO - Downloaded 1361 bytes. 17:28:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:28:08 INFO - Using the following test package requirements: 17:28:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:28:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:28:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:28:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'jsshell-linux-x86_64.zip'], 17:28:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:28:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:28:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:28:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:28:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:28:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:28:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:28:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:08 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:11 INFO - Downloaded 24325923 bytes. 17:28:11 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'] 17:28:11 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 17:28:12 INFO - Return code: 0 17:28:12 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 17:28: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')]} 17:28:12 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:28:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:28:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:28:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:13 INFO - Downloaded 24325923 bytes. 17:28:13 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'] 17:28:13 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 17:28:15 INFO - Return code: 0 17:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:15 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:16 INFO - Downloaded 14403317 bytes. 17:28:16 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'] 17:28:16 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 17:28:16 INFO - Return code: 0 17:28:16 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')]} 17:28:16 INFO - https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:28:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:28:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:28:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/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 17:28:17 INFO - Downloaded 60811699 bytes. 17:28:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:28:17 INFO - mkdir: /builds/slave/test/properties 17:28:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:28:17 INFO - Writing to file /builds/slave/test/properties/build_url 17:28:17 INFO - Contents: 17:28:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:28:23 INFO - Running post-action listener: _resource_record_post_action 17:28:23 INFO - Running post-action listener: set_extra_try_arguments 17:28:23 INFO - ##### 17:28:23 INFO - ##### Finished download-and-extract step (success) 17:28:23 INFO - ##### 17:28:23 INFO - ##### 17:28:23 INFO - ##### Running populate-webroot step. 17:28:23 INFO - ##### 17:28:23 INFO - Running pre-action listener: _resource_record_pre_action 17:28:23 INFO - Running main action method: populate_webroot 17:28:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:28:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:28:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:28:23 INFO - '--tppagecycles', 17:28:23 INFO - '7'], 17:28:23 INFO - 'tests': ['tsvgm']}}, 17:28:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:28:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:28:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:28:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:28:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['damp', 'tps']}, 17:28:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'tests': ['damp', 'tps']}, 17:28:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['dromaeo_dom']}, 17:28:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:28:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['basic_compositor_video']}, 17:28:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:28:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['a11yr', 17:28:23 INFO - 'ts_paint', 17:28:23 INFO - 'tpaint', 17:28:23 INFO - 'sessionrestore', 17:28:23 INFO - 'sessionrestore_no_auto_restore', 17:28:23 INFO - 'tabpaint']}, 17:28:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['tsvgx', 17:28:23 INFO - 'tsvgr_opacity', 17:28:23 INFO - 'tart', 17:28:23 INFO - 'tscrollx', 17:28:23 INFO - 'cart']}, 17:28:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:28:23 INFO - 'tsvgr_opacity', 17:28:23 INFO - 'tart', 17:28:23 INFO - 'tscrollx', 17:28:23 INFO - 'cart']}, 17:28:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'talos_options': ['--disable-e10s'], 17:28:23 INFO - 'tests': ['tp5o']}, 17:28:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'tests': ['tp5o']}, 17:28:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'talos_options': ['--disable-e10s', 17:28:23 INFO - '--xperf_path', 17:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:23 INFO - 'tests': ['tp5n']}, 17:28:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:23 INFO - 'talos_options': ['--xperf_path', 17:28:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:23 INFO - 'tests': ['tp5n']}}, 17:28:23 INFO - 'talos.zip': {'path': '', 17:28:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:28:23 INFO - Running post-action listener: _resource_record_post_action 17:28:23 INFO - ##### 17:28:23 INFO - ##### Finished populate-webroot step (success) 17:28:23 INFO - ##### 17:28:23 INFO - ##### 17:28:23 INFO - ##### Running create-virtualenv step. 17:28:23 INFO - ##### 17:28:23 INFO - Running pre-action listener: _resource_record_pre_action 17:28:23 INFO - Running main action method: create_virtualenv 17:28:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:28:23 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 17:28:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:28:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:28:23 INFO - Using real prefix '/usr' 17:28:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:28:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:28:25 INFO - Installing pip.................done. 17:28:25 INFO - Return code: 0 17:28:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:25 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:25 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 17:28:25 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 17:28:25 INFO - Using env: {'DISPLAY': ':0', 17:28:25 INFO - 'HOME': '/home/cltbld', 17:28:25 INFO - 'LANG': 'en_US.UTF-8', 17:28:25 INFO - 'LANGUAGE': 'en_US:en', 17:28:25 INFO - 'LOGNAME': 'cltbld', 17:28:25 INFO - 'MAIL': '/var/mail/cltbld', 17:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:25 INFO - 'MOZ_NO_REMOTE': '1', 17:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:25 INFO - 'NO_EM_RESTART': '1', 17:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:25 INFO - 'PWD': '/builds/slave/test', 17:28:25 INFO - 'SHELL': '/bin/bash', 17:28:25 INFO - 'SHLVL': '1', 17:28:25 INFO - 'TERM': 'linux', 17:28:25 INFO - 'TMOUT': '86400', 17:28:25 INFO - 'USER': 'cltbld', 17:28:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:25 INFO - '_': '/tools/buildbot/bin/python'} 17:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:25 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 17:28:25 INFO - Cleaning up... 17:28:25 INFO - Return code: 0 17:28:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:25 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:25 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 17:28:25 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 17:28:25 INFO - Using env: {'DISPLAY': ':0', 17:28:25 INFO - 'HOME': '/home/cltbld', 17:28:25 INFO - 'LANG': 'en_US.UTF-8', 17:28:25 INFO - 'LANGUAGE': 'en_US:en', 17:28:25 INFO - 'LOGNAME': 'cltbld', 17:28:25 INFO - 'MAIL': '/var/mail/cltbld', 17:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:25 INFO - 'MOZ_NO_REMOTE': '1', 17:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:25 INFO - 'NO_EM_RESTART': '1', 17:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:25 INFO - 'PWD': '/builds/slave/test', 17:28:25 INFO - 'SHELL': '/bin/bash', 17:28:25 INFO - 'SHLVL': '1', 17:28:25 INFO - 'TERM': 'linux', 17:28:25 INFO - 'TMOUT': '86400', 17:28:25 INFO - 'USER': 'cltbld', 17:28:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:25 INFO - '_': '/tools/buildbot/bin/python'} 17:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:26 INFO - Downloading/unpacking psutil>=3.1.1 17:28:26 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 17:28:26 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 17:28:26 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 17:28:26 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 17:28:26 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 17:28:26 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 17:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:28 INFO - Installing collected packages: psutil 17:28:28 INFO - Running setup.py install for psutil 17:28:28 INFO - building 'psutil._psutil_linux' extension 17:28:28 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 17:28:28 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 17:28:28 INFO - building 'psutil._psutil_posix' extension 17:28:28 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 17:28:28 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 17:28:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:28 INFO - Successfully installed psutil 17:28:28 INFO - Cleaning up... 17:28:28 INFO - Return code: 0 17:28:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:28:28 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')]} 17:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:28 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')]} 17:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:28 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:28 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 17:28:28 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 17:28:28 INFO - Using env: {'DISPLAY': ':0', 17:28:28 INFO - 'HOME': '/home/cltbld', 17:28:28 INFO - 'LANG': 'en_US.UTF-8', 17:28:28 INFO - 'LANGUAGE': 'en_US:en', 17:28:28 INFO - 'LOGNAME': 'cltbld', 17:28:28 INFO - 'MAIL': '/var/mail/cltbld', 17:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:28 INFO - 'MOZ_NO_REMOTE': '1', 17:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:28 INFO - 'NO_EM_RESTART': '1', 17:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:28 INFO - 'PWD': '/builds/slave/test', 17:28:28 INFO - 'SHELL': '/bin/bash', 17:28:28 INFO - 'SHLVL': '1', 17:28:28 INFO - 'TERM': 'linux', 17:28:28 INFO - 'TMOUT': '86400', 17:28:28 INFO - 'USER': 'cltbld', 17:28:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:28 INFO - '_': '/tools/buildbot/bin/python'} 17:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:28:28 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 17:28:28 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 17:28:28 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 17:28:28 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 17:28:28 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 17:28:28 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 17:28:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:28:30 INFO - Installing collected packages: mozsystemmonitor 17:28:30 INFO - Running setup.py install for mozsystemmonitor 17:28:30 INFO - Successfully installed mozsystemmonitor 17:28:30 INFO - Cleaning up... 17:28:30 INFO - Return code: 0 17:28:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:28: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')]} 17:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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')]} 17:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28: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==2.5.1'] in /builds/slave/test/build 17:28: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==2.5.1 17:28:30 INFO - Using env: {'DISPLAY': ':0', 17:28:30 INFO - 'HOME': '/home/cltbld', 17:28:30 INFO - 'LANG': 'en_US.UTF-8', 17:28:30 INFO - 'LANGUAGE': 'en_US:en', 17:28:30 INFO - 'LOGNAME': 'cltbld', 17:28:30 INFO - 'MAIL': '/var/mail/cltbld', 17:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:30 INFO - 'MOZ_NO_REMOTE': '1', 17:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:30 INFO - 'NO_EM_RESTART': '1', 17:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:30 INFO - 'PWD': '/builds/slave/test', 17:28:30 INFO - 'SHELL': '/bin/bash', 17:28:30 INFO - 'SHLVL': '1', 17:28:30 INFO - 'TERM': 'linux', 17:28:30 INFO - 'TMOUT': '86400', 17:28:30 INFO - 'USER': 'cltbld', 17:28:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:30 INFO - '_': '/tools/buildbot/bin/python'} 17:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:31 INFO - Downloading/unpacking jsonschema==2.5.1 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:28:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:33 INFO - warning: no files found matching '*.txt' 17:28:33 INFO - no previously-included directories found matching 'build' 17:28:33 INFO - no previously-included directories found matching 'dist' 17:28:33 INFO - no previously-included directories found matching '.git*' 17:28:33 INFO - Installing collected packages: jsonschema, functools32 17:28:33 INFO - Running setup.py install for functools32 17:28:33 INFO - warning: no files found matching '*.txt' 17:28:33 INFO - no previously-included directories found matching 'build' 17:28:33 INFO - no previously-included directories found matching 'dist' 17:28:33 INFO - no previously-included directories found matching '.git*' 17:28:33 INFO - Successfully installed jsonschema functools32 17:28:33 INFO - Cleaning up... 17:28:33 INFO - Return code: 0 17:28:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:33 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')]} 17:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:33 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')]} 17:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:33 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:33 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 17:28:33 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 17:28:33 INFO - Using env: {'DISPLAY': ':0', 17:28:33 INFO - 'HOME': '/home/cltbld', 17:28:33 INFO - 'LANG': 'en_US.UTF-8', 17:28:33 INFO - 'LANGUAGE': 'en_US:en', 17:28:33 INFO - 'LOGNAME': 'cltbld', 17:28:33 INFO - 'MAIL': '/var/mail/cltbld', 17:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:33 INFO - 'MOZ_NO_REMOTE': '1', 17:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:33 INFO - 'NO_EM_RESTART': '1', 17:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:33 INFO - 'PWD': '/builds/slave/test', 17:28:33 INFO - 'SHELL': '/bin/bash', 17:28:33 INFO - 'SHLVL': '1', 17:28:33 INFO - 'TERM': 'linux', 17:28:33 INFO - 'TMOUT': '86400', 17:28:33 INFO - 'USER': 'cltbld', 17:28:33 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:33 INFO - '_': '/tools/buildbot/bin/python'} 17:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28: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 17:28:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:35 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 17:28:35 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 17:28:35 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 17:28:35 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 17:28:35 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 17:28:35 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 17:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:36 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 17:28:36 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 17:28:36 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 17:28:36 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 17:28:36 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 17:28:36 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 17:28:36 INFO - Downloading docopt-0.6.1.tar.gz 17:28:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:36 INFO - Running setup.py install for blobuploader 17:28:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:36 INFO - Running setup.py install for requests 17:28:36 INFO - Running setup.py install for docopt 17:28:37 INFO - Successfully installed blobuploader requests docopt 17:28:37 INFO - Cleaning up... 17:28:37 INFO - Return code: 0 17:28:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:37 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:37 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 17:28:37 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 17:28:37 INFO - Using env: {'DISPLAY': ':0', 17:28:37 INFO - 'HOME': '/home/cltbld', 17:28:37 INFO - 'LANG': 'en_US.UTF-8', 17:28:37 INFO - 'LANGUAGE': 'en_US:en', 17:28:37 INFO - 'LOGNAME': 'cltbld', 17:28:37 INFO - 'MAIL': '/var/mail/cltbld', 17:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:37 INFO - 'MOZ_NO_REMOTE': '1', 17:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:37 INFO - 'NO_EM_RESTART': '1', 17:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:37 INFO - 'PWD': '/builds/slave/test', 17:28:37 INFO - 'SHELL': '/bin/bash', 17:28:37 INFO - 'SHLVL': '1', 17:28:37 INFO - 'TERM': 'linux', 17:28:37 INFO - 'TMOUT': '86400', 17:28:37 INFO - 'USER': 'cltbld', 17:28:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:37 INFO - '_': '/tools/buildbot/bin/python'} 17:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:37 INFO - Running setup.py (path:/tmp/pip-vzed7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:37 INFO - Running setup.py (path:/tmp/pip-b4KHSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:37 INFO - Running setup.py (path:/tmp/pip-pXdQuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:37 INFO - Running setup.py (path:/tmp/pip-zhpBVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:37 INFO - Running setup.py (path:/tmp/pip-w_p097-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:37 INFO - Running setup.py (path:/tmp/pip-U_reDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:37 INFO - Running setup.py (path:/tmp/pip-Q2suD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:37 INFO - Running setup.py (path:/tmp/pip-dtGNH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:37 INFO - Running setup.py (path:/tmp/pip-tRfYCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:37 INFO - Running setup.py (path:/tmp/pip-alPs9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:38 INFO - Running setup.py (path:/tmp/pip-y6dIMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:38 INFO - Running setup.py (path:/tmp/pip-8ADfpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:38 INFO - Running setup.py (path:/tmp/pip-bcCt5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:38 INFO - Running setup.py (path:/tmp/pip-Or5Ej0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:38 INFO - Running setup.py (path:/tmp/pip-Lbs4Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:38 INFO - Running setup.py (path:/tmp/pip-deGaDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:38 INFO - Running setup.py (path:/tmp/pip-XsmDfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:38 INFO - Running setup.py install for manifestparser 17:28:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for mozcrash 17:28:38 INFO - Running setup.py install for mozdebug 17:28:38 INFO - Running setup.py install for mozdevice 17:28:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:38 INFO - Running setup.py install for mozfile 17:28:39 INFO - Running setup.py install for mozhttpd 17:28:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozinfo 17:28:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozInstall 17:28:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozleak 17:28:39 INFO - Running setup.py install for mozlog 17:28:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for moznetwork 17:28:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozprocess 17:28:39 INFO - Running setup.py install for mozprofile 17:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:39 INFO - Running setup.py install for mozrunner 17:28:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:40 INFO - Running setup.py install for mozscreenshot 17:28:40 INFO - Running setup.py install for moztest 17:28:40 INFO - Running setup.py install for mozversion 17:28:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:40 INFO - Cleaning up... 17:28:40 INFO - Return code: 0 17:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:40 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:40 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 17:28:40 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 17:28:40 INFO - Using env: {'DISPLAY': ':0', 17:28:40 INFO - 'HOME': '/home/cltbld', 17:28:40 INFO - 'LANG': 'en_US.UTF-8', 17:28:40 INFO - 'LANGUAGE': 'en_US:en', 17:28:40 INFO - 'LOGNAME': 'cltbld', 17:28:40 INFO - 'MAIL': '/var/mail/cltbld', 17:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:40 INFO - 'MOZ_NO_REMOTE': '1', 17:28:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:40 INFO - 'NO_EM_RESTART': '1', 17:28:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:40 INFO - 'PWD': '/builds/slave/test', 17:28:40 INFO - 'SHELL': '/bin/bash', 17:28:40 INFO - 'SHLVL': '1', 17:28:40 INFO - 'TERM': 'linux', 17:28:40 INFO - 'TMOUT': '86400', 17:28:40 INFO - 'USER': 'cltbld', 17:28:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:40 INFO - '_': '/tools/buildbot/bin/python'} 17:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:40 INFO - Running setup.py (path:/tmp/pip-iDWkgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:40 INFO - Running setup.py (path:/tmp/pip-OS5s6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:40 INFO - Running setup.py (path:/tmp/pip-4JdWeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:40 INFO - Running setup.py (path:/tmp/pip-RciFN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:40 INFO - Running setup.py (path:/tmp/pip-2d5v8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:40 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)) 17:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:40 INFO - Running setup.py (path:/tmp/pip-0ZL705-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:41 INFO - Running setup.py (path:/tmp/pip-gMVvZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:41 INFO - Running setup.py (path:/tmp/pip-Gy3AvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:41 INFO - Running setup.py (path:/tmp/pip-1XshGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:41 INFO - Running setup.py (path:/tmp/pip-38eMOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:41 INFO - Running setup.py (path:/tmp/pip-kurl8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:41 INFO - Running setup.py (path:/tmp/pip-dVbrfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:41 INFO - Running setup.py (path:/tmp/pip-Qpcd4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:41 INFO - Running setup.py (path:/tmp/pip-qn56qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:41 INFO - Running setup.py (path:/tmp/pip-8z6_9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:41 INFO - Running setup.py (path:/tmp/pip-6f86tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:41 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)) 17:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:41 INFO - Running setup.py (path:/tmp/pip-B3NQ9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 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)) 17:28:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:41 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 17:28:41 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 17:28:41 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 17:28:41 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 17:28:41 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 17:28:41 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 17:28:43 INFO - Downloading blessings-1.6.tar.gz 17:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:28:43 INFO - Installing collected packages: blessings 17:28:43 INFO - Running setup.py install for blessings 17:28:43 INFO - Successfully installed blessings 17:28:43 INFO - Cleaning up... 17:28:44 INFO - Return code: 0 17:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:44 INFO - Reading from file tmpfile_stdout 17:28:44 INFO - Current package versions: 17:28:44 INFO - argparse == 1.2.1 17:28:44 INFO - blessings == 1.6 17:28:44 INFO - blobuploader == 1.2.4 17:28:44 INFO - docopt == 0.6.1 17:28:44 INFO - functools32 == 3.2.3-2 17:28:44 INFO - jsonschema == 2.5.1 17:28:44 INFO - manifestparser == 1.1 17:28:44 INFO - mozInstall == 1.12 17:28:44 INFO - mozcrash == 0.17 17:28:44 INFO - mozdebug == 0.1 17:28:44 INFO - mozdevice == 0.48 17:28:44 INFO - mozfile == 1.2 17:28:44 INFO - mozhttpd == 0.7 17:28:44 INFO - mozinfo == 0.9 17:28:44 INFO - mozleak == 0.1 17:28:44 INFO - mozlog == 3.2 17:28:44 INFO - moznetwork == 0.27 17:28:44 INFO - mozprocess == 0.23 17:28:44 INFO - mozprofile == 0.28 17:28:44 INFO - mozrunner == 6.12 17:28:44 INFO - mozscreenshot == 0.1 17:28:44 INFO - mozsystemmonitor == 0.3 17:28:44 INFO - moztest == 0.7 17:28:44 INFO - mozversion == 1.4 17:28:44 INFO - psutil == 3.1.1 17:28:44 INFO - requests == 1.2.3 17:28:44 INFO - wsgiref == 0.1.2 17:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:44 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')]} 17:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:44 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')]} 17:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:44 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:44 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 17:28:44 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 17:28:44 INFO - Using env: {'DISPLAY': ':0', 17:28:44 INFO - 'HOME': '/home/cltbld', 17:28:44 INFO - 'LANG': 'en_US.UTF-8', 17:28:44 INFO - 'LANGUAGE': 'en_US:en', 17:28:44 INFO - 'LOGNAME': 'cltbld', 17:28:44 INFO - 'MAIL': '/var/mail/cltbld', 17:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:44 INFO - 'MOZ_NO_REMOTE': '1', 17:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:44 INFO - 'NO_EM_RESTART': '1', 17:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:44 INFO - 'PWD': '/builds/slave/test', 17:28:44 INFO - 'SHELL': '/bin/bash', 17:28:44 INFO - 'SHLVL': '1', 17:28:44 INFO - 'TERM': 'linux', 17:28:44 INFO - 'TMOUT': '86400', 17:28:44 INFO - 'USER': 'cltbld', 17:28:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:44 INFO - '_': '/tools/buildbot/bin/python'} 17:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 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)) 17:28:44 INFO - Cleaning up... 17:28:44 INFO - Return code: 0 17:28:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:28:44 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')]} 17:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:44 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')]} 17:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:44 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 0xdf5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, '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': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', '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 17:28:44 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 17:28:44 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 17:28:44 INFO - Using env: {'DISPLAY': ':0', 17:28:44 INFO - 'HOME': '/home/cltbld', 17:28:44 INFO - 'LANG': 'en_US.UTF-8', 17:28:44 INFO - 'LANGUAGE': 'en_US:en', 17:28:44 INFO - 'LOGNAME': 'cltbld', 17:28:44 INFO - 'MAIL': '/var/mail/cltbld', 17:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:44 INFO - 'MOZ_NO_REMOTE': '1', 17:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:44 INFO - 'NO_EM_RESTART': '1', 17:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:44 INFO - 'PWD': '/builds/slave/test', 17:28:44 INFO - 'SHELL': '/bin/bash', 17:28:44 INFO - 'SHLVL': '1', 17:28:44 INFO - 'TERM': 'linux', 17:28:44 INFO - 'TMOUT': '86400', 17:28:44 INFO - 'USER': 'cltbld', 17:28:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:44 INFO - '_': '/tools/buildbot/bin/python'} 17:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:28:44 INFO - Cleaning up... 17:28:44 INFO - Return code: 0 17:28:44 INFO - Running post-action listener: _resource_record_post_action 17:28:44 INFO - Running post-action listener: _start_resource_monitoring 17:28:44 INFO - Starting resource monitoring. 17:28:44 INFO - ##### 17:28:44 INFO - ##### Finished create-virtualenv step (success) 17:28:44 INFO - ##### 17:28:44 INFO - ##### 17:28:44 INFO - ##### Running install step. 17:28:44 INFO - ##### 17:28:44 INFO - Running pre-action listener: _resource_record_pre_action 17:28:44 INFO - Running main action method: install 17:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:44 INFO - Reading from file tmpfile_stdout 17:28:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:28:44 INFO - Reading from file tmpfile_stdout 17:28:44 INFO - Output received: 17:28:44 INFO - Usage: mozinstall [options] installer 17:28:44 INFO - Options: 17:28:44 INFO - -h, --help show this help message and exit 17:28:44 INFO - -d DEST, --destination=DEST 17:28:44 INFO - Directory to install application into. [default: 17:28:44 INFO - "/builds/slave/test"] 17:28:44 INFO - --app=APP Application being installed. [default: firefox] 17:28:44 INFO - mkdir: /builds/slave/test/build/application 17:28:44 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'] 17:28:44 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 17:29:02 INFO - Reading from file tmpfile_stdout 17:29:02 INFO - Output received: 17:29:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:29:02 INFO - Running post-action listener: _resource_record_post_action 17:29:02 INFO - ##### 17:29:02 INFO - ##### Finished install step (success) 17:29:02 INFO - ##### 17:29:02 INFO - ##### 17:29:02 INFO - ##### Running run-tests step. 17:29:02 INFO - ##### 17:29:02 INFO - Running pre-action listener: _resource_record_pre_action 17:29:02 INFO - Running main action method: run_tests 17:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:02 INFO - Python 2.7.3 17:29:02 INFO - Return code: 0 17:29:02 INFO - grabbing minidump binary from tooltool 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:02 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 0x10b43b0>, '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 0x10b52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29:02 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 17:29:02 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 17:29:02 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 17:29:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:02 INFO - Return code: 0 17:29:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:29:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:29:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:29:02 INFO - Using env: {'DISPLAY': ':0', 17:29:02 INFO - 'HOME': '/home/cltbld', 17:29:02 INFO - 'LANG': 'en_US.UTF-8', 17:29:02 INFO - 'LANGUAGE': 'en_US:en', 17:29:02 INFO - 'LOGNAME': 'cltbld', 17:29:02 INFO - 'MAIL': '/var/mail/cltbld', 17:29:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:02 INFO - 'MOZ_NO_REMOTE': '1', 17:29:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:02 INFO - 'NO_EM_RESTART': '1', 17:29:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:02 INFO - 'PWD': '/builds/slave/test', 17:29:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:02 INFO - 'SHELL': '/bin/bash', 17:29:02 INFO - 'SHLVL': '1', 17:29:02 INFO - 'TERM': 'linux', 17:29:02 INFO - 'TMOUT': '86400', 17:29:02 INFO - 'USER': 'cltbld', 17:29:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462', 17:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:02 INFO - '_': '/tools/buildbot/bin/python'} 17:29:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:29:02 INFO - mozversion application_buildid: 20160713143006 17:29:02 INFO - mozversion application_changeset: 34a128489d8895e2f1ef58f43e2b4d196be6e544 17:29:02 INFO - mozversion application_display_name: Nightly 17:29:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:02 INFO - mozversion application_name: Firefox 17:29:02 INFO - mozversion application_remotingname: firefox 17:29:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:29:02 INFO - mozversion application_vendor: Mozilla 17:29:02 INFO - mozversion application_version: 50.0a1 17:29:02 INFO - mozversion platform_buildid: 20160713143006 17:29:02 INFO - mozversion platform_changeset: 34a128489d8895e2f1ef58f43e2b4d196be6e544 17:29:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:29:02 INFO - mozversion platform_version: 50.0a1 17:29:02 INFO - using testdate: 1468456142 17:29:02 INFO - actual date: 1468456142 17:29:02 INFO - starting webserver on 'localhost:35396' 17:29:02 INFO - SUITE-START | Running 2 tests 17:29:02 INFO - TEST-START | dromaeo_css 17:29:02 INFO - operating with platform_type : linux_ 17:29:02 INFO - Initialising browser for dromaeo_css test... 17:29:02 INFO - TEST-INFO | started process 10869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1QW8w8/profile http://localhost:35396/getInfo.html) 17:29:06 INFO - PROCESS | 10869 | __metrics Screen width/height:1600/1200 17:29:06 INFO - PROCESS | 10869 | colorDepth:24 17:29:06 INFO - PROCESS | 10869 | Browser inner width/height: 1024/697 17:29:06 INFO - PROCESS | 10869 | __metrics 17:29:06 INFO - PROCESS | 10869 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:29:06 INFO - PROCESS | 10869 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:07 INFO - TEST-INFO | 10869: exit 0 17:29:07 INFO - Browser initialized. 17:29:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:07 INFO - TEST-INFO | started process 10951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1QW8w8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:19 INFO - PROCESS | 10951 | RSS: Main: 157696000 17:29:19 INFO - PROCESS | 10951 | 17:30:10 INFO - PROCESS | 10951 | 1468456210566 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] 17:32:18 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35396/tests/dromaeo/cssquery-ext.html) 17:32:19 INFO - PROCESS | 10951 | RSS: Main: 280559616 17:32:19 INFO - PROCESS | 10951 | 17:35:21 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-ext.html (next: http://localhost:35396/tests/dromaeo/cssquery-jquery.html) 17:35:22 INFO - PROCESS | 10951 | RSS: Main: 246448128 17:35:22 INFO - PROCESS | 10951 | 17:38:24 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35396/tests/dromaeo/cssquery-mootools.html) 17:38:25 INFO - PROCESS | 10951 | RSS: Main: 244215808 17:38:25 INFO - PROCESS | 10951 | 17:41:27 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35396/tests/dromaeo/cssquery-prototype.html) 17:41:27 INFO - PROCESS | 10951 | RSS: Main: 244490240 17:41:27 INFO - PROCESS | 10951 | 17:44:30 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35396/tests/dromaeo/cssquery-yui.html) 17:44:30 INFO - PROCESS | 10951 | RSS: Main: 223277056 17:44:30 INFO - PROCESS | 10951 | 17:47:33 INFO - PROCESS | 10951 | Cycle 1(1): loaded http://localhost:35396/tests/dromaeo/cssquery-yui.html (next: http://localhost:35396/tests/dromaeo/cssquery-dojo.html) 17:47:34 INFO - PROCESS | 10951 | RSS: Main: 275349504 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | __start_tp_report 17:47:34 INFO - PROCESS | 10951 | _x_x_mozilla_page_load 17:47:34 INFO - PROCESS | 10951 | _x_x_mozilla_page_load_details 17:47:34 INFO - PROCESS | 10951 | |i|pagename|runs| 17:47:34 INFO - PROCESS | 10951 | |0;dojo.html;2975.7916945813795;2991.8354490503043;3007.984960075201;3012.307169351049;3027.6366835979684;5101.974490127544;5105.514976077271;5114.156164232906;5207.4271830098705;5269.76286067127;5187.429382767902;5196.766145523451;5213.296205012322;5214.582833373331;5263.1578947368425;4683.7189768613825;4781.115493633689;4788.114198873202;4790.209615413452;4918.065567542173;4831.9275210871865;4851.781669824849;4864.416270047582;4880.902381952359;4890.73100979446;4681.812727490897;4682.719036857799;4692.718436893797;4747.667663263573;4761.262004389325;4731.503192164842;4732.550407711262;4739.478657347689;4743.952560474386;4850.296706977504;4761.190597598382;4763.64272679547;4764.166270902613;4780.665353425262;4789.114013907403;5094.821681241138;5101.923471147936;5139.408967968657;5152.587792976553;5317.946820531823;5525.613207075507;5572.247746554244;5587.38538760736;5589.189567512688;5589.441055894418;5567.610267281292;5604;5609.52319052881;5616.438356164392;5617.578681598856;5081.720505372203;5165.999999999963;5181.559567436735;5222.92165617516;5235.110031294689;5773.797917072882;5786.508146807569;5787.88424231513;5788.971055144697;5794.5364370851075;5516.282883225235;5516.9448305517235;5550.8057217997175;5563.777448902079;5564.749586268627;5369.838904832784;5371.355437347544;5456.945430545644;5471.151971444432;5646.802361917313;5445.992491389105;5481.205225242397;5499.917501237484;5509.035918714209;5510.476504732044;5384.057789886754;5428.37573679032;5429.864253393696;5434.483724046209;5482.985647655197;4132.070284186094;4171.541130475645;4178.498580170338;4189.91620167601;4212.031232816469;3767.698584113264;3775.6035616260447;3785.981070094687;3814.332491813977;3820.6943444524372;5195.766190521435;5236.345456817898;5240.737963101829;5242.344706911636;5280.20796880471;5413;5499.587530935196;5505.889882202334;5548.056830338852;5567.805126820542;5292.973535132377;5309.070912590359;5325.2810870531985;5327.360716714019;5330.013947419662;4695.489544577301;4706.364640773451;4709.505501922249;4710.552497512731;4749.1926372516755;5650.745716442688;5681.744321505459;5742.109972954116;5760.36635970043;5782.624129431658;5627.690477023639;5635.267415235993;5641.097424412074;5641.548676105819;5642.23829782974;5665.49010589049;5781.739821708117;5792.275965504312;5793.275840519935;5793.768249270151;5410.296661433988;5441.782328706808;5454.809081682122;5489.64317319373;5504.036793561191;5561.221428999862;5573.972130139486;5574.358948720786;5574.609777315549;5578.665280083208;5419.539339156216;5453.15476101205;5465.7813687453645;5467.835964921059;5517.917231241615;5373.516383525502;5426.07756681373;5437.374701909331;5466.863328416822;5471.398146203994;5366.2487251784005;5380.3274590676165;5405.486478784509;5405.621606487665;5406.24312596229;5375.435579264277;5388.164834450667;5487.945120548743;5499.50504454601;5552.611317207919;5293.2589437479555;5313.229581710708;5314.734263286898;5349.170878513836;5386.13821788512 17:47:34 INFO - PROCESS | 10951 | |1;ext.html;560.5207547546847;612.4334990134125;617.8640699046209;618.913352130702;625.8466675664463;43384;44999.77500112495;45063.774681126546;45225.547744522584;48139.27791083136;45676;46172.307415388714;46192.76903615486;46249.07501849961;46289;9048.954755226232;9202.539873006357;9217.907820921771;9220.07799220076;9231.215346695539;8978.326625503081;8980.46117232965;9082.59128339223;9093.818123637524;9097.590608422604;8941.59762810675;8971.416857904247;8971.910280897206;8973.95513022434;8975;9101.453912765222;9124.452532847983;9138.954305228432;9142.908570914273;9143.725688229331;9077.228435582983;9129.269658427309;9154;9159.450432973976;9159.862602060974;43264.35103473451;43556;43646.781766091284;43704;43745.343819842725;3427.657234276577;3451.3097380523996;3528.2414280929465;3660.3045421369857;3708.332500149999;33020;33376.6662333376;33685.157871053176;33695;34461.48307775385;4433.689641725081;4501.887452813673;4557.225271703818;4562.77186140695;4576.839810606646;370834;374284;374897;376281;377096;63904.68047659732;63937;64367.67816160889;64421;64456.35543644503;57854.7107264461;64278;65417.672911635134;65524.34475655182;66941.6652916742;16651.583710407336;16652.417165399154;16719.916400418162;16880.409185678443;16973.236204370834;12648.304343261208;12712.046596505299;12721.872781272254;12824;12864.807027894589;17489.825101749073;17671.11644417774;17683.646327073642;18894.905525472284;19265.996411101114;6963.303669633097;7007.159140903124;7181.676824542908;7233.204347521769;7447.776566703008;963.2534785541121;1102.1238115698038;1113.2541197397763;1134.9035331996872;1136.159242160795;33214.335713285596;33509.16227094342;33623.495647564814;33649.91590515495;33659.49510757292;1072.694282129605;1149.149629274331;1168.655246702225;1182.4206138991833;1239.4918083585687;17227.741583876254;17433.651326973388;17476.30094796194;17484.825151748573;17647;599729;604202;604485;605391;606494;59606.70196648989;61284.38715612876;61303;61404.69297653483;61425.38574614197;1336.0781061067833;1345.2466618693368;1357.3281225793296;1362.8364596248514;1382.6958069224754;31666.841665791522;32998.67001329956;33401.49897751487;33519.664803351654;34087.31825363528;54784.45215547953;55003;55180.724096380865;55223.17165242605;55238.44761552333;452421;453614;456630;456766;457324;25597.23208303754;27681.58477622797;28416.85791571029;29161.125166245045;29499.557506637848;47104;47683;48116.27825582549;48183.75908120437;48705.26942095801;39600.603993960845;40224.597754022085;41152.58847411488;41337.58662413458;41634;41182.176356473305;41335.793321034405;41702;41877.79061104675;42004.78997604993;36463.27073458569;40583.9445172938;41370.79314603408;41410.1717965645;41430;33204.66795332016;35561.46657800187;36286.455703165004;36417.81791091028;36518.26963460663;27051.729482704923;27723.44553108967;27792.861035694692;27803;27859.582106268826 17:47:34 INFO - PROCESS | 10951 | |2;jquery.html;373.6749028345339;373.7458528200824;375.0642147841137;375.33190920162104;386.32393311704516;18720.063996800156;19349.322773702923;20243.49391265219;20319.49201269969;21008.264710735126;11630.12774041946;12028;12102.273863568193;12107.697307567316;12878.549250776225;4943.1596628573225;5074.441811400761;5105.208692652626;5114.488551144893;5117.1556693145585;3808.1241314497684;5511.311086114236;5766.1639062335935;5777.508911742507;6011.5491338149595;5570.108782594785;5895.616784908989;5908.113782932552;5998.610090344136;6001.849953751169;5705.2012718219485;5708.914366284509;5745.569082318801;5747.942520574804;5751.942480575203;3653.2693461307845;3816.2367526494813;3816.9427458588143;5310.734463276821;5686.289213848269;13390.86609133906;13547.45810167592;13555.593332199951;22471;24266.878665606735;2082.7708952015264;2365.4086478380405;2901.5357542793054;2913.4318807832483;2978.5085460898927;9206.815863682688;9759.756006099833;10274.280800343979;11471.48378322969;15383.615409614737;1878.8121187881238;1907.8855268683924;1972.3491247888305;1987.1256647075386;2027.2701827342146;84928.57535712281;85336.14663853344;85634.57182714109;88419;88464.11535884687;10580.095582795171;10797.784044319227;11017.338959662446;11046.779064418666;11197;14931;15053.924730376279;15060.54818355451;15061.924690376698;15082.095074295357;8159.510429374138;8329.125441828643;8347.916520834835;8367.665293388318;8474.491530508189;8052.275295223458;8064.516129032277;8164.183581641788;8234.135415781377;8244.958775206085;4593.954060459353;4612.215923293048;4637.46669133054;4660.6970546914345;4746.833860814855;1706.3942300483398;1743;1835.4493651904374;1879.7838248601313;1960.4020773663883;926.1340646495548;968.1818863060843;968.6125549780145;1003.1322905686675;1020.8774947006407;18879;19669.901650491942;19724.90137549332;19869.801301986794;20342.79657203409;996.3673067602125;1030.8299130643509;1035.4201647077662;1043.0612448796144;1058.5025038232018;10461.215408844368;10852.72868178286;10865.945670271756;10948.835767463494;10949.83575246372;522297;528843;529202;530274;534707;93166.53416732873;95249.52375238219;95251.52374238223;96278.51860740791;96382.51808740912;986.4229425785852;994.264244459095;997.0806198068689;998.3660375661507;1009.1220638044948;16224.513264602081;17182.914085429493;17408.216630251416;17599.64800703953;17899.73150402771;36081.819590901876;42566.78716606397;44084.559154409326;44556;45364.77317613391;57863.10684465844;58167.4183258162;59015.40984590271;59113.70443147757;59882;8114.878276825971;8176.345892328718;8183.713570025258;8272.090070092405;8324.417290789828;8752.51861147643;8769.38614296993;12252.652208256906;13307.068505204543;13543.661408464866;8152.2662960333855;8422.105026369018;8487.618057187317;8488.193621605938;8698.956505217433;7888.645010974635;7961.323287520394;7974.362051036019;8217.465864718773;8379.329653627574;8122.553259570544;8364.079951205484;8408.117147699404;8434.325253979545;8698.085861362286;12772.489100435878;13076.607701768962;13076.803847942097;13171.670708231988;13248.668783280495;12548;12932.159409638343;13038.282894440898;13048.739025219633;13101 17:47:34 INFO - PROCESS | 10951 | |3;mootools.html;1292.1342700390737;1430.3849344781743;1463.560931720484;1579.407722104211;1736.2707662781622;7929.484583502069;8243.835123297538;8252.422330436864;8454.070052294242;8467;8266.214709602593;8470.322374210064;8475.449095808768;8477.533735644538;8480.618372173252;1918.4436513411094;1971.3297478857185;1975.6048790241937;2170.5550362175754;2196.143504033428;2004.6391649503084;2018.8687735297233;2074.678424844152;2075.4292569543422;2099.813605313001;2143.3998480425507;2145.3992881993067;2167.880766557839;2169.2516081951703;2169.707089542915;1853.4439668099517;2117.375374264596;2125.2667829598763;2125.309274485798;2125.7130287411233;2108.1567373050902;2147.4631342164457;2157.4067131538795;2183.170395249811;2184.7815218478027;8306;8346.791330216733;8373.62318695654;8375.371847111492;8375.748727538183;4863.319135321058;4978.377702787152;4985.850424487271;4987.825426110068;4993.750312484398;3133.796303240305;3196.6483686794436;3241.7082462578246;3275.0993476793833;3279;956.5350853306562;990.2968892086627;1012.6607586458546;1015.7917626886544;1024.3904876598413;11503.07975361969;11513.194076414655;11550.653480395602;11584.536618535249;11588.478518466605;4196.391523229115;4264.552222016706;4404.11917616478;4404.405405270311;4500.842470513517;9697.078777516124;9713.27150463704;9725.124738773544;9725.367851089657;9735.610575577039;5051.570616497639;5080.085584594734;5086.21163719624;5092.337996060489;5098.719570423662;4079.7144199906315;4506.954930450654;4703.223968045234;4716.292556116541;4718.622510199176;3841.7118716096406;3869.941950870739;3949.92100158001;3982.661473774762;4002.399640054015;1225.2893321873291;1251.5181655062866;1265.3483456020158;1267.9049071319687;1270.898328133747;909.0500427053745;916.6608354908593;932.2914584915377;947.3226642950324;953.0755167487526;5413.133898576209;5565.276514053147;5733.827985160452;5955.910661340084;5977.163197152402;917.3395155488038;919.3013309884536;929.5816882402946;931.9254459643212;963.7590602349412;3918.3534716771983;3957.742746721454;4032.899177520527;4041.7170798044444;4083.3670781028986;10131.848022279672;10456.215783816093;10563.841542376871;10584.523696433678;10591.099756520627;10492;10497.107745841537;10505.159587233004;10509.579616815394;10511.632092876713;7595.772126836204;7831.686732530635;7904.723334683258;7985.880211796828;8012.1186669466315;5801.796937107181;5844.211031510692;5937.910931335947;6016.278046634432;6170.136180934763;9242.861357079515;9605.087516685904;9640.662576809778;9809.705708828747;9922.851157232502;9515.143637072697;9853.556589953327;9972;10050.24623153281;10094.697159085239;7557.697692092474;7766.495177813424;7951.3638908886;8016;8020.117787043538;7923.286904178652;7937.682492700227;7973.8405231896195;8160.428769986044;8174.427790054639;7116.074910261633;7444.106707195171;7472.327490525661;7473.514221575798;7561.4706970513735;7163.6060016699585;7175.712971481083;7226.602536860523;7389.482736208413;7460.850782984418;6361.904571431525;6445.742170313135;6492.220933488012;6502.512311576746;6508.446782023581;4676.251799712029;4680.321353403806;4880.389951256093;5050.419201791841;5129.640925135204;4784.784684689128;4853.344798452305;4916.237983112624;4926.802927882844;4983.825566105314 17:47:34 INFO - PROCESS | 10951 | |4;prototype.html;308.8965196659119;315.2371261547057;317.9984100079499;328.5170798925582;332.0851055342531;5225.178403662018;5307.761150748216;5348.786048558058;5359.866003349918;5404.135338345865;5249.947500524993;5297.278384525025;5299.860529986052;5304.151335786275;5322.121849894763;4153.190127925056;4155.314373128438;4158.6465150462245;4168.874933751992;4170.624643782059;4045.352743561031;4151.647109995654;4211.599898009699;4213.85251516197;4220.662347012247;4099.180163967204;4118.393826407703;4125.257453658341;4128.112455821998;4131.2357213915375;4153.91692166158;4154.480689913776;4163.895902602429;4176.791160441996;4177.7284476509085;3712.628737126293;3723.1995121048835;3724.7020238380865;3732.64539868712;3734.9439758403646;5113.51421614946;5156.607715916682;5170.302009228782;5181.248718935771;5240.6069544784295;4683.555062269079;4695.483496815382;4695.929561056587;4715.1512727709;4734.171519983989;5450.427705090988;5452.836414907559;5462.126059830448;5482;5528.612997090206;3708.42519409492;3889.4749208857006;3928.5874983126932;3962.881113566598;3989.3018721723874;5522.779088836442;5671.958095085807;5764.308283006024;5784;5800.361960184377;3882.378819388884;3965.980170099189;3969.622885825842;3969.7221194516105;3986.1629057897585;4025.19496100781;4027.7986100694848;4053.6554392876346;4053.7162398631813;4066.044479547304;4574.130915126116;4663.533646635309;4670.579647831712;4690.95309046912;4696.647751418657;5521.585881058937;5550.361708403585;5551.500364967092;5554.638948468337;5566.471185237477;1379.903406761517;1402.7615305398108;1404.9297535123203;1406.1492796857958;1409.6405416618902;872.6204101215865;892.4065496444921;913.9405938613969;923.8337099322052;927.2767241551601;4707.458642256116;4750.596199323097;4827.61379089672;4839.056384005085;4846.61227101831;5032.622553308516;5037.5391136570715;5075.568576671024;5076.44159142494;5102.387713474407;4734.786934587952;4758;4809.398825146856;4811.254255590389;5009.398872135367;2987.9840854109707;3000;3013.8794448222266;3014.3217776000665;3017.9547306790414;5847.9415205848245;5921.822345329647;5939.554533410012;5951.672658003851;5957.4042595740075;5575.80120274143;5818.4763371296785;5836.387179346192;5843.6851708365275;5849.713063126105;5831.446012628879;5837.6941108262845;5850.210221620112;5873.442023007808;5893.852653683693;5446.754896029767;5656.095024796013;5686.265688964905;5707.429257074259;5712.714364281686;5626.071698169756;5639.182318563868;5651.463111004448;5674.177244299636;5678.3028061670375;5655.349634792052;5799;5816.767329306949;5819.243498345188;5904.6457212565665;3849.9807500962315;3934.488516492838;4004.3181863617933;4015.6185162409524;4055.3105971985424;5658.349289831722;5684.857878553069;5701.486866182064;5702.315722113373;5713.200151978809;5324.494173053554;5574.526165275997;5583.218349431002;5597.692126932895;5599.60802743804;5531.6257083180035;5535.612507124462;5549.1676248563035;5574.331080270394;5593.727669313497;5290.127129023822;5445.237666726741;5505.054795684289;5513.7794488221625;5530.281063461724;5582.469665381782;5596.888062238651;5599.384067752625;5602.887942241051;5615.859603509945;5495.422980587141;5514.228008078792;5517.724113794214;5523.613347065667;5526.502614764529 17:47:34 INFO - PROCESS | 10951 | |5;yui.html;792.1128336263384;795.2484901767832;804.2600807257322;832.4630613254454;839.2866063845736;13802.861971380284;14919.32863021164;14940.925295373521;14947.92526037371;16560.171991400413;15819.683606327866;16175.757363639525;16276.75584866228;16296.103714295708;16317;668.6489592963684;791.2127433203956;814.1044850664281;816.6774124220959;817.5013241922422;781.9882701759478;785.2540086917422;795.3239746215728;806.1978331560106;807.0315621254518;851.0255757158051;852.9275011623988;854.372036553133;856.1737922904396;856.5674334461088;698.807827847341;702.2310569925922;848.766589187972;849.2314455417857;851.0128251228546;520.1755217979508;592.4253474130087;606.3148642034473;611.1443978430189;617.1544983372763;13205.603831885059;13278.136921100195;13318.866811331956;13424.664383390396;13515.121517101357;13144.934275328562;13495.66260843477;13694.383752731052;13974;14260.92869535656;12731.61805145847;12788.808167877489;12790.680232994157;12951.287679177642;13296.800547991788;4485.34962430449;4542.318652202163;4588.041396308777;4593.150267200545;4620.884477888046;77621.61189194018;78340;78341.21658783396;78373;78471.21528784696;10990.670279891456;11128.44357782124;11154.888451115547;11229.55081796719;11649;19110.33113841009;19129.33047343336;19140.23439062422;19154.61690766177;19288.22847086101;8042;8097.878531822027;8161.347092232607;8214.63034163464;8396.748097557083;4553.681242313072;4806.95193048072;4821.734804585782;4866.318715379779;4924.507549245047;3138.686131386843;3237.3201627657986;3241.497567876983;3243.1081452600724;3246.366958443128;573.5182446744755;578.1703255827816;588.2264821759459;589.5136512377306;592.6177615438019;569.9768914797864;574.2276637921988;582.647498263553;596.83885350955;633.4520639646672;8935.508547029845;9056.456612603264;9074.637014519345;9480.383775054599;9497.905020949702;534.7994502061727;584.1675612252524;618.5793660311032;630.6909614288966;669.8124525132971;4234.957650423518;4601.792919318572;4726.409198850144;4872.805087796449;4893.84994526286;110021;114910;119860;122209;122269.38865305795;104323;104834.47582762038;104916.47541762242;105331.47334263433;107058;79005;89615.55192223997;89806.55096724475;89995.55002224947;91199.54400228089;9142.26861851037;9180.26557875355;9265.72202833916;9296.581653825458;9315.86026209594;38210.235795283385;43441.3483797737;47740;49081.50918490769;49219.7539012317;72731;76335.23664763282;80372;81796;82959.5852020736;11950.163488555718;12554.560590379293;12720.491180352683;12767.361631918182;13070.281134537312;12728.363581821057;12893.35533223354;12943.5469758558;13365.39855706515;14093.224872631694;12780.744385112432;12781.808272875729;12964.481420743441;13131.474741010636;13136.474541018635;12894.548690795777;13082.215067096005;13248.735025299247;13557.457701692216;13667.931660341636;12231;12595.370231488572;12659.303738294482;13167.144135631153;13585;10854.29447085937;10994.34033957965;11033.393163376091;11042.171837112088;11134.498947547218;10585.470726463493;10604.204684648836;10615;10616.043772975003;10640.84038739404 17:47:34 INFO - PROCESS | 10951 | __end_tp_report 17:47:34 INFO - PROCESS | 10951 | __start_cc_report 17:47:34 INFO - PROCESS | 10951 | _x_x_mozilla_cycle_collect,1097 17:47:34 INFO - PROCESS | 10951 | __end_cc_report 17:47:34 INFO - PROCESS | 10951 | __startTimestamp1468457254082__endTimestamp 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | ------- Summary: start ------- 17:47:34 INFO - PROCESS | 10951 | Number of tests: 6 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#0] dojo.html Cycles:165 Average:5166.58 Median:5373.52 stddev:587.60 (10.9%) stddev-sans-first:563.71 17:47:34 INFO - PROCESS | 10951 | Values: 2975.8 2991.8 3008.0 3012.3 3027.6 5102.0 5105.5 5114.2 5207.4 5269.8 5187.4 5196.8 5213.3 5214.6 5263.2 4683.7 4781.1 4788.1 4790.2 4918.1 4831.9 4851.8 4864.4 4880.9 4890.7 4681.8 4682.7 4692.7 4747.7 4761.3 4731.5 4732.6 4739.5 4744.0 4850.3 4761.2 4763.6 4764.2 4780.7 4789.1 5094.8 5101.9 5139.4 5152.6 5317.9 5525.6 5572.2 5587.4 5589.2 5589.4 5567.6 5604.0 5609.5 5616.4 5617.6 5081.7 5166.0 5181.6 5222.9 5235.1 5773.8 5786.5 5787.9 5789.0 5794.5 5516.3 5516.9 5550.8 5563.8 5564.7 5369.8 5371.4 5456.9 5471.2 5646.8 5446.0 5481.2 5499.9 5509.0 5510.5 5384.1 5428.4 5429.9 5434.5 5483.0 4132.1 4171.5 4178.5 4189.9 4212.0 3767.7 3775.6 3786.0 3814.3 3820.7 5195.8 5236.3 5240.7 5242.3 5280.2 5413.0 5499.6 5505.9 5548.1 5567.8 5293.0 5309.1 5325.3 5327.4 5330.0 4695.5 4706.4 4709.5 4710.6 4749.2 5650.7 5681.7 5742.1 5760.4 5782.6 5627.7 5635.3 5641.1 5641.5 5642.2 5665.5 5781.7 5792.3 5793.3 5793.8 5410.3 5441.8 5454.8 5489.6 5504.0 5561.2 5574.0 5574.4 5574.6 5578.7 5419.5 5453.2 5465.8 5467.8 5517.9 5373.5 5426.1 5437.4 5466.9 5471.4 5366.2 5380.3 5405.5 5405.6 5406.2 5375.4 5388.2 5487.9 5499.5 5552.6 5293.3 5313.2 5314.7 5349.2 5386.1 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#1] ext.html Cycles:180 Average:64050.70 Median:43470.00 stddev:129577.89 (298.1%) stddev-sans-first:129853.71 17:47:34 INFO - PROCESS | 10951 | Values: 560.5 612.4 617.9 618.9 625.8 43384.0 44999.8 45063.8 45225.5 48139.3 45676.0 46172.3 46192.8 46249.1 46289.0 9049.0 9202.5 9217.9 9220.1 9231.2 8978.3 8980.5 9082.6 9093.8 9097.6 8941.6 8971.4 8971.9 8974.0 8975.0 9101.5 9124.5 9139.0 9142.9 9143.7 9077.2 9129.3 9154.0 9159.5 9159.9 43264.4 43556.0 43646.8 43704.0 43745.3 3427.7 3451.3 3528.2 3660.3 3708.3 33020.0 33376.7 33685.2 33695.0 34461.5 4433.7 4501.9 4557.2 4562.8 4576.8 370834.0 374284.0 374897.0 376281.0 377096.0 63904.7 63937.0 64367.7 64421.0 64456.4 57854.7 64278.0 65417.7 65524.3 66941.7 16651.6 16652.4 16719.9 16880.4 16973.2 12648.3 12712.0 12721.9 12824.0 12864.8 17489.8 17671.1 17683.6 18894.9 19266.0 6963.3 7007.2 7181.7 7233.2 7447.8 963.3 1102.1 1113.3 1134.9 1136.2 33214.3 33509.2 33623.5 33649.9 33659.5 1072.7 1149.1 1168.7 1182.4 1239.5 17227.7 17433.7 17476.3 17484.8 17647.0 599729.0 604202.0 604485.0 605391.0 606494.0 59606.7 61284.4 61303.0 61404.7 61425.4 1336.1 1345.2 1357.3 1362.8 1382.7 31666.8 32998.7 33401.5 33519.7 34087.3 54784.5 55003.0 55180.7 55223.2 55238.4 452421.0 453614.0 456630.0 456766.0 457324.0 25597.2 27681.6 28416.9 29161.1 29499.6 47104.0 47683.0 48116.3 48183.8 48705.3 39600.6 40224.6 41152.6 41337.6 41634.0 41182.2 41335.8 41702.0 41877.8 42004.8 36463.3 40583.9 41370.8 41410.2 41430.0 33204.7 35561.5 36286.5 36417.8 36518.3 27051.7 27723.4 27792.9 27803.0 27859.6 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#2] jquery.html Cycles:180 Average:29851.44 Median:44960.39 stddev:87311.40 (194.2%) stddev-sans-first:87528.28 17:47:34 INFO - PROCESS | 10951 | Values: 373.7 373.7 375.1 375.3 386.3 18720.1 19349.3 20243.5 20319.5 21008.3 11630.1 12028.0 12102.3 12107.7 12878.5 4943.2 5074.4 5105.2 5114.5 5117.2 3808.1 5511.3 5766.2 5777.5 6011.5 5570.1 5895.6 5908.1 5998.6 6001.8 5705.2 5708.9 5745.6 5747.9 5751.9 3653.3 3816.2 3816.9 5310.7 5686.3 13390.9 13547.5 13555.6 22471.0 24266.9 2082.8 2365.4 2901.5 2913.4 2978.5 9206.8 9759.8 10274.3 11471.5 15383.6 1878.8 1907.9 1972.3 1987.1 2027.3 84928.6 85336.1 85634.6 88419.0 88464.1 10580.1 10797.8 11017.3 11046.8 11197.0 14931.0 15053.9 15060.5 15061.9 15082.1 8159.5 8329.1 8347.9 8367.7 8474.5 8052.3 8064.5 8164.2 8234.1 8245.0 4594.0 4612.2 4637.5 4660.7 4746.8 1706.4 1743.0 1835.4 1879.8 1960.4 926.1 968.2 968.6 1003.1 1020.9 18879.0 19669.9 19724.9 19869.8 20342.8 996.4 1030.8 1035.4 1043.1 1058.5 10461.2 10852.7 10865.9 10948.8 10949.8 522297.0 528843.0 529202.0 530274.0 534707.0 93166.5 95249.5 95251.5 96278.5 96382.5 986.4 994.3 997.1 998.4 1009.1 16224.5 17182.9 17408.2 17599.6 17899.7 36081.8 42566.8 44084.6 44556.0 45364.8 57863.1 58167.4 59015.4 59113.7 59882.0 8114.9 8176.3 8183.7 8272.1 8324.4 8752.5 8769.4 12252.7 13307.1 13543.7 8152.3 8422.1 8487.6 8488.2 8699.0 7888.6 7961.3 7974.4 8217.5 8379.3 8122.6 8364.1 8408.1 8434.3 8698.1 12772.5 13076.6 13076.8 13171.7 13248.7 12548.0 12932.2 13038.3 13048.7 13101.0 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#3] mootools.html Cycles:180 Average:5539.65 Median:4986.84 stddev:3163.64 (63.4%) stddev-sans-first:3156.41 17:47:34 INFO - PROCESS | 10951 | Values: 1292.1 1430.4 1463.6 1579.4 1736.3 7929.5 8243.8 8252.4 8454.1 8467.0 8266.2 8470.3 8475.4 8477.5 8480.6 1918.4 1971.3 1975.6 2170.6 2196.1 2004.6 2018.9 2074.7 2075.4 2099.8 2143.4 2145.4 2167.9 2169.3 2169.7 1853.4 2117.4 2125.3 2125.3 2125.7 2108.2 2147.5 2157.4 2183.2 2184.8 8306.0 8346.8 8373.6 8375.4 8375.7 4863.3 4978.4 4985.9 4987.8 4993.8 3133.8 3196.6 3241.7 3275.1 3279.0 956.5 990.3 1012.7 1015.8 1024.4 11503.1 11513.2 11550.7 11584.5 11588.5 4196.4 4264.6 4404.1 4404.4 4500.8 9697.1 9713.3 9725.1 9725.4 9735.6 5051.6 5080.1 5086.2 5092.3 5098.7 4079.7 4507.0 4703.2 4716.3 4718.6 3841.7 3869.9 3949.9 3982.7 4002.4 1225.3 1251.5 1265.3 1267.9 1270.9 909.1 916.7 932.3 947.3 953.1 5413.1 5565.3 5733.8 5955.9 5977.2 917.3 919.3 929.6 931.9 963.8 3918.4 3957.7 4032.9 4041.7 4083.4 10131.8 10456.2 10563.8 10584.5 10591.1 10492.0 10497.1 10505.2 10509.6 10511.6 7595.8 7831.7 7904.7 7985.9 8012.1 5801.8 5844.2 5937.9 6016.3 6170.1 9242.9 9605.1 9640.7 9809.7 9922.9 9515.1 9853.6 9972.0 10050.2 10094.7 7557.7 7766.5 7951.4 8016.0 8020.1 7923.3 7937.7 7973.8 8160.4 8174.4 7116.1 7444.1 7472.3 7473.5 7561.5 7163.6 7175.7 7226.6 7389.5 7460.9 6361.9 6445.7 6492.2 6502.5 6508.4 4676.3 4680.3 4880.4 5050.4 5129.6 4784.8 4853.3 4916.2 4926.8 4983.8 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#4] prototype.html Cycles:180 Average:4623.26 Median:5245.28 stddev:1362.69 (26.0%) stddev-sans-first:1327.48 17:47:34 INFO - PROCESS | 10951 | Values: 308.9 315.2 318.0 328.5 332.1 5225.2 5307.8 5348.8 5359.9 5404.1 5249.9 5297.3 5299.9 5304.2 5322.1 4153.2 4155.3 4158.6 4168.9 4170.6 4045.4 4151.6 4211.6 4213.9 4220.7 4099.2 4118.4 4125.3 4128.1 4131.2 4153.9 4154.5 4163.9 4176.8 4177.7 3712.6 3723.2 3724.7 3732.6 3734.9 5113.5 5156.6 5170.3 5181.2 5240.6 4683.6 4695.5 4695.9 4715.2 4734.2 5450.4 5452.8 5462.1 5482.0 5528.6 3708.4 3889.5 3928.6 3962.9 3989.3 5522.8 5672.0 5764.3 5784.0 5800.4 3882.4 3966.0 3969.6 3969.7 3986.2 4025.2 4027.8 4053.7 4053.7 4066.0 4574.1 4663.5 4670.6 4691.0 4696.6 5521.6 5550.4 5551.5 5554.6 5566.5 1379.9 1402.8 1404.9 1406.1 1409.6 872.6 892.4 913.9 923.8 927.3 4707.5 4750.6 4827.6 4839.1 4846.6 5032.6 5037.5 5075.6 5076.4 5102.4 4734.8 4758.0 4809.4 4811.3 5009.4 2988.0 3000.0 3013.9 3014.3 3018.0 5847.9 5921.8 5939.6 5951.7 5957.4 5575.8 5818.5 5836.4 5843.7 5849.7 5831.4 5837.7 5850.2 5873.4 5893.9 5446.8 5656.1 5686.3 5707.4 5712.7 5626.1 5639.2 5651.5 5674.2 5678.3 5655.3 5799.0 5816.8 5819.2 5904.6 3850.0 3934.5 4004.3 4015.6 4055.3 5658.3 5684.9 5701.5 5702.3 5713.2 5324.5 5574.5 5583.2 5597.7 5599.6 5531.6 5535.6 5549.2 5574.3 5593.7 5290.1 5445.2 5505.1 5513.8 5530.3 5582.5 5596.9 5599.4 5602.9 5615.9 5495.4 5514.2 5517.7 5523.6 5526.5 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - PROCESS | 10951 | [#5] yui.html Cycles:180 Average:20891.19 Median:4570.86 stddev:30994.07 (678.1%) stddev-sans-first:31044.28 17:47:34 INFO - PROCESS | 10951 | Values: 792.1 795.2 804.3 832.5 839.3 13802.9 14919.3 14940.9 14947.9 16560.2 15819.7 16175.8 16276.8 16296.1 16317.0 668.6 791.2 814.1 816.7 817.5 782.0 785.3 795.3 806.2 807.0 851.0 852.9 854.4 856.2 856.6 698.8 702.2 848.8 849.2 851.0 520.2 592.4 606.3 611.1 617.2 13205.6 13278.1 13318.9 13424.7 13515.1 13144.9 13495.7 13694.4 13974.0 14260.9 12731.6 12788.8 12790.7 12951.3 13296.8 4485.3 4542.3 4588.0 4593.2 4620.9 77621.6 78340.0 78341.2 78373.0 78471.2 10990.7 11128.4 11154.9 11229.6 11649.0 19110.3 19129.3 19140.2 19154.6 19288.2 8042.0 8097.9 8161.3 8214.6 8396.7 4553.7 4807.0 4821.7 4866.3 4924.5 3138.7 3237.3 3241.5 3243.1 3246.4 573.5 578.2 588.2 589.5 592.6 570.0 574.2 582.6 596.8 633.5 8935.5 9056.5 9074.6 9480.4 9497.9 534.8 584.2 618.6 630.7 669.8 4235.0 4601.8 4726.4 4872.8 4893.8 110021.0 114910.0 119860.0 122209.0 122269.4 104323.0 104834.5 104916.5 105331.5 107058.0 79005.0 89615.6 89806.6 89995.6 91199.5 9142.3 9180.3 9265.7 9296.6 9315.9 38210.2 43441.3 47740.0 49081.5 49219.8 72731.0 76335.2 80372.0 81796.0 82959.6 11950.2 12554.6 12720.5 12767.4 13070.3 12728.4 12893.4 12943.5 13365.4 14093.2 12780.7 12781.8 12964.5 13131.5 13136.5 12894.5 13082.2 13248.7 13557.5 13667.9 12231.0 12595.4 12659.3 13167.1 13585.0 10854.3 10994.3 11033.4 11042.2 11134.5 10585.5 10604.2 10615.0 10616.0 10640.8 17:47:34 INFO - PROCESS | 10951 | -------- Summary: end -------- 17:47:34 INFO - PROCESS | 10951 | 17:47:34 INFO - TEST-INFO | 10951: exit 0 17:47:34 INFO - TEST-OK | dromaeo_css | took 1112297ms 17:47:34 INFO - TEST-START | kraken 17:47:34 INFO - operating with platform_type : linux_ 17:47:34 INFO - Initialising browser for kraken test... 17:47:34 INFO - TEST-INFO | started process 11139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPaLR8/profile http://localhost:35396/getInfo.html) 17:47:38 INFO - PROCESS | 11139 | __metrics Screen width/height:1600/1200 17:47:38 INFO - PROCESS | 11139 | colorDepth:24 17:47:38 INFO - PROCESS | 11139 | Browser inner width/height: 1024/697 17:47:38 INFO - PROCESS | 11139 | __metrics 17:47:39 INFO - PROCESS | 11139 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:47:39 INFO - PROCESS | 11139 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:47:40 INFO - TEST-INFO | 11139: exit 0 17:47:40 INFO - Browser initialized. 17:47:40 INFO - Running cycle 1/1 for kraken test... 17:47:40 INFO - TEST-INFO | started process 11223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWPaLR8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:51 INFO - PROCESS | 11223 | RSS: Main: 157667328 17:47:51 INFO - PROCESS | 11223 | 17:47:54 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35396/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:55 INFO - PROCESS | 11223 | RSS: Main: 215261184 17:47:55 INFO - PROCESS | 11223 | 17:47:57 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35396/tests/kraken/driver.html?testName=audio-dft) 17:47:58 INFO - PROCESS | 11223 | RSS: Main: 203911168 17:47:58 INFO - PROCESS | 11223 | 17:48:01 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35396/tests/kraken/driver.html?testName=audio-fft) 17:48:02 INFO - PROCESS | 11223 | RSS: Main: 269537280 17:48:02 INFO - PROCESS | 11223 | 17:48:04 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35396/tests/kraken/driver.html?testName=audio-oscillator) 17:48:04 INFO - PROCESS | 11223 | RSS: Main: 181010432 17:48:04 INFO - PROCESS | 11223 | 17:48:07 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:07 INFO - PROCESS | 11223 | RSS: Main: 185405440 17:48:07 INFO - PROCESS | 11223 | 17:48:10 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35396/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:11 INFO - PROCESS | 11223 | RSS: Main: 219316224 17:48:11 INFO - PROCESS | 11223 | 17:48:14 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35396/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:15 INFO - PROCESS | 11223 | RSS: Main: 221507584 17:48:15 INFO - PROCESS | 11223 | 17:48:17 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35396/tests/kraken/driver.html?testName=json-parse-financial) 17:48:18 INFO - PROCESS | 11223 | RSS: Main: 221900800 17:48:18 INFO - PROCESS | 11223 | 17:48:20 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:48:20 INFO - PROCESS | 11223 | RSS: Main: 209575936 17:48:20 INFO - PROCESS | 11223 | 17:48:22 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:48:23 INFO - PROCESS | 11223 | RSS: Main: 211439616 17:48:23 INFO - PROCESS | 11223 | 17:48:24 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:48:25 INFO - PROCESS | 11223 | RSS: Main: 210206720 17:48:25 INFO - PROCESS | 11223 | 17:48:28 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:48:28 INFO - PROCESS | 11223 | RSS: Main: 222302208 17:48:28 INFO - PROCESS | 11223 | 17:48:31 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:48:32 INFO - PROCESS | 11223 | RSS: Main: 223760384 17:48:32 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | Cycle 1(1): loaded http://localhost:35396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35396/tests/kraken/driver.html?testName=ai-astar) 17:48:33 INFO - PROCESS | 11223 | RSS: Main: 265494528 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | __start_tp_report 17:48:33 INFO - PROCESS | 11223 | _x_x_mozilla_page_load 17:48:33 INFO - PROCESS | 11223 | _x_x_mozilla_page_load_details 17:48:33 INFO - PROCESS | 11223 | |i|pagename|runs| 17:48:33 INFO - PROCESS | 11223 | |0;ai-astar;102;112;110;109;111;111;109;111;108;111 17:48:33 INFO - PROCESS | 11223 | |1;audio-beat-detection;144;116;120;174;119;119;147;116;169;117 17:48:33 INFO - PROCESS | 11223 | |2;audio-dft;161;161;161;160;161;160;161;162;160;161 17:48:33 INFO - PROCESS | 11223 | |3;audio-fft;74;75;76;126;76;75;74;74;112;76 17:48:33 INFO - PROCESS | 11223 | |4;audio-oscillator;85;84;115;85;83;84;119;84;84;131 17:48:33 INFO - PROCESS | 11223 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;117;117 17:48:33 INFO - PROCESS | 11223 | |6;imaging-darkroom;145;146;146;146;145;145;146;145;146;146 17:48:33 INFO - PROCESS | 11223 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;95;95 17:48:33 INFO - PROCESS | 11223 | |8;json-parse-financial;54;52;51;51;53;51;51;51;53;51 17:48:33 INFO - PROCESS | 11223 | |9;json-stringify-tinderbox;61;62;62;62;62;62;62;63;70;62 17:48:33 INFO - PROCESS | 11223 | |10;stanford-crypto-aes;76;76;74;74;74;76;75;75;75;78 17:48:33 INFO - PROCESS | 11223 | |11;stanford-crypto-ccm;118;117;118;118;117;118;119;120;159;119 17:48:33 INFO - PROCESS | 11223 | |12;stanford-crypto-pbkdf2;160;158;157;156;156;155;159;157;159;161 17:48:33 INFO - PROCESS | 11223 | |13;stanford-crypto-sha256-iterative;63;64;64;62;62;62;62;61;62;61 17:48:33 INFO - PROCESS | 11223 | __end_tp_report 17:48:33 INFO - PROCESS | 11223 | __start_cc_report 17:48:33 INFO - PROCESS | 11223 | _x_x_mozilla_cycle_collect,1664 17:48:33 INFO - PROCESS | 11223 | __end_cc_report 17:48:33 INFO - PROCESS | 11223 | __startTimestamp1468457313893__endTimestamp 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | ------- Summary: start ------- 17:48:33 INFO - PROCESS | 11223 | Number of tests: 14 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:2.88 (2.6%) stddev-sans-first:1.30 17:48:33 INFO - PROCESS | 11223 | Values: 102.0 112.0 110.0 109.0 111.0 111.0 109.0 111.0 108.0 111.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:132.00 stddev:22.80 (17.3%) stddev-sans-first:23.90 17:48:33 INFO - PROCESS | 11223 | Values: 144.0 116.0 120.0 174.0 119.0 119.0 147.0 116.0 169.0 117.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:48:33 INFO - PROCESS | 11223 | Values: 161.0 161.0 161.0 160.0 161.0 160.0 161.0 162.0 160.0 161.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:18.86 (25.1%) stddev-sans-first:19.67 17:48:33 INFO - PROCESS | 11223 | Values: 74.0 75.0 76.0 126.0 76.0 75.0 74.0 74.0 112.0 76.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.55 (22.1%) stddev-sans-first:19.29 17:48:33 INFO - PROCESS | 11223 | Values: 85.0 84.0 115.0 85.0 83.0 84.0 119.0 84.0 84.0 131.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:48:33 INFO - PROCESS | 11223 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:48:33 INFO - PROCESS | 11223 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:48:33 INFO - PROCESS | 11223 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.50 stddev:1.14 (2.2%) stddev-sans-first:0.88 17:48:33 INFO - PROCESS | 11223 | Values: 54.0 52.0 51.0 51.0 53.0 51.0 51.0 51.0 53.0 51.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:62.00 stddev:2.57 (4.2%) stddev-sans-first:2.65 17:48:33 INFO - PROCESS | 11223 | Values: 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 70.0 62.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.50 stddev:1.25 (1.7%) stddev-sans-first:1.30 17:48:33 INFO - PROCESS | 11223 | Values: 76.0 76.0 74.0 74.0 74.0 76.0 75.0 75.0 75.0 78.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:118.50 stddev:12.93 (10.9%) stddev-sans-first:13.62 17:48:33 INFO - PROCESS | 11223 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 119.0 120.0 159.0 119.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.50 stddev:1.93 (1.2%) stddev-sans-first:1.88 17:48:33 INFO - PROCESS | 11223 | Values: 160.0 158.0 157.0 156.0 156.0 155.0 159.0 157.0 159.0 161.0 17:48:33 INFO - PROCESS | 11223 | 17:48:33 INFO - PROCESS | 11223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.06 (1.7%) stddev-sans-first:1.09 17:48:33 INFO - PROCESS | 11223 | Values: 63.0 64.0 64.0 62.0 62.0 62.0 62.0 61.0 62.0 61.0 17:48:33 INFO - PROCESS | 11223 | -------- Summary: end -------- 17:48:33 INFO - PROCESS | 11223 | 17:48:34 INFO - TEST-INFO | 11223: exit 0 17:48:34 INFO - TEST-OK | kraken | took 60109ms 17:48:34 INFO - SUITE-END | took 1172s 17:48:35 INFO - Completed test suite (00:19:32) 17:48:35 INFO - javascript benchmark 17:48:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.7916945813795, 2991.8354490503043, 3007.984960075201, 3012.307169351049, 3027.6366835979684, 5101.974490127544, 5105.514976077271, 5114.156164232906, 5207.4271830098705, 5269.76286067127, 5187.429382767902, 5196.766145523451, 5213.296205012322, 5214.582833373331, 5263.1578947368425, 4683.7189768613825, 4781.115493633689, 4788.114198873202, 4790.209615413452, 4918.065567542173, 4831.9275210871865, 4851.781669824849, 4864.416270047582, 4880.902381952359, 4890.73100979446, 4681.812727490897, 4682.719036857799, 4692.718436893797, 4747.667663263573, 4761.262004389325, 4731.503192164842, 4732.550407711262, 4739.478657347689, 4743.952560474386, 4850.296706977504, 4761.190597598382, 4763.64272679547, 4764.166270902613, 4780.665353425262, 4789.114013907403, 5094.821681241138, 5101.923471147936, 5139.408967968657, 5152.587792976553, 5317.946820531823, 5525.613207075507, 5572.247746554244, 5587.38538760736, 5589.189567512688, 5589.441055894418, 5567.610267281292, 5604.0, 5609.52319052881, 5616.438356164392, 5617.578681598856, 5081.720505372203, 5165.999999999963, 5181.559567436735, 5222.92165617516, 5235.110031294689, 5773.797917072882, 5786.508146807569, 5787.88424231513, 5788.971055144697, 5794.5364370851075, 5516.282883225235, 5516.9448305517235, 5550.8057217997175, 5563.777448902079, 5564.749586268627, 5369.838904832784, 5371.355437347544, 5456.945430545644, 5471.151971444432, 5646.802361917313, 5445.992491389105, 5481.205225242397, 5499.917501237484, 5509.035918714209, 5510.476504732044, 5384.057789886754, 5428.37573679032, 5429.864253393696, 5434.483724046209, 5482.985647655197, 4132.070284186094, 4171.541130475645, 4178.498580170338, 4189.91620167601, 4212.031232816469, 3767.698584113264, 3775.6035616260447, 3785.981070094687, 3814.332491813977, 3820.6943444524372, 5195.766190521435, 5236.345456817898, 5240.737963101829, 5242.344706911636, 5280.20796880471, 5413.0, 5499.587530935196, 5505.889882202334, 5548.056830338852, 5567.805126820542, 5292.973535132377, 5309.070912590359, 5325.2810870531985, 5327.360716714019, 5330.013947419662, 4695.489544577301, 4706.364640773451, 4709.505501922249, 4710.552497512731, 4749.1926372516755, 5650.745716442688, 5681.744321505459, 5742.109972954116, 5760.36635970043, 5782.624129431658, 5627.690477023639, 5635.267415235993, 5641.097424412074, 5641.548676105819, 5642.23829782974, 5665.49010589049, 5781.739821708117, 5792.275965504312, 5793.275840519935, 5793.768249270151, 5410.296661433988, 5441.782328706808, 5454.809081682122, 5489.64317319373, 5504.036793561191, 5561.221428999862, 5573.972130139486, 5574.358948720786, 5574.609777315549, 5578.665280083208, 5419.539339156216, 5453.15476101205, 5465.7813687453645, 5467.835964921059, 5517.917231241615, 5373.516383525502, 5426.07756681373, 5437.374701909331, 5466.863328416822, 5471.398146203994, 5366.2487251784005, 5380.3274590676165, 5405.486478784509, 5405.621606487665, 5406.24312596229, 5375.435579264277, 5388.164834450667, 5487.945120548743, 5499.50504454601, 5552.611317207919, 5293.2589437479555, 5313.229581710708, 5314.734263286898, 5349.170878513836, 5386.13821788512], "value": 5126.66150468045, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.5207547546847, 612.4334990134125, 617.8640699046209, 618.913352130702, 625.8466675664463, 43384.0, 44999.77500112495, 45063.774681126546, 45225.547744522584, 48139.27791083136, 45676.0, 46172.307415388714, 46192.76903615486, 46249.07501849961, 46289.0, 9048.954755226232, 9202.539873006357, 9217.907820921771, 9220.07799220076, 9231.215346695539, 8978.326625503081, 8980.46117232965, 9082.59128339223, 9093.818123637524, 9097.590608422604, 8941.59762810675, 8971.416857904247, 8971.910280897206, 8973.95513022434, 8975.0, 9101.453912765222, 9124.452532847983, 9138.954305228432, 9142.908570914273, 9143.725688229331, 9077.228435582983, 9129.269658427309, 9154.0, 9159.450432973976, 9159.862602060974, 43264.35103473451, 43556.0, 43646.781766091284, 43704.0, 43745.343819842725, 3427.657234276577, 3451.3097380523996, 3528.2414280929465, 3660.3045421369857, 3708.332500149999, 33020.0, 33376.6662333376, 33685.157871053176, 33695.0, 34461.48307775385, 4433.689641725081, 4501.887452813673, 4557.225271703818, 4562.77186140695, 4576.839810606646, 370834.0, 374284.0, 374897.0, 376281.0, 377096.0, 63904.68047659732, 63937.0, 64367.67816160889, 64421.0, 64456.35543644503, 57854.7107264461, 64278.0, 65417.672911635134, 65524.34475655182, 66941.6652916742, 16651.583710407336, 16652.417165399154, 16719.916400418162, 16880.409185678443, 16973.236204370834, 12648.304343261208, 12712.046596505299, 12721.872781272254, 12824.0, 12864.807027894589, 17489.825101749073, 17671.11644417774, 17683.646327073642, 18894.905525472284, 19265.996411101114, 6963.303669633097, 7007.159140903124, 7181.676824542908, 7233.204347521769, 7447.776566703008, 963.2534785541121, 1102.1238115698038, 1113.2541197397763, 1134.9035331996872, 1136.159242160795, 33214.335713285596, 33509.16227094342, 33623.495647564814, 33649.91590515495, 33659.49510757292, 1072.694282129605, 1149.149629274331, 1168.655246702225, 1182.4206138991833, 1239.4918083585687, 17227.741583876254, 17433.651326973388, 17476.30094796194, 17484.825151748573, 17647.0, 599729.0, 604202.0, 604485.0, 605391.0, 606494.0, 59606.70196648989, 61284.38715612876, 61303.0, 61404.69297653483, 61425.38574614197, 1336.0781061067833, 1345.2466618693368, 1357.3281225793296, 1362.8364596248514, 1382.6958069224754, 31666.841665791522, 32998.67001329956, 33401.49897751487, 33519.664803351654, 34087.31825363528, 54784.45215547953, 55003.0, 55180.724096380865, 55223.17165242605, 55238.44761552333, 452421.0, 453614.0, 456630.0, 456766.0, 457324.0, 25597.23208303754, 27681.58477622797, 28416.85791571029, 29161.125166245045, 29499.557506637848, 47104.0, 47683.0, 48116.27825582549, 48183.75908120437, 48705.26942095801, 39600.603993960845, 40224.597754022085, 41152.58847411488, 41337.58662413458, 41634.0, 41182.176356473305, 41335.793321034405, 41702.0, 41877.79061104675, 42004.78997604993, 36463.27073458569, 40583.9445172938, 41370.79314603408, 41410.1717965645, 41430.0, 33204.66795332016, 35561.46657800187, 36286.455703165004, 36417.81791091028, 36518.26963460663, 27051.729482704923, 27723.44553108967, 27792.861035694692, 27803.0, 27859.582106268826], "value": 20668.111039877313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.6749028345339, 373.7458528200824, 375.0642147841137, 375.33190920162104, 386.32393311704516, 18720.063996800156, 19349.322773702923, 20243.49391265219, 20319.49201269969, 21008.264710735126, 11630.12774041946, 12028.0, 12102.273863568193, 12107.697307567316, 12878.549250776225, 4943.1596628573225, 5074.441811400761, 5105.208692652626, 5114.488551144893, 5117.1556693145585, 3808.1241314497684, 5511.311086114236, 5766.1639062335935, 5777.508911742507, 6011.5491338149595, 5570.108782594785, 5895.616784908989, 5908.113782932552, 5998.610090344136, 6001.849953751169, 5705.2012718219485, 5708.914366284509, 5745.569082318801, 5747.942520574804, 5751.942480575203, 3653.2693461307845, 3816.2367526494813, 3816.9427458588143, 5310.734463276821, 5686.289213848269, 13390.86609133906, 13547.45810167592, 13555.593332199951, 22471.0, 24266.878665606735, 2082.7708952015264, 2365.4086478380405, 2901.5357542793054, 2913.4318807832483, 2978.5085460898927, 9206.815863682688, 9759.756006099833, 10274.280800343979, 11471.48378322969, 15383.615409614737, 1878.8121187881238, 1907.8855268683924, 1972.3491247888305, 1987.1256647075386, 2027.2701827342146, 84928.57535712281, 85336.14663853344, 85634.57182714109, 88419.0, 88464.11535884687, 10580.095582795171, 10797.784044319227, 11017.338959662446, 11046.779064418666, 11197.0, 14931.0, 15053.924730376279, 15060.54818355451, 15061.924690376698, 15082.095074295357, 8159.510429374138, 8329.125441828643, 8347.916520834835, 8367.665293388318, 8474.491530508189, 8052.275295223458, 8064.516129032277, 8164.183581641788, 8234.135415781377, 8244.958775206085, 4593.954060459353, 4612.215923293048, 4637.46669133054, 4660.6970546914345, 4746.833860814855, 1706.3942300483398, 1743.0, 1835.4493651904374, 1879.7838248601313, 1960.4020773663883, 926.1340646495548, 968.1818863060843, 968.6125549780145, 1003.1322905686675, 1020.8774947006407, 18879.0, 19669.901650491942, 19724.90137549332, 19869.801301986794, 20342.79657203409, 996.3673067602125, 1030.8299130643509, 1035.4201647077662, 1043.0612448796144, 1058.5025038232018, 10461.215408844368, 10852.72868178286, 10865.945670271756, 10948.835767463494, 10949.83575246372, 522297.0, 528843.0, 529202.0, 530274.0, 534707.0, 93166.53416732873, 95249.52375238219, 95251.52374238223, 96278.51860740791, 96382.51808740912, 986.4229425785852, 994.264244459095, 997.0806198068689, 998.3660375661507, 1009.1220638044948, 16224.513264602081, 17182.914085429493, 17408.216630251416, 17599.64800703953, 17899.73150402771, 36081.819590901876, 42566.78716606397, 44084.559154409326, 44556.0, 45364.77317613391, 57863.10684465844, 58167.4183258162, 59015.40984590271, 59113.70443147757, 59882.0, 8114.878276825971, 8176.345892328718, 8183.713570025258, 8272.090070092405, 8324.417290789828, 8752.51861147643, 8769.38614296993, 12252.652208256906, 13307.068505204543, 13543.661408464866, 8152.2662960333855, 8422.105026369018, 8487.618057187317, 8488.193621605938, 8698.956505217433, 7888.645010974635, 7961.323287520394, 7974.362051036019, 8217.465864718773, 8379.329653627574, 8122.553259570544, 8364.079951205484, 8408.117147699404, 8434.325253979545, 8698.085861362286, 12772.489100435878, 13076.607701768962, 13076.803847942097, 13171.670708231988, 13248.668783280495, 12548.0, 12932.159409638343, 13038.282894440898, 13048.739025219633, 13101.0], "value": 8866.322015021102, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.1342700390737, 1430.3849344781743, 1463.560931720484, 1579.407722104211, 1736.2707662781622, 7929.484583502069, 8243.835123297538, 8252.422330436864, 8454.070052294242, 8467.0, 8266.214709602593, 8470.322374210064, 8475.449095808768, 8477.533735644538, 8480.618372173252, 1918.4436513411094, 1971.3297478857185, 1975.6048790241937, 2170.5550362175754, 2196.143504033428, 2004.6391649503084, 2018.8687735297233, 2074.678424844152, 2075.4292569543422, 2099.813605313001, 2143.3998480425507, 2145.3992881993067, 2167.880766557839, 2169.2516081951703, 2169.707089542915, 1853.4439668099517, 2117.375374264596, 2125.2667829598763, 2125.309274485798, 2125.7130287411233, 2108.1567373050902, 2147.4631342164457, 2157.4067131538795, 2183.170395249811, 2184.7815218478027, 8306.0, 8346.791330216733, 8373.62318695654, 8375.371847111492, 8375.748727538183, 4863.319135321058, 4978.377702787152, 4985.850424487271, 4987.825426110068, 4993.750312484398, 3133.796303240305, 3196.6483686794436, 3241.7082462578246, 3275.0993476793833, 3279.0, 956.5350853306562, 990.2968892086627, 1012.6607586458546, 1015.7917626886544, 1024.3904876598413, 11503.07975361969, 11513.194076414655, 11550.653480395602, 11584.536618535249, 11588.478518466605, 4196.391523229115, 4264.552222016706, 4404.11917616478, 4404.405405270311, 4500.842470513517, 9697.078777516124, 9713.27150463704, 9725.124738773544, 9725.367851089657, 9735.610575577039, 5051.570616497639, 5080.085584594734, 5086.21163719624, 5092.337996060489, 5098.719570423662, 4079.7144199906315, 4506.954930450654, 4703.223968045234, 4716.292556116541, 4718.622510199176, 3841.7118716096406, 3869.941950870739, 3949.92100158001, 3982.661473774762, 4002.399640054015, 1225.2893321873291, 1251.5181655062866, 1265.3483456020158, 1267.9049071319687, 1270.898328133747, 909.0500427053745, 916.6608354908593, 932.2914584915377, 947.3226642950324, 953.0755167487526, 5413.133898576209, 5565.276514053147, 5733.827985160452, 5955.910661340084, 5977.163197152402, 917.3395155488038, 919.3013309884536, 929.5816882402946, 931.9254459643212, 963.7590602349412, 3918.3534716771983, 3957.742746721454, 4032.899177520527, 4041.7170798044444, 4083.3670781028986, 10131.848022279672, 10456.215783816093, 10563.841542376871, 10584.523696433678, 10591.099756520627, 10492.0, 10497.107745841537, 10505.159587233004, 10509.579616815394, 10511.632092876713, 7595.772126836204, 7831.686732530635, 7904.723334683258, 7985.880211796828, 8012.1186669466315, 5801.796937107181, 5844.211031510692, 5937.910931335947, 6016.278046634432, 6170.136180934763, 9242.861357079515, 9605.087516685904, 9640.662576809778, 9809.705708828747, 9922.851157232502, 9515.143637072697, 9853.556589953327, 9972.0, 10050.24623153281, 10094.697159085239, 7557.697692092474, 7766.495177813424, 7951.3638908886, 8016.0, 8020.117787043538, 7923.286904178652, 7937.682492700227, 7973.8405231896195, 8160.428769986044, 8174.427790054639, 7116.074910261633, 7444.106707195171, 7472.327490525661, 7473.514221575798, 7561.4706970513735, 7163.6060016699585, 7175.712971481083, 7226.602536860523, 7389.482736208413, 7460.850782984418, 6361.904571431525, 6445.742170313135, 6492.220933488012, 6502.512311576746, 6508.446782023581, 4676.251799712029, 4680.321353403806, 4880.389951256093, 5050.419201791841, 5129.640925135204, 4784.784684689128, 4853.344798452305, 4916.237983112624, 4926.802927882844, 4983.825566105314], "value": 4413.822391436808, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.8965196659119, 315.2371261547057, 317.9984100079499, 328.5170798925582, 332.0851055342531, 5225.178403662018, 5307.761150748216, 5348.786048558058, 5359.866003349918, 5404.135338345865, 5249.947500524993, 5297.278384525025, 5299.860529986052, 5304.151335786275, 5322.121849894763, 4153.190127925056, 4155.314373128438, 4158.6465150462245, 4168.874933751992, 4170.624643782059, 4045.352743561031, 4151.647109995654, 4211.599898009699, 4213.85251516197, 4220.662347012247, 4099.180163967204, 4118.393826407703, 4125.257453658341, 4128.112455821998, 4131.2357213915375, 4153.91692166158, 4154.480689913776, 4163.895902602429, 4176.791160441996, 4177.7284476509085, 3712.628737126293, 3723.1995121048835, 3724.7020238380865, 3732.64539868712, 3734.9439758403646, 5113.51421614946, 5156.607715916682, 5170.302009228782, 5181.248718935771, 5240.6069544784295, 4683.555062269079, 4695.483496815382, 4695.929561056587, 4715.1512727709, 4734.171519983989, 5450.427705090988, 5452.836414907559, 5462.126059830448, 5482.0, 5528.612997090206, 3708.42519409492, 3889.4749208857006, 3928.5874983126932, 3962.881113566598, 3989.3018721723874, 5522.779088836442, 5671.958095085807, 5764.308283006024, 5784.0, 5800.361960184377, 3882.378819388884, 3965.980170099189, 3969.622885825842, 3969.7221194516105, 3986.1629057897585, 4025.19496100781, 4027.7986100694848, 4053.6554392876346, 4053.7162398631813, 4066.044479547304, 4574.130915126116, 4663.533646635309, 4670.579647831712, 4690.95309046912, 4696.647751418657, 5521.585881058937, 5550.361708403585, 5551.500364967092, 5554.638948468337, 5566.471185237477, 1379.903406761517, 1402.7615305398108, 1404.9297535123203, 1406.1492796857958, 1409.6405416618902, 872.6204101215865, 892.4065496444921, 913.9405938613969, 923.8337099322052, 927.2767241551601, 4707.458642256116, 4750.596199323097, 4827.61379089672, 4839.056384005085, 4846.61227101831, 5032.622553308516, 5037.5391136570715, 5075.568576671024, 5076.44159142494, 5102.387713474407, 4734.786934587952, 4758.0, 4809.398825146856, 4811.254255590389, 5009.398872135367, 2987.9840854109707, 3000.0, 3013.8794448222266, 3014.3217776000665, 3017.9547306790414, 5847.9415205848245, 5921.822345329647, 5939.554533410012, 5951.672658003851, 5957.4042595740075, 5575.80120274143, 5818.4763371296785, 5836.387179346192, 5843.6851708365275, 5849.713063126105, 5831.446012628879, 5837.6941108262845, 5850.210221620112, 5873.442023007808, 5893.852653683693, 5446.754896029767, 5656.095024796013, 5686.265688964905, 5707.429257074259, 5712.714364281686, 5626.071698169756, 5639.182318563868, 5651.463111004448, 5674.177244299636, 5678.3028061670375, 5655.349634792052, 5799.0, 5816.767329306949, 5819.243498345188, 5904.6457212565665, 3849.9807500962315, 3934.488516492838, 4004.3181863617933, 4015.6185162409524, 4055.3105971985424, 5658.349289831722, 5684.857878553069, 5701.486866182064, 5702.315722113373, 5713.200151978809, 5324.494173053554, 5574.526165275997, 5583.218349431002, 5597.692126932895, 5599.60802743804, 5531.6257083180035, 5535.612507124462, 5549.1676248563035, 5574.331080270394, 5593.727669313497, 5290.127129023822, 5445.237666726741, 5505.054795684289, 5513.7794488221625, 5530.281063461724, 5582.469665381782, 5596.888062238651, 5599.384067752625, 5602.887942241051, 5615.859603509945, 5495.422980587141, 5514.228008078792, 5517.724113794214, 5523.613347065667, 5526.502614764529], "value": 4184.761130345486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.1128336263384, 795.2484901767832, 804.2600807257322, 832.4630613254454, 839.2866063845736, 13802.861971380284, 14919.32863021164, 14940.925295373521, 14947.92526037371, 16560.171991400413, 15819.683606327866, 16175.757363639525, 16276.75584866228, 16296.103714295708, 16317.0, 668.6489592963684, 791.2127433203956, 814.1044850664281, 816.6774124220959, 817.5013241922422, 781.9882701759478, 785.2540086917422, 795.3239746215728, 806.1978331560106, 807.0315621254518, 851.0255757158051, 852.9275011623988, 854.372036553133, 856.1737922904396, 856.5674334461088, 698.807827847341, 702.2310569925922, 848.766589187972, 849.2314455417857, 851.0128251228546, 520.1755217979508, 592.4253474130087, 606.3148642034473, 611.1443978430189, 617.1544983372763, 13205.603831885059, 13278.136921100195, 13318.866811331956, 13424.664383390396, 13515.121517101357, 13144.934275328562, 13495.66260843477, 13694.383752731052, 13974.0, 14260.92869535656, 12731.61805145847, 12788.808167877489, 12790.680232994157, 12951.287679177642, 13296.800547991788, 4485.34962430449, 4542.318652202163, 4588.041396308777, 4593.150267200545, 4620.884477888046, 77621.61189194018, 78340.0, 78341.21658783396, 78373.0, 78471.21528784696, 10990.670279891456, 11128.44357782124, 11154.888451115547, 11229.55081796719, 11649.0, 19110.33113841009, 19129.33047343336, 19140.23439062422, 19154.61690766177, 19288.22847086101, 8042.0, 8097.878531822027, 8161.347092232607, 8214.63034163464, 8396.748097557083, 4553.681242313072, 4806.95193048072, 4821.734804585782, 4866.318715379779, 4924.507549245047, 3138.686131386843, 3237.3201627657986, 3241.497567876983, 3243.1081452600724, 3246.366958443128, 573.5182446744755, 578.1703255827816, 588.2264821759459, 589.5136512377306, 592.6177615438019, 569.9768914797864, 574.2276637921988, 582.647498263553, 596.83885350955, 633.4520639646672, 8935.508547029845, 9056.456612603264, 9074.637014519345, 9480.383775054599, 9497.905020949702, 534.7994502061727, 584.1675612252524, 618.5793660311032, 630.6909614288966, 669.8124525132971, 4234.957650423518, 4601.792919318572, 4726.409198850144, 4872.805087796449, 4893.84994526286, 110021.0, 114910.0, 119860.0, 122209.0, 122269.38865305795, 104323.0, 104834.47582762038, 104916.47541762242, 105331.47334263433, 107058.0, 79005.0, 89615.55192223997, 89806.55096724475, 89995.55002224947, 91199.54400228089, 9142.26861851037, 9180.26557875355, 9265.72202833916, 9296.581653825458, 9315.86026209594, 38210.235795283385, 43441.3483797737, 47740.0, 49081.50918490769, 49219.7539012317, 72731.0, 76335.23664763282, 80372.0, 81796.0, 82959.5852020736, 11950.163488555718, 12554.560590379293, 12720.491180352683, 12767.361631918182, 13070.281134537312, 12728.363581821057, 12893.35533223354, 12943.5469758558, 13365.39855706515, 14093.224872631694, 12780.744385112432, 12781.808272875729, 12964.481420743441, 13131.474741010636, 13136.474541018635, 12894.548690795777, 13082.215067096005, 13248.735025299247, 13557.457701692216, 13667.931660341636, 12231.0, 12595.370231488572, 12659.303738294482, 13167.144135631153, 13585.0, 10854.29447085937, 10994.34033957965, 11033.393163376091, 11042.171837112088, 11134.498947547218, 10585.470726463493, 10604.204684648836, 10615.0, 10616.043772975003, 10640.84038739404], "value": 7357.732546849192, "unit": "score"}], "name": "dromaeo_css", "value": 7096.205609197995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 109.0, 111.0, 111.0, 109.0, 111.0, 108.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 120.0, 174.0, 119.0, 119.0, 147.0, 116.0, 169.0, 117.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 126.0, 76.0, 75.0, 74.0, 74.0, 112.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 115.0, 85.0, 83.0, 84.0, 119.0, 84.0, 84.0, 131.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 51.0, 53.0, 51.0, 51.0, 51.0, 53.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 70.0, 62.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 74.0, 74.0, 76.0, 75.0, 75.0, 75.0, 78.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 119.0, 120.0, 159.0, 119.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 157.0, 156.0, 156.0, 155.0, 159.0, 157.0, 159.0, 161.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1472.9999999999998, "alertThreshold": 2.0}]} 17:48:35 INFO - Return code: 0 17:48:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:48:35 INFO - # TBPL SUCCESS # 17:48:35 INFO - Running post-action listener: _resource_record_post_action 17:48:35 INFO - ##### 17:48:35 INFO - ##### Finished run-tests step (success) 17:48:35 INFO - ##### 17:48:35 INFO - Running post-run listener: _resource_record_post_run 17:48:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 556048384; Read time: 0; Write time: 445048 17:48:35 INFO - TinderboxPrint: CPU usage
13.0% 17:48:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:48:35 INFO - TinderboxPrint: I/O write bytes / time
556,048,384 / 445,048 17:48:35 INFO - TinderboxPrint: CPU idle
8,261.8 (87.0%) 17:48:35 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 17:48:35 INFO - TinderboxPrint: Swap in / out
0 / 0 17:48:35 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256630784; Read time: 0; Write time: 229660 17:48:35 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 299417600; Read time: 0; Write time: 215388 17:48:35 INFO - Running post-run listener: _upload_blobber_files 17:48:35 INFO - Blob upload gear active. 17:48:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:35 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 17:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:48:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:48:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:37 INFO - (blobuploader) - INFO - Done attempting. 17:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:40 INFO - (blobuploader) - INFO - Done attempting. 17:48:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:48:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:48:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:41 INFO - (blobuploader) - INFO - Done attempting. 17:48:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:41 INFO - Return code: 0 17:48:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6589ce502caae63dafc81a38226b709243d5bda88011c205b945885235ee382c6c780fc2b6f63ff090df25f5f10b7214cc8fd0ab072fabf77aaf71e120ec655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea9bcef0eb24b5d51e88d45088e60b493f197266097a8c00e5f819f33a299f294f09458d2ccd96118062c2ff6d20dc82a65fff12c3179d3ae1ef3e9c5a23b54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaeef2c00787ef5678f3358334f3584b6dd7db1deb7b2d68d8d8b268db3a49b8ec36a7bced5bfe7f33feb4724a663b73fc3ac4220d0d4ea97837184ec3baa2dc"} 17:48:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:41 INFO - Contents: 17:48:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6589ce502caae63dafc81a38226b709243d5bda88011c205b945885235ee382c6c780fc2b6f63ff090df25f5f10b7214cc8fd0ab072fabf77aaf71e120ec655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea9bcef0eb24b5d51e88d45088e60b493f197266097a8c00e5f819f33a299f294f09458d2ccd96118062c2ff6d20dc82a65fff12c3179d3ae1ef3e9c5a23b54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaeef2c00787ef5678f3358334f3584b6dd7db1deb7b2d68d8d8b268db3a49b8ec36a7bced5bfe7f33feb4724a663b73fc3ac4220d0d4ea97837184ec3baa2dc"} 17:48:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:41 INFO - Copying logs to upload dir... 17:48:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.215237 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-13 17:48:40.465451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:40.469122) ========= 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=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6589ce502caae63dafc81a38226b709243d5bda88011c205b945885235ee382c6c780fc2b6f63ff090df25f5f10b7214cc8fd0ab072fabf77aaf71e120ec655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea9bcef0eb24b5d51e88d45088e60b493f197266097a8c00e5f819f33a299f294f09458d2ccd96118062c2ff6d20dc82a65fff12c3179d3ae1ef3e9c5a23b54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaeef2c00787ef5678f3358334f3584b6dd7db1deb7b2d68d8d8b268db3a49b8ec36a7bced5bfe7f33feb4724a663b73fc3ac4220d0d4ea97837184ec3baa2dc"} build_url:https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011130 build_url: 'https://queue.taskcluster.net/v1/task/GCnzCZtKRD-cW62ZeTJ1wg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6589ce502caae63dafc81a38226b709243d5bda88011c205b945885235ee382c6c780fc2b6f63ff090df25f5f10b7214cc8fd0ab072fabf77aaf71e120ec655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ea9bcef0eb24b5d51e88d45088e60b493f197266097a8c00e5f819f33a299f294f09458d2ccd96118062c2ff6d20dc82a65fff12c3179d3ae1ef3e9c5a23b54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaeef2c00787ef5678f3358334f3584b6dd7db1deb7b2d68d8d8b268db3a49b8ec36a7bced5bfe7f33feb4724a663b73fc3ac4220d0d4ea97837184ec3baa2dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:40.494682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:40.495021) ========= 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=923d835db2ba3686ebe126b700000192-1468455781.452058-1004064462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:40.577493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:48:40.577828) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:48:40.578139) ========= ========= Total master_lag: 0.16 =========