builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1471977419.24 results: success (0) buildid: 20160823080458 builduid: a2b4d81c2c674d329bffc448498cd257 revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.235808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.236294) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.236660) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.254846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.255315) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 11:36:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-08-23 11:36:59 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.392658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.392991) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019822 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:36:59.444034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:36:59.444452) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --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 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 --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=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 11:36:59,553 truncating revision to first 12 chars 2016-08-23 11:36:59,553 Setting DEBUG logging. 2016-08-23 11:36:59,553 attempt 1/10 2016-08-23 11:36:59,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8381bc7a4681?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 11:37:00,359 unpacking tar archive at: fx-team-8381bc7a4681/testing/mozharness/ program finished with exit code 0 elapsedTime=1.130227 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-23 11:37:00.588566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:37:00.588951) ========= script_repo_revision: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:37:00.589403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:37:00.589682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:37:00.599848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 11:37:00.600296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:00 INFO - MultiFileLogger online at 20160823 11:37:00 in /builds/slave/test 11:37:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:37:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:00 INFO - {'append_to_log': False, 11:37:00 INFO - 'base_work_dir': '/builds/slave/test', 11:37:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:37:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:00 INFO - 'branch': 'Fx-Team-Non-PGO', 11:37:00 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:00 INFO - 'config_files': ('talos/linux_config.py',), 11:37:00 INFO - 'default_actions': ('clobber', 11:37:00 INFO - 'read-buildbot-config', 11:37:00 INFO - 'download-and-extract', 11:37:00 INFO - 'populate-webroot', 11:37:00 INFO - 'create-virtualenv', 11:37:00 INFO - 'install', 11:37:00 INFO - 'run-tests'), 11:37:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:00 INFO - 'download_minidump_stackwalk': True, 11:37:00 INFO - 'download_symbols': 'ondemand', 11:37:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:00 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:00 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:00 INFO - 'installer_path': 'installer.exe', 11:37:00 INFO - 'log_level': 'info', 11:37:00 INFO - 'log_name': 'talos', 11:37:00 INFO - 'log_to_console': True, 11:37:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:00 INFO - 'opt_config_files': (), 11:37:00 INFO - 'pip_index': False, 11:37:00 INFO - 'sps_profile': False, 11:37:00 INFO - 'sps_profile_interval': 0, 11:37:00 INFO - 'suite': 'dromaeojs', 11:37:00 INFO - 'system_bits': '32', 11:37:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:00 INFO - 'title': 'talos-linux64-ix-005', 11:37:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:00 INFO - 'use_talos_json': True, 11:37:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:00 INFO - 'work_dir': 'build'} 11:37:00 INFO - [mozharness: 2016-08-23 18:37:00.808040Z] Running clobber step. 11:37:00 INFO - Running pre-action listener: _resource_record_pre_action 11:37:00 INFO - Running main action method: clobber 11:37:00 INFO - rmtree: /builds/slave/test/build 11:37:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:01 INFO - Running post-action listener: _resource_record_post_action 11:37:01 INFO - [mozharness: 2016-08-23 18:37:01.775041Z] Finished clobber step (success) 11:37:01 INFO - [mozharness: 2016-08-23 18:37:01.775141Z] Running read-buildbot-config step. 11:37:01 INFO - Running pre-action listener: _resource_record_pre_action 11:37:01 INFO - Running main action method: read_buildbot_config 11:37:01 INFO - Using buildbot properties: 11:37:01 INFO - { 11:37:01 INFO - "project": "", 11:37:01 INFO - "product": "firefox", 11:37:01 INFO - "script_repo_revision": "production", 11:37:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:37:01 INFO - "repository": "", 11:37:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:37:01 INFO - "buildid": "20160823080458", 11:37:01 INFO - "pgo_build": "False", 11:37:01 INFO - "basedir": "/builds/slave/test", 11:37:01 INFO - "buildnumber": 1880, 11:37:01 INFO - "slavename": "talos-linux64-ix-005", 11:37:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:37:01 INFO - "platform": "ubuntu64_hw", 11:37:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:37:01 INFO - "branch": "fx-team", 11:37:01 INFO - "repo_path": "integration/fx-team", 11:37:01 INFO - "revision": "8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2", 11:37:01 INFO - "stage_platform": "linux64", 11:37:01 INFO - "builduid": "a2b4d81c2c674d329bffc448498cd257", 11:37:01 INFO - "slavebuilddir": "test" 11:37:01 INFO - } 11:37:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:37:01 INFO - Running post-action listener: _resource_record_post_action 11:37:01 INFO - [mozharness: 2016-08-23 18:37:01.777596Z] Finished read-buildbot-config step (success) 11:37:01 INFO - [mozharness: 2016-08-23 18:37:01.777684Z] Running download-and-extract step. 11:37:01 INFO - Running pre-action listener: _resource_record_pre_action 11:37:01 INFO - Running main action method: download_and_extract 11:37:01 INFO - mkdir: /builds/slave/test/build/tests 11:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:01 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:37:01 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:37:02 INFO - Downloaded 1361 bytes. 11:37:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:37:02 INFO - Using the following test package requirements: 11:37:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:37:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:37:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'jsshell-linux-x86_64.zip'], 11:37:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:37:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:37:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:37:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:37:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:37:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:02 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:37:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:37:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:37:03 INFO - Downloaded 20324645 bytes. 11:37:03 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:37:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:07 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:37:07 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:37:08 INFO - Downloaded 20324645 bytes. 11:37:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:12 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:12 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:37:13 INFO - Downloaded 14413981 bytes. 11:37:13 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:14 INFO - trying https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:37:15 INFO - Downloaded 55740682 bytes. 11:37:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:15 INFO - mkdir: /builds/slave/test/properties 11:37:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:15 INFO - Contents: 11:37:15 INFO - build_url:https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:37:16 INFO - Running post-action listener: _resource_record_post_action 11:37:16 INFO - Running post-action listener: set_extra_try_arguments 11:37:16 INFO - [mozharness: 2016-08-23 18:37:16.182509Z] Finished download-and-extract step (success) 11:37:16 INFO - [mozharness: 2016-08-23 18:37:16.182734Z] Running populate-webroot step. 11:37:16 INFO - Running pre-action listener: _resource_record_pre_action 11:37:16 INFO - Running main action method: populate_webroot 11:37:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:16 INFO - '--tppagecycles', 11:37:16 INFO - '7'], 11:37:16 INFO - 'tests': ['tsvgm']}}, 11:37:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['damp', 'tps']}, 11:37:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'tests': ['damp', 'tps']}, 11:37:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['dromaeo_dom']}, 11:37:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['basic_compositor_video']}, 11:37:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:37:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['a11yr', 11:37:16 INFO - 'ts_paint', 11:37:16 INFO - 'tpaint', 11:37:16 INFO - 'sessionrestore', 11:37:16 INFO - 'sessionrestore_no_auto_restore', 11:37:16 INFO - 'tabpaint']}, 11:37:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['tsvgx', 11:37:16 INFO - 'tsvgr_opacity', 11:37:16 INFO - 'tart', 11:37:16 INFO - 'tscrollx', 11:37:16 INFO - 'cart']}, 11:37:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:16 INFO - 'tsvgr_opacity', 11:37:16 INFO - 'tart', 11:37:16 INFO - 'tscrollx', 11:37:16 INFO - 'cart']}, 11:37:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'talos_options': ['--disable-e10s'], 11:37:16 INFO - 'tests': ['tp5o']}, 11:37:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'tests': ['tp5o']}, 11:37:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'talos_options': ['--disable-e10s', 11:37:16 INFO - '--xperf_path', 11:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:16 INFO - 'tests': ['tp5n']}, 11:37:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:16 INFO - 'talos_options': ['--xperf_path', 11:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:16 INFO - 'tests': ['tp5n']}}, 11:37:16 INFO - 'talos.zip': {'path': '', 11:37:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:16 INFO - Running post-action listener: _resource_record_post_action 11:37:16 INFO - [mozharness: 2016-08-23 18:37:16.201633Z] Finished populate-webroot step (success) 11:37:16 INFO - [mozharness: 2016-08-23 18:37:16.201722Z] Running create-virtualenv step. 11:37:16 INFO - Running pre-action listener: _resource_record_pre_action 11:37:16 INFO - Running main action method: create_virtualenv 11:37:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:16 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 11:37:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:16 INFO - Using real prefix '/usr' 11:37:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:18 INFO - Installing pip.................done. 11:37:18 INFO - Return code: 0 11:37:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:18 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 11:37:18 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 11:37:18 INFO - Using env: {'DISPLAY': ':0', 11:37:18 INFO - 'HOME': '/home/cltbld', 11:37:18 INFO - 'LANG': 'en_US.UTF-8', 11:37:18 INFO - 'LANGUAGE': 'en_US:en', 11:37:18 INFO - 'LOGNAME': 'cltbld', 11:37:18 INFO - 'MAIL': '/var/mail/cltbld', 11:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:18 INFO - 'MOZ_NO_REMOTE': '1', 11:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:18 INFO - 'NO_EM_RESTART': '1', 11:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:18 INFO - 'PWD': '/builds/slave/test', 11:37:18 INFO - 'SHELL': '/bin/bash', 11:37:18 INFO - 'SHLVL': '1', 11:37:18 INFO - 'TERM': 'linux', 11:37:18 INFO - 'TMOUT': '86400', 11:37:18 INFO - 'USER': 'cltbld', 11:37:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:18 INFO - '_': '/tools/buildbot/bin/python'} 11:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:18 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 11:37:18 INFO - Cleaning up... 11:37:18 INFO - Return code: 0 11:37:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:18 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:37:19 INFO - Using env: {'DISPLAY': ':0', 11:37:19 INFO - 'HOME': '/home/cltbld', 11:37:19 INFO - 'LANG': 'en_US.UTF-8', 11:37:19 INFO - 'LANGUAGE': 'en_US:en', 11:37:19 INFO - 'LOGNAME': 'cltbld', 11:37:19 INFO - 'MAIL': '/var/mail/cltbld', 11:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:19 INFO - 'MOZ_NO_REMOTE': '1', 11:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:19 INFO - 'NO_EM_RESTART': '1', 11:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:19 INFO - 'PWD': '/builds/slave/test', 11:37:19 INFO - 'SHELL': '/bin/bash', 11:37:19 INFO - 'SHLVL': '1', 11:37:19 INFO - 'TERM': 'linux', 11:37:19 INFO - 'TMOUT': '86400', 11:37:19 INFO - 'USER': 'cltbld', 11:37:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:19 INFO - '_': '/tools/buildbot/bin/python'} 11:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:19 INFO - Downloading/unpacking psutil>=3.1.1 11:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:21 INFO - Installing collected packages: psutil 11:37:21 INFO - Running setup.py install for psutil 11:37:21 INFO - building 'psutil._psutil_linux' extension 11:37:21 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 11:37:21 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 11:37:21 INFO - building 'psutil._psutil_posix' extension 11:37:21 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 11:37:21 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 11:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:21 INFO - Successfully installed psutil 11:37:21 INFO - Cleaning up... 11:37:21 INFO - Return code: 0 11:37:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:21 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 11:37:21 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 11:37:21 INFO - Using env: {'DISPLAY': ':0', 11:37:21 INFO - 'HOME': '/home/cltbld', 11:37:21 INFO - 'LANG': 'en_US.UTF-8', 11:37:21 INFO - 'LANGUAGE': 'en_US:en', 11:37:21 INFO - 'LOGNAME': 'cltbld', 11:37:21 INFO - 'MAIL': '/var/mail/cltbld', 11:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:21 INFO - 'MOZ_NO_REMOTE': '1', 11:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:21 INFO - 'NO_EM_RESTART': '1', 11:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:21 INFO - 'PWD': '/builds/slave/test', 11:37:21 INFO - 'SHELL': '/bin/bash', 11:37:21 INFO - 'SHLVL': '1', 11:37:21 INFO - 'TERM': 'linux', 11:37:21 INFO - 'TMOUT': '86400', 11:37:21 INFO - 'USER': 'cltbld', 11:37:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:21 INFO - '_': '/tools/buildbot/bin/python'} 11:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:37:23 INFO - Installing collected packages: mozsystemmonitor 11:37:23 INFO - Running setup.py install for mozsystemmonitor 11:37:23 INFO - Successfully installed mozsystemmonitor 11:37:23 INFO - Cleaning up... 11:37:24 INFO - Return code: 0 11:37:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:37:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:24 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:24 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 11:37:24 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 11:37:24 INFO - Using env: {'DISPLAY': ':0', 11:37:24 INFO - 'HOME': '/home/cltbld', 11:37:24 INFO - 'LANG': 'en_US.UTF-8', 11:37:24 INFO - 'LANGUAGE': 'en_US:en', 11:37:24 INFO - 'LOGNAME': 'cltbld', 11:37:24 INFO - 'MAIL': '/var/mail/cltbld', 11:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:24 INFO - 'MOZ_NO_REMOTE': '1', 11:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:24 INFO - 'NO_EM_RESTART': '1', 11:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:24 INFO - 'PWD': '/builds/slave/test', 11:37:24 INFO - 'SHELL': '/bin/bash', 11:37:24 INFO - 'SHLVL': '1', 11:37:24 INFO - 'TERM': 'linux', 11:37:24 INFO - 'TMOUT': '86400', 11:37:24 INFO - 'USER': 'cltbld', 11:37:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:24 INFO - '_': '/tools/buildbot/bin/python'} 11:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:37:24 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 11:37:24 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 11:37:24 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 11:37:24 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 11:37:24 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 11:37:24 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 11:37:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:26 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:26 INFO - warning: no files found matching '*.txt' 11:37:26 INFO - no previously-included directories found matching 'build' 11:37:26 INFO - no previously-included directories found matching 'dist' 11:37:26 INFO - no previously-included directories found matching '.git*' 11:37:26 INFO - Installing collected packages: jsonschema, functools32 11:37:26 INFO - Running setup.py install for functools32 11:37:26 INFO - warning: no files found matching '*.txt' 11:37:26 INFO - no previously-included directories found matching 'build' 11:37:26 INFO - no previously-included directories found matching 'dist' 11:37:26 INFO - no previously-included directories found matching '.git*' 11:37:26 INFO - Successfully installed jsonschema functools32 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:26 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:37:26 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 functools32==3.2.3-2 11:37:26 INFO - Using env: {'DISPLAY': ':0', 11:37:26 INFO - 'HOME': '/home/cltbld', 11:37:26 INFO - 'LANG': 'en_US.UTF-8', 11:37:26 INFO - 'LANGUAGE': 'en_US:en', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MAIL': '/var/mail/cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SHLVL': '1', 11:37:26 INFO - 'TERM': 'linux', 11:37:26 INFO - 'TMOUT': '86400', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - '_': '/tools/buildbot/bin/python'} 11:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:26 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 11:37:26 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 11:37:26 INFO - Using env: {'DISPLAY': ':0', 11:37:26 INFO - 'HOME': '/home/cltbld', 11:37:26 INFO - 'LANG': 'en_US.UTF-8', 11:37:26 INFO - 'LANGUAGE': 'en_US:en', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MAIL': '/var/mail/cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SHLVL': '1', 11:37:26 INFO - 'TERM': 'linux', 11:37:26 INFO - 'TMOUT': '86400', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - '_': '/tools/buildbot/bin/python'} 11:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:29 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 11:37:29 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 11:37:29 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 11:37:29 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 11:37:29 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 11:37:29 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 11:37:29 INFO - Downloading docopt-0.6.1.tar.gz 11:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:29 INFO - Running setup.py install for blobuploader 11:37:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:29 INFO - Running setup.py install for requests 11:37:30 INFO - Running setup.py install for docopt 11:37:30 INFO - Successfully installed blobuploader requests docopt 11:37:30 INFO - Cleaning up... 11:37:30 INFO - Return code: 0 11:37:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:30 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:30 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 11:37:30 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 11:37:30 INFO - Using env: {'DISPLAY': ':0', 11:37:30 INFO - 'HOME': '/home/cltbld', 11:37:30 INFO - 'LANG': 'en_US.UTF-8', 11:37:30 INFO - 'LANGUAGE': 'en_US:en', 11:37:30 INFO - 'LOGNAME': 'cltbld', 11:37:30 INFO - 'MAIL': '/var/mail/cltbld', 11:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:30 INFO - 'MOZ_NO_REMOTE': '1', 11:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:30 INFO - 'NO_EM_RESTART': '1', 11:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:30 INFO - 'PWD': '/builds/slave/test', 11:37:30 INFO - 'SHELL': '/bin/bash', 11:37:30 INFO - 'SHLVL': '1', 11:37:30 INFO - 'TERM': 'linux', 11:37:30 INFO - 'TMOUT': '86400', 11:37:30 INFO - 'USER': 'cltbld', 11:37:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:30 INFO - '_': '/tools/buildbot/bin/python'} 11:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:30 INFO - Running setup.py (path:/tmp/pip-TINg3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 INFO - Running setup.py (path:/tmp/pip-zFTMdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 INFO - Running setup.py (path:/tmp/pip-3XLW58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 INFO - Running setup.py (path:/tmp/pip-riKOf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:30 INFO - Running setup.py (path:/tmp/pip-l7_J6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 INFO - Running setup.py (path:/tmp/pip-NAZ0Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 INFO - Running setup.py (path:/tmp/pip-xmPhX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:30 INFO - Running setup.py (path:/tmp/pip-GW5FLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:31 INFO - Running setup.py (path:/tmp/pip-gKYkQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:31 INFO - Running setup.py (path:/tmp/pip-iyVtNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:31 INFO - Running setup.py (path:/tmp/pip-A6PBDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:31 INFO - Running setup.py (path:/tmp/pip-Ja1sQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:31 INFO - Running setup.py (path:/tmp/pip-6bFYyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:31 INFO - Running setup.py (path:/tmp/pip-tQeopj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:31 INFO - Running setup.py (path:/tmp/pip-VRi0hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:31 INFO - Running setup.py (path:/tmp/pip-z5cjgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:31 INFO - Running setup.py (path:/tmp/pip-KAcDTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:31 INFO - Running setup.py install for manifestparser 11:37:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:31 INFO - Running setup.py install for mozcrash 11:37:31 INFO - Running setup.py install for mozdebug 11:37:32 INFO - Running setup.py install for mozdevice 11:37:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozfile 11:37:32 INFO - Running setup.py install for mozhttpd 11:37:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozinfo 11:37:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozInstall 11:37:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozleak 11:37:32 INFO - Running setup.py install for mozlog 11:37:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for moznetwork 11:37:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:32 INFO - Running setup.py install for mozprocess 11:37:32 INFO - Running setup.py install for mozprofile 11:37:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:33 INFO - Running setup.py install for mozrunner 11:37:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:33 INFO - Running setup.py install for mozscreenshot 11:37:33 INFO - Running setup.py install for moztest 11:37:33 INFO - Running setup.py install for mozversion 11:37:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:33 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 11:37:33 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 11:37:33 INFO - Using env: {'DISPLAY': ':0', 11:37:33 INFO - 'HOME': '/home/cltbld', 11:37:33 INFO - 'LANG': 'en_US.UTF-8', 11:37:33 INFO - 'LANGUAGE': 'en_US:en', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MAIL': '/var/mail/cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SHLVL': '1', 11:37:33 INFO - 'TERM': 'linux', 11:37:33 INFO - 'TMOUT': '86400', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - '_': '/tools/buildbot/bin/python'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:33 INFO - Running setup.py (path:/tmp/pip-kJhEU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:33 INFO - Running setup.py (path:/tmp/pip-TZGQzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:33 INFO - Running setup.py (path:/tmp/pip-QxabY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:33 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)) 11:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:33 INFO - Running setup.py (path:/tmp/pip-tUpNYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:34 INFO - Running setup.py (path:/tmp/pip-x5i3DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:34 INFO - Running setup.py (path:/tmp/pip-F4gHsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:34 INFO - Running setup.py (path:/tmp/pip-cO3JZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:34 INFO - Running setup.py (path:/tmp/pip-L74uTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:34 INFO - Running setup.py (path:/tmp/pip-O10QSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:34 INFO - Running setup.py (path:/tmp/pip-8V7ihl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:34 INFO - Running setup.py (path:/tmp/pip-s71pIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:34 INFO - Running setup.py (path:/tmp/pip-ROkyZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:34 INFO - Running setup.py (path:/tmp/pip-8CeyI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:34 INFO - Running setup.py (path:/tmp/pip-WSLO0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:34 INFO - Running setup.py (path:/tmp/pip-Otk950-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:34 INFO - Running setup.py (path:/tmp/pip-6sWLMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:34 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)) 11:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:34 INFO - Running setup.py (path:/tmp/pip-GH84Au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 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)) 11:37:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:34 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 11:37:36 INFO - Downloading blessings-1.6.tar.gz 11:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:36 INFO - Installing collected packages: blessings 11:37:36 INFO - Running setup.py install for blessings 11:37:37 INFO - Successfully installed blessings 11:37:37 INFO - Cleaning up... 11:37:37 INFO - Return code: 0 11:37:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:37 INFO - Reading from file tmpfile_stdout 11:37:37 INFO - Current package versions: 11:37:37 INFO - argparse == 1.2.1 11:37:37 INFO - blessings == 1.6 11:37:37 INFO - blobuploader == 1.2.4 11:37:37 INFO - docopt == 0.6.1 11:37:37 INFO - functools32 == 3.2.3-2 11:37:37 INFO - jsonschema == 2.5.1 11:37:37 INFO - manifestparser == 1.1 11:37:37 INFO - mozInstall == 1.12 11:37:37 INFO - mozcrash == 0.17 11:37:37 INFO - mozdebug == 0.1 11:37:37 INFO - mozdevice == 0.48 11:37:37 INFO - mozfile == 1.2 11:37:37 INFO - mozhttpd == 0.7 11:37:37 INFO - mozinfo == 0.9 11:37:37 INFO - mozleak == 0.1 11:37:37 INFO - mozlog == 3.3 11:37:37 INFO - moznetwork == 0.27 11:37:37 INFO - mozprocess == 0.23 11:37:37 INFO - mozprofile == 0.28 11:37:37 INFO - mozrunner == 6.12 11:37:37 INFO - mozscreenshot == 0.1 11:37:37 INFO - mozsystemmonitor == 0.3 11:37:37 INFO - moztest == 0.7 11:37:37 INFO - mozversion == 1.4 11:37:37 INFO - psutil == 3.1.1 11:37:37 INFO - requests == 1.2.3 11:37:37 INFO - wsgiref == 0.1.2 11:37:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:37 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 11:37:37 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 11:37:37 INFO - Using env: {'DISPLAY': ':0', 11:37:37 INFO - 'HOME': '/home/cltbld', 11:37:37 INFO - 'LANG': 'en_US.UTF-8', 11:37:37 INFO - 'LANGUAGE': 'en_US:en', 11:37:37 INFO - 'LOGNAME': 'cltbld', 11:37:37 INFO - 'MAIL': '/var/mail/cltbld', 11:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:37 INFO - 'MOZ_NO_REMOTE': '1', 11:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:37 INFO - 'NO_EM_RESTART': '1', 11:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:37 INFO - 'PWD': '/builds/slave/test', 11:37:37 INFO - 'SHELL': '/bin/bash', 11:37:37 INFO - 'SHLVL': '1', 11:37:37 INFO - 'TERM': 'linux', 11:37:37 INFO - 'TMOUT': '86400', 11:37:37 INFO - 'USER': 'cltbld', 11:37:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:37 INFO - '_': '/tools/buildbot/bin/python'} 11:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 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)) 11:37:37 INFO - Cleaning up... 11:37:37 INFO - Return code: 0 11:37:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 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 0x7fa3ee7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x266e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273d230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', '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 11:37:37 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 11:37:37 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 11:37:37 INFO - Using env: {'DISPLAY': ':0', 11:37:37 INFO - 'HOME': '/home/cltbld', 11:37:37 INFO - 'LANG': 'en_US.UTF-8', 11:37:37 INFO - 'LANGUAGE': 'en_US:en', 11:37:37 INFO - 'LOGNAME': 'cltbld', 11:37:37 INFO - 'MAIL': '/var/mail/cltbld', 11:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:37 INFO - 'MOZ_NO_REMOTE': '1', 11:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:37 INFO - 'NO_EM_RESTART': '1', 11:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:37 INFO - 'PWD': '/builds/slave/test', 11:37:37 INFO - 'SHELL': '/bin/bash', 11:37:37 INFO - 'SHLVL': '1', 11:37:37 INFO - 'TERM': 'linux', 11:37:37 INFO - 'TMOUT': '86400', 11:37:37 INFO - 'USER': 'cltbld', 11:37:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:37 INFO - '_': '/tools/buildbot/bin/python'} 11:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:37:37 INFO - Cleaning up... 11:37:37 INFO - Return code: 0 11:37:37 INFO - Running post-action listener: _resource_record_post_action 11:37:37 INFO - Running post-action listener: _start_resource_monitoring 11:37:37 INFO - Starting resource monitoring. 11:37:37 INFO - [mozharness: 2016-08-23 18:37:37.751311Z] Finished create-virtualenv step (success) 11:37:37 INFO - [mozharness: 2016-08-23 18:37:37.751861Z] Running install step. 11:37:37 INFO - Running pre-action listener: _resource_record_pre_action 11:37:37 INFO - Running main action method: install 11:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:37 INFO - Reading from file tmpfile_stdout 11:37:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:37:38 INFO - Reading from file tmpfile_stdout 11:37:38 INFO - Output received: 11:37:38 INFO - Usage: mozinstall [options] installer 11:37:38 INFO - Options: 11:37:38 INFO - -h, --help show this help message and exit 11:37:38 INFO - -d DEST, --destination=DEST 11:37:38 INFO - Directory to install application into. [default: 11:37:38 INFO - "/builds/slave/test"] 11:37:38 INFO - --app=APP Application being installed. [default: firefox] 11:37:38 INFO - mkdir: /builds/slave/test/build/application 11:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:37:54 INFO - Reading from file tmpfile_stdout 11:37:54 INFO - Output received: 11:37:54 INFO - /builds/slave/test/build/application/firefox/firefox 11:37:54 INFO - Running post-action listener: _resource_record_post_action 11:37:54 INFO - [mozharness: 2016-08-23 18:37:54.116216Z] Finished install step (success) 11:37:54 INFO - [mozharness: 2016-08-23 18:37:54.116463Z] Running run-tests step. 11:37:54 INFO - Running pre-action listener: _resource_record_pre_action 11:37:54 INFO - Running main action method: run_tests 11:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:54 INFO - Python 2.7.3 11:37:54 INFO - Return code: 0 11:37:54 INFO - grabbing minidump binary from tooltool 11:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:54 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 0x2737090>, '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 0x273a9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273ae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37:54 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 11:37:54 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 11:37:54 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 11:37:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:54 INFO - Return code: 0 11:37:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:37:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:37:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 11:37:54 INFO - Using env: {'DISPLAY': ':0', 11:37:54 INFO - 'HOME': '/home/cltbld', 11:37:54 INFO - 'LANG': 'en_US.UTF-8', 11:37:54 INFO - 'LANGUAGE': 'en_US:en', 11:37:54 INFO - 'LOGNAME': 'cltbld', 11:37:54 INFO - 'MAIL': '/var/mail/cltbld', 11:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:54 INFO - 'MOZ_NO_REMOTE': '1', 11:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:54 INFO - 'NO_EM_RESTART': '1', 11:37:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:54 INFO - 'PWD': '/builds/slave/test', 11:37:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:54 INFO - 'SHELL': '/bin/bash', 11:37:54 INFO - 'SHLVL': '1', 11:37:54 INFO - 'TERM': 'linux', 11:37:54 INFO - 'TMOUT': '86400', 11:37:54 INFO - 'USER': 'cltbld', 11:37:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254', 11:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:54 INFO - '_': '/tools/buildbot/bin/python'} 11:37:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:37:54 INFO - mozversion application_buildid: 20160823080458 11:37:54 INFO - mozversion application_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 11:37:54 INFO - mozversion application_display_name: Nightly 11:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:54 INFO - mozversion application_name: Firefox 11:37:54 INFO - mozversion application_remotingname: firefox 11:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:37:54 INFO - mozversion application_vendor: Mozilla 11:37:54 INFO - mozversion application_version: 51.0a1 11:37:54 INFO - mozversion platform_buildid: 20160823080458 11:37:54 INFO - mozversion platform_changeset: 8381bc7a46811aa0de0d984cdb6f1cc5ce4c52c2 11:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:37:54 INFO - mozversion platform_version: 51.0a1 11:37:54 INFO - using testdate: 1471977474 11:37:54 INFO - actual date: 1471977474 11:37:54 INFO - starting webserver on 'localhost:57358' 11:37:54 INFO - SUITE-START | Running 2 tests 11:37:54 INFO - TEST-START | dromaeo_css 11:37:54 INFO - operating with platform_type : linux_ 11:37:54 INFO - Initialising browser for dromaeo_css test... 11:37:54 INFO - TEST-INFO | started process 13275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpETHtTf/profile http://localhost:57358/getInfo.html) 11:37:58 INFO - PROCESS | 13275 | __metrics Screen width/height:1600/1200 11:37:58 INFO - PROCESS | 13275 | colorDepth:24 11:37:58 INFO - PROCESS | 13275 | Browser inner width/height: 1024/697 11:37:58 INFO - PROCESS | 13275 | __metrics 11:37:59 INFO - PROCESS | 13275 | 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" 11:37:59 INFO - PROCESS | 13275 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:59 INFO - PROCESS | 13275 | console.error: PushService: 11:37:59 INFO - PROCESS | 13275 | stateChangeProcessEnqueue: Error transitioning state 11:37:59 INFO - PROCESS | 13275 | UnknownError 11:38:00 INFO - TEST-INFO | 13275: exit 0 11:38:00 INFO - Browser initialized. 11:38:00 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:00 INFO - TEST-INFO | started process 13356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpETHtTf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:12 INFO - PROCESS | 13356 | RSS: Main: 182960128 11:38:12 INFO - PROCESS | 13356 | 11:39:04 INFO - PROCESS | 13356 | 1471977544352 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] 11:41:16 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57358/tests/dromaeo/cssquery-ext.html) 11:41:18 INFO - PROCESS | 13356 | RSS: Main: 307601408 11:41:18 INFO - PROCESS | 13356 | 11:44:20 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-ext.html (next: http://localhost:57358/tests/dromaeo/cssquery-jquery.html) 11:44:21 INFO - PROCESS | 13356 | RSS: Main: 279408640 11:44:21 INFO - PROCESS | 13356 | 11:47:24 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57358/tests/dromaeo/cssquery-mootools.html) 11:47:24 INFO - PROCESS | 13356 | RSS: Main: 217796608 11:47:24 INFO - PROCESS | 13356 | 11:50:26 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57358/tests/dromaeo/cssquery-prototype.html) 11:50:27 INFO - PROCESS | 13356 | RSS: Main: 262340608 11:50:27 INFO - PROCESS | 13356 | 11:53:30 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57358/tests/dromaeo/cssquery-yui.html) 11:53:31 INFO - PROCESS | 13356 | RSS: Main: 219332608 11:53:31 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | Cycle 1(1): loaded http://localhost:57358/tests/dromaeo/cssquery-yui.html (next: http://localhost:57358/tests/dromaeo/cssquery-dojo.html) 11:56:34 INFO - PROCESS | 13356 | RSS: Main: 306274304 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | __start_tp_report 11:56:34 INFO - PROCESS | 13356 | _x_x_mozilla_page_load 11:56:34 INFO - PROCESS | 13356 | _x_x_mozilla_page_load_details 11:56:34 INFO - PROCESS | 13356 | |i|pagename|runs| 11:56:34 INFO - PROCESS | 13356 | |0;dojo.html;2539.746025397459;2565.371483986423;2571.3314538220056;2596.28602134413;2601.5967525033616;4600.551787332794;4608.308753686949;4643.837465688702;4693.460252071013;4740.4548476925165;4610.769461526918;4663.790129444174;4670.836520721776;4671.836485723001;4747.311639812225;4304.24675681756;4311.116221174651;4313.935290970638;4329.134173165364;4481.596656300932;4425.66807489438;4430.379746835446;4431.534688857671;4433.977830110861;4460.821567137311;4196.916061678749;4247.256730072225;4252.617264446184;4289.613934745857;4290.227759003378;4271.316589345721;4296.5273819879785;4305.483341998949;4312.504062032875;4313.137372525476;4241.406203131564;4258.829646814123;4263.0834370610155;4277.272863613193;4353.608175264209;4669.229577119771;4696.107739529479;4699.459562150328;4712.622990160813;4729.527047295277;4872.074305881906;4897.04507621014;4991.351124353847;5001.499850015006;5051.292819005343;4956.826511072131;4972.577330926875;4985.277134815467;4988.426330971948;5037.924431133536;4641.396618439581;4645.094206629675;4652.604528615038;4665.883352916137;4696.436427628706;4980.5019498049905;5041.168207245837;5086.745662716849;5096;5106.617003724736;4814.229723244334;4819.6867203631655;4830.227163653799;4885.340479035285;4889.2910527973245;4881.974785295057;4894.19245824435;4901.264810278487;4925.21196608541;4961.305417241589;4792.856214313576;4865.9026819463415;4875.219964805614;4884.579778815255;4941.777620007108;4873.244647079709;4916.754162291871;4924.162892308316;4982.60139188864;4984.053029924376;4159.500859896832;4163.83344666216;4165.75005499671;4202.243596152722;4216.051388437577;3635.9818200908826;3652.671259586597;3662;3663.8351274192723;3724.925501489955;4304.268274393298;4331.436913201263;4338.023944612437;4344.370066340426;4346.587074227943;5033.496650334937;5036.093503169464;5038.193888977746;5061.266116413173;5090.516400941905;4359.26380856241;4365.323374876835;4370.737755734666;4420.270655341897;4427.955720442818;4329.935050974238;4386.210482113251;4417.977910110429;4455.2648812946145;4462.866114016585;4695.990362072171;4702.0360826031265;4706.0823139487475;4744.312074749073;4762.16662084127;4934.432540257916;4983.925241121314;4989.027139707868;4994.9750251248515;5035.622328325464;4621.722696638212;4693.131770622445;4708.152532544175;4719.126961511994;4766.904661906673;4917.6311776616185;4940.036692845005;4943.406791185081;4980.153373926513;4999.700017998932;5016.172331565251;5017.799288028438;5024.547790698854;5025.748712564284;5080.364954380702;4743.146233677971;4746.976265118652;4765.76171191446;4884.12085824555;4957.776900039435;4798.47216806158;4810.254410566367;4824.49342818999;4863.4650188479945;4869.220924652039;4754.7384893829785;4756.7383793890285;4757.952420475751;4758.738269395078;4803.759812009315;4749.976250118727;4839.975800120977;4851.975740121276;4881;4884.340614017062;4809.44691360484;4824.903501930012;4827.710337379768;4861.805527778849;4887.462379138363 11:56:34 INFO - PROCESS | 13356 | |1;ext.html;563.6308218117133;570.7602806821135;574.8074395077649;578.4158000419575;583.0263460021763;28327.858360708193;31402.842985785068;38428;39530.40704389437;39658.40512392316;39897.60102398975;40331;40346;40436.393454098215;40486.59513404865;7660.5403675779635;7809.804754881116;7812.726554570591;7812.968628156692;7816.843663126734;7346.412287017052;7472.439567032494;7531.6610752516;7535.585542795144;7713.190115037924;9797.84447421566;10086.344387614818;10086.546105425237;10366.222533309994;10372.533236004398;9890.505474726271;9962.501874906226;9964.950175249078;9985.550650220757;9988.1510071644;9894.406335619886;9965.053319934595;9966.20270378368;9970.202383809277;9971.90028099717;38356.424653630216;38559.614403855885;38668.41997370042;38675.41986870199;38682.22635547273;2740.7670348020442;2747.3406382468065;2851.2871782054485;3274.96725032749;3393.694567488913;28561.428771424456;29383.412331753458;29390.41219175626;29991.400171996655;30751.692483075105;3312.850921708529;3370.9325813483592;3385.743608138554;3446.483027545888;3459.7924124552605;242306;242959;243415;244090;244330;52526.737366312926;52985.735071325165;52991;53066.7346663272;53170.468295316554;32021.199470013435;33099.50350744741;33240.83379583135;35265.64734352624;35318.644728750725;14231.501897433747;14479.466093433606;14486.420543178365;14492.550744925424;14496.420143194366;10966.670999870017;11223.551057957753;11224.607138750105;11229.38238396896;11235.438228088562;15709.921450392903;17498.475045748648;17781.7332740009;17888.463346099637;17993.64012719738;6683.832904177434;6750.5274630775375;6843.965780171067;6901.792946211622;6967.756128535579;745.3329270303157;814.8411059843273;922.8938672052666;949.9715008549755;978.295627148452;26807.463850722877;28137.27744399243;28661.426771464456;28724.42551149007;28752.424951500852;894.5259012723267;971.3491960386558;1070.7537266428765;1074.4412905289362;1077.138289368502;14113;14929.477468288775;15235.542933712006;15253.771193432107;15345.769813452807;383701;384625;385242;386810;387435;48629;49141.75429122832;49273.50726492761;49310.75344623254;49353.259701104515;1156.5951916829042;1199.9040076793835;1203.6750077479032;1204.0367705835297;1207.2273744803508;26202.86898565495;27179.59230611582;27508;27894.86052569724;28130;43077;43383.34924976191;43418.565814341455;43432.131357373306;43488.56511434845;304635;304991;305529;305861;306174;22503.88748056249;24308.270751877473;25092.498150037263;25629.743702562737;26030.479390412464;41403;41552.79223603863;42512.78743606386;42694.57305426906;42703.5729642712;34213.65786342204;35606.71568308929;36595;37087.44368834416;37218.62781372152;35799.82100089483;35841.82079089588;35970.28059438744;36280.63719362878;36283.45574816327;34602.96191114271;35098.82450587833;35301.29397411986;35606.821965890005;36006.45990310095;30330.69669303367;32675.183120422178;33115;33367.33265334631;33427.164320892174;24549.63175552404;25483.745162548137;25675.614865776653;25852.095176668725;26133.60799588046 11:56:34 INFO - PROCESS | 13356 | |2;jquery.html;360.861068488632;368.682932677897;372.8117300763115;384.0628865568016;385.8572328238552;16180.757288640665;17791.466256012307;18174.365536788133;18311.54221144472;18386.448406547825;14962.775558366633;15415.69168616627;15551.144687042208;15569.84430155701;15614.921925390385;4888.242322440027;5091.159958606825;5120.231965205212;5121.615878809085;5124.846254612367;3768.208676178006;3837.1750073734142;3905.1051526793176;4968.3292755477905;5049.4698056704065;5435.347758269013;5947.732352044169;5949.196858424122;5954.880902381949;5955.9702201488935;5743.5118014968775;5938.613990090652;5968.31364393096;5972.492338151263;6165.445109940127;5438.048341540215;5440.102383106782;5444.809431669913;5445.891082178374;5450.291462109901;20966.685499717518;20996.895015524824;21017.369478915658;21061.578768424544;21265.574688506298;1846.3722334406232;1850.0842083168918;1912.4549503391606;1949.2008276606523;2574.84550926945;13111.147775394664;13496.325183740872;13497.392617332243;13674.863251367458;13991.65020874476;1691.560194349478;1750.0724615953438;1771.7342398640178;1824.4161868202182;1850.8056654051265;66624.33375666279;69433;69459;70737;71092.6445367775;9492.667756628485;9685.951570242245;9871.40771553709;10007.732023046447;10071.194304455626;13877.722445551033;13900.304984750723;13911.234882081582;13911.86088139126;13917.164970101827;7039.753608623673;7164.856702866018;7204.17152027513;7435.665395057235;7436.516626419266;6759.188897332351;6761.18865736105;7000.299970002959;7002.964985175144;7008.088948436773;6147.200863887755;6281.183446151971;6284.842878927972;6300.857708379173;6449.838754031093;1753.1672455583496;1754.824517548235;1773.9911300443416;1792.050213386907;1830.2313028528051;836.8033512124646;853.2747164909777;856.7643897927995;892.1435421994958;909.231699214163;17183.65632687339;17310.480685579452;18038.909805451152;18256.543586410447;18319.450416487525;851.45932332969;880.9119088091268;884.3234925282164;917.5091326140483;931.5388882503204;9375.39059961114;10083.848742268872;10267.74330641725;10277.229207809443;10327.638532651321;371293;377604;400200;402627;402806;45752;63063.32430081315;64071.359286407474;69912;70641.99086155366;829.4732844643574;850.3452341696859;885.8272636835756;888.0542222532981;917.4678686361895;11682.88317116818;14367.568972930829;15908.920455397649;16530.338786448407;16895.155242237593;36211.2062070078;37627.623723762415;38424.23151536898;40458.190836182526;41590.792046039576;51891.740541297055;51938;52316.19800093297;52648;53187.4681253198;7226.530275532074;7495;7583.203763604963;7810;7983.560904150328;9801.558929848317;11807;11881.82177267359;12070.27578345302;12357.629271121881;9993.400395976265;10374.27380083387;10378.377297362182;10594.364338139736;10791.460426978776;4645.372874661877;7240.710371585288;10026.248031397528;10045.547950342398;10323.174146068446;10465.424401657981;10548.736281592715;10631.840522392326;10649.361038337725;11080.778384432106;7365.042544469399;7534.585597792174;7606.923930760621;7857.057153141431;8081.919180808117;9219.44683319003;10287.331323463952;10348.741281467723;10449.738756531147;10470.947645261725 11:56:34 INFO - PROCESS | 13356 | |3;mootools.html;1342.523404191512;1354.7425989062078;1403.2352367959468;1603.286537490817;1639.0329705473775;7118.679659415326;7732.342750866176;7735.883961740578;7741;7748.225177482249;6622.337766223375;7300.306470885257;7526.134494533117;7531.9623401883055;7599.696012159521;2116.0689296709475;2163.8809865457392;2164.145162660748;2166.3825809644254;2167.3822960456273;2127.4894025433864;2145.9248926287582;2160.686700428445;2160.7299087614047;2164.0478189596606;2113.3342996955985;2131.435169680028;2132.4775430019668;2142.7428708554994;2144.9034793434334;2066.9896650516725;2068.596623658387;2068.7724350321378;2071.0369678099605;2079.812816846476;2084.405944305881;2152.0638522242875;2154.569086182754;2155.838312126597;2156.202205184092;7600.239976002411;7708.03649543807;7724.922750772476;7755;7760.534367937886;4264.445622069111;4368.104538569585;4377.824887004516;4379.167958087953;4388.078503514266;2652.7612514873754;2705.147878418292;2791.2184588315304;2797.510435673749;2803.243124356433;836.4437648963432;863.2834747159905;865.485036403339;881.1496905486237;885.7209978856639;10292.433916134609;10329.741756456073;10345.275830691855;10377.740556486073;10378.377297362182;3811.5706610021243;3953.2093581283857;4086.67306615476;4096.037431203665;4097.467329247179;8788.736337909873;8788.824223515494;8791.736247912573;8793.384463087523;8794.780130496789;4428.955710442854;4443.33349997503;4445.82216711328;4449.976505403775;4459.2865141577195;3457.3776720190103;3871.8064096795047;4056.553779084298;4068.4710987571425;4079.102597428561;3481.268933523938;3546.6985306248744;3642.4172132459207;3653.8173091345857;3660.9450858237146;1117.7987962166887;1125.4429057616533;1136.2727854173336;1150.6433005768238;1151.3955173533961;709.8260926073145;789.6880732110784;813.2233716800441;814.267159556404;819.1276290750332;4997.9500204997485;5077.898442031139;5182.093133701587;5314.468553144732;5401.567874570103;353.3163328958474;353.85668804134366;357.5048557747538;365.5029160341933;368.85614610302;3504.684578387957;3563.8752643657867;3573.6426357364057;3631.3463576555946;3678.3746763050344;9096.590653420611;9286.396384235004;9364.110409511086;9366.203872670763;9366.391184572982;9304.16262536375;9311.348205625676;9316.347855650174;9322.067793220624;9323.72028839136;6955.130608673916;7043.471739619549;7075.433965282765;7141.678624461912;7144.785656430419;4958.057968985881;4986.202207646759;5000.849974500771;5086.593072554261;5101.081805274937;8371.204735550113;8450.746477605682;8519.531425771642;8534.957325213334;8760.386772925835;8743;8752.256058235122;8949.149830766068;9057.954710226406;9069.501177435304;5727.1695604138;5877.764889404376;6368.713407896748;6509.479241660751;6527.314631963575;7166.426685865223;7402.29678180572;7430.96284518574;7436.962815186106;7437.702491900263;6291.905621415591;6421.068945002855;6473.967630161819;6501.837454063686;6655.73377064912;6052.061930400795;6055.6063855849225;6080;6087.969560152171;6194;6032.065029920369;6175.69121543912;6177.1969643945995;6182.227221597301;6184.165137706352;4242.321228603409;4286.292761694285;4321.719088259253;4371.519132895315;4481;4304.849330273425;4307.483102027777;4398.362237475612;4434.933475997798;4523.457185137804 11:56:34 INFO - PROCESS | 13356 | |4;prototype.html;279.6979262396612;293.62855987176226;294.3480191376102;295.55961617190366;300.72333453223035;4576.244919588264;4727.409073865767;4732.810687572497;4766.61867050636;4784.282357646351;4546.227141385964;4711;4713.363695901053;4737.928931066028;4741.90516189676;3741.158239396141;3752.868649597251;3762.3980163173896;3765.548134223897;3767.792771397572;3591.7844929304197;3764.1718821859286;3767.6420740029653;3769.246150769843;3777.1690228149764;3480.6519348065244;3727.869524566641;3742.644448777362;3744.1014156602355;3773.320872211867;3712.6658600726064;3714.2014466889477;3714.8699795507027;3717.5910649828766;3766.472693822867;3293.8682452701864;3294.1435226840954;3302.207470207157;3304.653011433813;3304.867805287786;4549.294859296814;4586.1286355592665;4610.76946152691;4640.396748422683;4660.603848672867;4227.767472788995;4232.11125663611;4232.666709986344;4248.702590818644;4248.723832950879;4932.506749325074;4961.280614310905;4969.26075873445;4969.35398398206;4996.551000209971;3446.7414943879057;3590.299891521154;3602.6937710294656;3608.4226523756333;3628.4738712886483;5128.102582048126;5183.896322073538;5185.222216667492;5189.896202075937;5196.272521846907;3662.1760103976394;3663.9557726047947;3668.834902429397;3670.724695647837;3671.1372827385544;3720.051386896378;3730.477733117366;3740.8690695825517;3747.950573839275;3753.887383378503;3930.3711406174875;4135.1316223593385;4144.274751918402;4240.660747140221;4247.936280955788;4960.826371076995;4968.751562421864;4985.601151907838;5005.824796132118;5020.820107274788;1208.1844754790482;1222.7493363860387;1273.3442277227236;1282.993585032069;1287.1569122224957;847.639753104928;858;871.2986046232717;871.6818361298207;872.3021582733787;4438.312061630452;4440.800163992628;4444.28891377378;4455.398521199597;4458.286674132123;5102.872428189251;5109.718965456936;5116.718580478035;5119.436861945183;5131.56381707559;4257.8509752158525;4450.332450132441;4481.75350355727;4500.842470513517;4534.59188673021;2724.645796046541;2752.651200911579;2752.944941101167;2754.394033312668;2758.917232483029;4907.852764417074;4910.950890491121;4923.606111511071;4926.852194434173;4935.457099719028;5155.149400348901;5221.269022336875;5265.578753699695;5277.8416647500635;5285.656432331886;4852.611791056707;4865.70805751656;4865.95134048655;4876.341693871353;4879.56083952446;5046.066477701637;5139.997700448376;5147.305113809588;5152.124138896322;5181.932183236292;4982.975085124551;5058.013687330935;5093;5113.488651135006;5130.101492656786;4907.288443175791;4910.189818680021;4910.877228069184;4911.361523001987;4953.504649535018;3639.1811842335264;3645.2527231917925;3647.4711166881184;3647.6717095460476;3654.1778099928365;5048.242763585492;5146;5176;5185.703574106474;5190.455002224863;5047.318611987334;5049.2173713074535;5055.241713742968;5059.316992206005;5071.4421413645205;4936.43231028422;4989.326440930573;4992.975035124801;5002.299678045004;5076.390833100052;4701.976490117664;4769.546893045155;4828.76866399066;4907.975460122677;4991.3511243538105;5023.34696489454;5043.722595257296;5063.443021267584;5064.924026139684;5076.18780995039;4944.728039957837;4949.901001980013;4960.842033715346;4960.8759781005765;4963.875903102451 11:56:34 INFO - PROCESS | 13356 | |5;yui.html;601.9488343490804;632.1592282264588;662.9602223866567;671.1442910289377;703.7677566403088;12503.937480312587;12807.935960320197;13400.128991615538;13404.66488337792;13482.595522134327;12972.545960891372;13192.340382980836;13249.271290079067;13260.071794974356;13265.1377660452;616.9352218017111;747.9252074792531;767.6277005652254;771.3327971304809;771.3867475357105;712.700665720396;736.988945165823;739.4121673269764;747.1930315259507;749.4791120171483;785.4541093939714;787.5117427195147;787.7242964962275;787.7951732549521;788.1802924958065;628.3653509954933;788.0543347982444;789.5460110436493;791.0467886197176;791.3273717340244;563.5294529068233;575.0569066730566;577.4514211499051;581.3198557687474;581.5522048023041;11846.940765296118;11855.05159587231;11967.102467314986;11986.940065299705;11991.400429978466;12011.759764804743;12533.857558096319;12624.873751262461;12831.87168128316;13348.065635405526;11322.377269250188;11619.6514104577;11669.416529173592;11695.239809412362;12112.576059837951;3949.4865667463046;4007.779572123532;4035.1929614077303;4137.089840235143;4138.151678905847;65781.67109164472;66870.66564667145;66916.66541667261;67784;68218.3178168217;9178.19979059258;9475.857862132074;9626.807463850684;9920.553575089138;9951.15415189717;17830.19764110618;18129.54676133081;18164.63670726578;18182.363587276945;18194.545136371697;6751.493637977172;6760.594364338155;6789.558678685869;7067.964660176769;7075.292470752884;3655.3968595182027;3665.780053196817;3670.155864151207;3706.3328600852105;3861.768293902375;2688.153231731998;2820.294926268433;2823.745862872351;2833.4049849531416;2835.17779843843;469.1765950756469;473.7962676049332;475.4935993167266;482.6814302560364;487.57093757493885;404.641891925642;434.0970780775978;438.2002844808174;439.2401146017408;441.2124358020917;6892.414144797648;7252;7252.927470725331;7369.668364923591;7869.213078692085;452.8913060865369;474.6487599176584;474.89789695215006;485.0250995499072;494.97030178189425;3282.8030318180986;3347.7656564040285;3430.2967891582166;3549.8580056797437;3562.7684200526883;101747;105739;107541;109277;110439.44780276208;90435.54782226047;91024.54487727518;91266.54366728124;91351;91811.54094229486;79415;80282;81250.59374703089;81729.59135204286;82110;6752.257251702211;6799.694013769294;6831.111955445959;6923.273056329013;7181.964090179516;47002.52997469981;47462;47890.52109479;48905;49005;67546;69209.65395172992;70484.64757676178;70865.64567177132;72910.63544682243;8469.5341756204;8651.653933842575;8674.869876951978;8688.739337819876;8870.73387798367;9540.809183816145;9574.47340396285;9843.60625574969;9888.110070093726;9892.604295828087;7684.961575192312;7896.921030789618;7969.123396426273;8329;9138.588763505526;7540.585267810104;9467.195288400288;9472.57373418184;10074;10124.291299608956;10358.274920755475;10497.2127090467;10669.199810014125;10795.784084318428;10847.891521084688;8249.79375515593;8542.316614670935;9317.254619630548;9730.41617502952;9864.408135511892;8065.274125328749;8312.70905518328;8939.463632182089;8991.955040224757;9518.571664275263 11:56:34 INFO - PROCESS | 13356 | __end_tp_report 11:56:34 INFO - PROCESS | 13356 | __start_cc_report 11:56:34 INFO - PROCESS | 13356 | _x_x_mozilla_cycle_collect,1162 11:56:34 INFO - PROCESS | 13356 | __end_cc_report 11:56:34 INFO - PROCESS | 13356 | __startTimestamp1471978594727__endTimestamp 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | ------- Summary: start ------- 11:56:34 INFO - PROCESS | 13356 | Number of tests: 6 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#0] dojo.html Cycles:165 Average:4606.18 Median:4744.31 stddev:479.89 (10.1%) stddev-sans-first:453.15 11:56:34 INFO - PROCESS | 13356 | Values: 2539.7 2565.4 2571.3 2596.3 2601.6 4600.6 4608.3 4643.8 4693.5 4740.5 4610.8 4663.8 4670.8 4671.8 4747.3 4304.2 4311.1 4313.9 4329.1 4481.6 4425.7 4430.4 4431.5 4434.0 4460.8 4196.9 4247.3 4252.6 4289.6 4290.2 4271.3 4296.5 4305.5 4312.5 4313.1 4241.4 4258.8 4263.1 4277.3 4353.6 4669.2 4696.1 4699.5 4712.6 4729.5 4872.1 4897.0 4991.4 5001.5 5051.3 4956.8 4972.6 4985.3 4988.4 5037.9 4641.4 4645.1 4652.6 4665.9 4696.4 4980.5 5041.2 5086.7 5096.0 5106.6 4814.2 4819.7 4830.2 4885.3 4889.3 4882.0 4894.2 4901.3 4925.2 4961.3 4792.9 4865.9 4875.2 4884.6 4941.8 4873.2 4916.8 4924.2 4982.6 4984.1 4159.5 4163.8 4165.8 4202.2 4216.1 3636.0 3652.7 3662.0 3663.8 3724.9 4304.3 4331.4 4338.0 4344.4 4346.6 5033.5 5036.1 5038.2 5061.3 5090.5 4359.3 4365.3 4370.7 4420.3 4428.0 4329.9 4386.2 4418.0 4455.3 4462.9 4696.0 4702.0 4706.1 4744.3 4762.2 4934.4 4983.9 4989.0 4995.0 5035.6 4621.7 4693.1 4708.2 4719.1 4766.9 4917.6 4940.0 4943.4 4980.2 4999.7 5016.2 5017.8 5024.5 5025.7 5080.4 4743.1 4747.0 4765.8 4884.1 4957.8 4798.5 4810.3 4824.5 4863.5 4869.2 4754.7 4756.7 4758.0 4758.7 4803.8 4750.0 4840.0 4852.0 4881.0 4884.3 4809.4 4824.9 4827.7 4861.8 4887.5 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#1] ext.html Cycles:180 Average:46276.59 Median:35283.47 stddev:83311.79 (236.1%) stddev-sans-first:83474.80 11:56:34 INFO - PROCESS | 13356 | Values: 563.6 570.8 574.8 578.4 583.0 28327.9 31402.8 38428.0 39530.4 39658.4 39897.6 40331.0 40346.0 40436.4 40486.6 7660.5 7809.8 7812.7 7813.0 7816.8 7346.4 7472.4 7531.7 7535.6 7713.2 9797.8 10086.3 10086.5 10366.2 10372.5 9890.5 9962.5 9965.0 9985.6 9988.2 9894.4 9965.1 9966.2 9970.2 9971.9 38356.4 38559.6 38668.4 38675.4 38682.2 2740.8 2747.3 2851.3 3275.0 3393.7 28561.4 29383.4 29390.4 29991.4 30751.7 3312.9 3370.9 3385.7 3446.5 3459.8 242306.0 242959.0 243415.0 244090.0 244330.0 52526.7 52985.7 52991.0 53066.7 53170.5 32021.2 33099.5 33240.8 35265.6 35318.6 14231.5 14479.5 14486.4 14492.6 14496.4 10966.7 11223.6 11224.6 11229.4 11235.4 15709.9 17498.5 17781.7 17888.5 17993.6 6683.8 6750.5 6844.0 6901.8 6967.8 745.3 814.8 922.9 950.0 978.3 26807.5 28137.3 28661.4 28724.4 28752.4 894.5 971.3 1070.8 1074.4 1077.1 14113.0 14929.5 15235.5 15253.8 15345.8 383701.0 384625.0 385242.0 386810.0 387435.0 48629.0 49141.8 49273.5 49310.8 49353.3 1156.6 1199.9 1203.7 1204.0 1207.2 26202.9 27179.6 27508.0 27894.9 28130.0 43077.0 43383.3 43418.6 43432.1 43488.6 304635.0 304991.0 305529.0 305861.0 306174.0 22503.9 24308.3 25092.5 25629.7 26030.5 41403.0 41552.8 42512.8 42694.6 42703.6 34213.7 35606.7 36595.0 37087.4 37218.6 35799.8 35841.8 35970.3 36280.6 36283.5 34603.0 35098.8 35301.3 35606.8 36006.5 30330.7 32675.2 33115.0 33367.3 33427.2 24549.6 25483.7 25675.6 25852.1 26133.6 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#2] jquery.html Cycles:180 Average:24197.41 Median:402716.50 stddev:64315.65 (16.0%) stddev-sans-first:64471.17 11:56:34 INFO - PROCESS | 13356 | Values: 360.9 368.7 372.8 384.1 385.9 16180.8 17791.5 18174.4 18311.5 18386.4 14962.8 15415.7 15551.1 15569.8 15614.9 4888.2 5091.2 5120.2 5121.6 5124.8 3768.2 3837.2 3905.1 4968.3 5049.5 5435.3 5947.7 5949.2 5954.9 5956.0 5743.5 5938.6 5968.3 5972.5 6165.4 5438.0 5440.1 5444.8 5445.9 5450.3 20966.7 20996.9 21017.4 21061.6 21265.6 1846.4 1850.1 1912.5 1949.2 2574.8 13111.1 13496.3 13497.4 13674.9 13991.7 1691.6 1750.1 1771.7 1824.4 1850.8 66624.3 69433.0 69459.0 70737.0 71092.6 9492.7 9686.0 9871.4 10007.7 10071.2 13877.7 13900.3 13911.2 13911.9 13917.2 7039.8 7164.9 7204.2 7435.7 7436.5 6759.2 6761.2 7000.3 7003.0 7008.1 6147.2 6281.2 6284.8 6300.9 6449.8 1753.2 1754.8 1774.0 1792.1 1830.2 836.8 853.3 856.8 892.1 909.2 17183.7 17310.5 18038.9 18256.5 18319.5 851.5 880.9 884.3 917.5 931.5 9375.4 10083.8 10267.7 10277.2 10327.6 371293.0 377604.0 400200.0 402627.0 402806.0 45752.0 63063.3 64071.4 69912.0 70642.0 829.5 850.3 885.8 888.1 917.5 11682.9 14367.6 15908.9 16530.3 16895.2 36211.2 37627.6 38424.2 40458.2 41590.8 51891.7 51938.0 52316.2 52648.0 53187.5 7226.5 7495.0 7583.2 7810.0 7983.6 9801.6 11807.0 11881.8 12070.3 12357.6 9993.4 10374.3 10378.4 10594.4 10791.5 4645.4 7240.7 10026.2 10045.5 10323.2 10465.4 10548.7 10631.8 10649.4 11080.8 7365.0 7534.6 7606.9 7857.1 8081.9 9219.4 10287.3 10348.7 10449.7 10470.9 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#3] mootools.html Cycles:180 Average:4946.52 Median:4972.13 stddev:2804.15 (56.4%) stddev-sans-first:2798.93 11:56:34 INFO - PROCESS | 13356 | Values: 1342.5 1354.7 1403.2 1603.3 1639.0 7118.7 7732.3 7735.9 7741.0 7748.2 6622.3 7300.3 7526.1 7532.0 7599.7 2116.1 2163.9 2164.1 2166.4 2167.4 2127.5 2145.9 2160.7 2160.7 2164.0 2113.3 2131.4 2132.5 2142.7 2144.9 2067.0 2068.6 2068.8 2071.0 2079.8 2084.4 2152.1 2154.6 2155.8 2156.2 7600.2 7708.0 7724.9 7755.0 7760.5 4264.4 4368.1 4377.8 4379.2 4388.1 2652.8 2705.1 2791.2 2797.5 2803.2 836.4 863.3 865.5 881.1 885.7 10292.4 10329.7 10345.3 10377.7 10378.4 3811.6 3953.2 4086.7 4096.0 4097.5 8788.7 8788.8 8791.7 8793.4 8794.8 4429.0 4443.3 4445.8 4450.0 4459.3 3457.4 3871.8 4056.6 4068.5 4079.1 3481.3 3546.7 3642.4 3653.8 3660.9 1117.8 1125.4 1136.3 1150.6 1151.4 709.8 789.7 813.2 814.3 819.1 4998.0 5077.9 5182.1 5314.5 5401.6 353.3 353.9 357.5 365.5 368.9 3504.7 3563.9 3573.6 3631.3 3678.4 9096.6 9286.4 9364.1 9366.2 9366.4 9304.2 9311.3 9316.3 9322.1 9323.7 6955.1 7043.5 7075.4 7141.7 7144.8 4958.1 4986.2 5000.8 5086.6 5101.1 8371.2 8450.7 8519.5 8535.0 8760.4 8743.0 8752.3 8949.1 9058.0 9069.5 5727.2 5877.8 6368.7 6509.5 6527.3 7166.4 7402.3 7431.0 7437.0 7437.7 6291.9 6421.1 6474.0 6501.8 6655.7 6052.1 6055.6 6080.0 6088.0 6194.0 6032.1 6175.7 6177.2 6182.2 6184.2 4242.3 4286.3 4321.7 4371.5 4481.0 4304.8 4307.5 4398.4 4434.9 4523.5 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#4] prototype.html Cycles:180 Average:4159.63 Median:4730.11 stddev:1206.22 (25.5%) stddev-sans-first:1173.92 11:56:34 INFO - PROCESS | 13356 | Values: 279.7 293.6 294.3 295.6 300.7 4576.2 4727.4 4732.8 4766.6 4784.3 4546.2 4711.0 4713.4 4737.9 4741.9 3741.2 3752.9 3762.4 3765.5 3767.8 3591.8 3764.2 3767.6 3769.2 3777.2 3480.7 3727.9 3742.6 3744.1 3773.3 3712.7 3714.2 3714.9 3717.6 3766.5 3293.9 3294.1 3302.2 3304.7 3304.9 4549.3 4586.1 4610.8 4640.4 4660.6 4227.8 4232.1 4232.7 4248.7 4248.7 4932.5 4961.3 4969.3 4969.4 4996.6 3446.7 3590.3 3602.7 3608.4 3628.5 5128.1 5183.9 5185.2 5189.9 5196.3 3662.2 3664.0 3668.8 3670.7 3671.1 3720.1 3730.5 3740.9 3748.0 3753.9 3930.4 4135.1 4144.3 4240.7 4247.9 4960.8 4968.8 4985.6 5005.8 5020.8 1208.2 1222.7 1273.3 1283.0 1287.2 847.6 858.0 871.3 871.7 872.3 4438.3 4440.8 4444.3 4455.4 4458.3 5102.9 5109.7 5116.7 5119.4 5131.6 4257.9 4450.3 4481.8 4500.8 4534.6 2724.6 2752.7 2752.9 2754.4 2758.9 4907.9 4911.0 4923.6 4926.9 4935.5 5155.1 5221.3 5265.6 5277.8 5285.7 4852.6 4865.7 4866.0 4876.3 4879.6 5046.1 5140.0 5147.3 5152.1 5181.9 4983.0 5058.0 5093.0 5113.5 5130.1 4907.3 4910.2 4910.9 4911.4 4953.5 3639.2 3645.3 3647.5 3647.7 3654.2 5048.2 5146.0 5176.0 5185.7 5190.5 5047.3 5049.2 5055.2 5059.3 5071.4 4936.4 4989.3 4993.0 5002.3 5076.4 4702.0 4769.5 4828.8 4908.0 4991.4 5023.3 5043.7 5063.4 5064.9 5076.2 4944.7 4949.9 4960.8 4960.9 4963.9 11:56:34 INFO - PROCESS | 13356 | 11:56:34 INFO - PROCESS | 13356 | [#5] yui.html Cycles:180 Average:18333.95 Median:33206.92 stddev:27951.66 (84.2%) stddev-sans-first:27998.36 11:56:34 INFO - PROCESS | 13356 | Values: 601.9 632.2 663.0 671.1 703.8 12503.9 12807.9 13400.1 13404.7 13482.6 12972.5 13192.3 13249.3 13260.1 13265.1 616.9 747.9 767.6 771.3 771.4 712.7 737.0 739.4 747.2 749.5 785.5 787.5 787.7 787.8 788.2 628.4 788.1 789.5 791.0 791.3 563.5 575.1 577.5 581.3 581.6 11846.9 11855.1 11967.1 11986.9 11991.4 12011.8 12533.9 12624.9 12831.9 13348.1 11322.4 11619.7 11669.4 11695.2 12112.6 3949.5 4007.8 4035.2 4137.1 4138.2 65781.7 66870.7 66916.7 67784.0 68218.3 9178.2 9475.9 9626.8 9920.6 9951.2 17830.2 18129.5 18164.6 18182.4 18194.5 6751.5 6760.6 6789.6 7068.0 7075.3 3655.4 3665.8 3670.2 3706.3 3861.8 2688.2 2820.3 2823.7 2833.4 2835.2 469.2 473.8 475.5 482.7 487.6 404.6 434.1 438.2 439.2 441.2 6892.4 7252.0 7252.9 7369.7 7869.2 452.9 474.6 474.9 485.0 495.0 3282.8 3347.8 3430.3 3549.9 3562.8 101747.0 105739.0 107541.0 109277.0 110439.4 90435.5 91024.5 91266.5 91351.0 91811.5 79415.0 80282.0 81250.6 81729.6 82110.0 6752.3 6799.7 6831.1 6923.3 7182.0 47002.5 47462.0 47890.5 48905.0 49005.0 67546.0 69209.7 70484.6 70865.6 72910.6 8469.5 8651.7 8674.9 8688.7 8870.7 9540.8 9574.5 9843.6 9888.1 9892.6 7685.0 7896.9 7969.1 8329.0 9138.6 7540.6 9467.2 9472.6 10074.0 10124.3 10358.3 10497.2 10669.2 10795.8 10847.9 8249.8 8542.3 9317.3 9730.4 9864.4 8065.3 8312.7 8939.5 8992.0 9518.6 11:56:34 INFO - PROCESS | 13356 | -------- Summary: end -------- 11:56:34 INFO - PROCESS | 13356 | 11:56:35 INFO - TEST-INFO | 13356: exit 0 11:56:35 INFO - TEST-OK | dromaeo_css | took 1121347ms 11:56:35 INFO - TEST-START | kraken 11:56:35 INFO - operating with platform_type : linux_ 11:56:35 INFO - Initialising browser for kraken test... 11:56:35 INFO - TEST-INFO | started process 13666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppduG5s/profile http://localhost:57358/getInfo.html) 11:56:40 INFO - PROCESS | 13666 | __metrics Screen width/height:1600/1200 11:56:40 INFO - PROCESS | 13666 | colorDepth:24 11:56:40 INFO - PROCESS | 13666 | Browser inner width/height: 1024/697 11:56:40 INFO - PROCESS | 13666 | __metrics 11:56:40 INFO - PROCESS | 13666 | 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" 11:56:40 INFO - PROCESS | 13666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:41 INFO - PROCESS | 13666 | console.error: PushService: 11:56:41 INFO - PROCESS | 13666 | stateChangeProcessEnqueue: Error transitioning state 11:56:41 INFO - PROCESS | 13666 | UnknownError 11:56:41 INFO - TEST-INFO | 13666: exit 0 11:56:41 INFO - Browser initialized. 11:56:41 INFO - Running cycle 1/1 for kraken test... 11:56:41 INFO - TEST-INFO | started process 13747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppduG5s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:54 INFO - PROCESS | 13747 | RSS: Main: 183144448 11:56:54 INFO - PROCESS | 13747 | 11:56:56 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection) 11:56:57 INFO - PROCESS | 13747 | RSS: Main: 236163072 11:56:57 INFO - PROCESS | 13747 | 11:57:00 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-dft) 11:57:01 INFO - PROCESS | 13747 | RSS: Main: 226803712 11:57:01 INFO - PROCESS | 13747 | 11:57:04 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-fft) 11:57:05 INFO - PROCESS | 13747 | RSS: Main: 305197056 11:57:05 INFO - PROCESS | 13747 | 11:57:07 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator) 11:57:07 INFO - PROCESS | 13747 | RSS: Main: 213315584 11:57:07 INFO - PROCESS | 13747 | 11:57:10 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:10 INFO - PROCESS | 13747 | RSS: Main: 216064000 11:57:10 INFO - PROCESS | 13747 | 11:57:14 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:14 INFO - PROCESS | 13747 | RSS: Main: 254185472 11:57:14 INFO - PROCESS | 13747 | 11:57:18 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:18 INFO - PROCESS | 13747 | RSS: Main: 253337600 11:57:18 INFO - PROCESS | 13747 | 11:57:21 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial) 11:57:22 INFO - PROCESS | 13747 | RSS: Main: 252264448 11:57:22 INFO - PROCESS | 13747 | 11:57:24 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:24 INFO - PROCESS | 13747 | RSS: Main: 215695360 11:57:24 INFO - PROCESS | 13747 | 11:57:26 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:27 INFO - PROCESS | 13747 | RSS: Main: 222433280 11:57:27 INFO - PROCESS | 13747 | 11:57:29 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:30 INFO - PROCESS | 13747 | RSS: Main: 224038912 11:57:30 INFO - PROCESS | 13747 | 11:57:32 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:33 INFO - PROCESS | 13747 | RSS: Main: 219455488 11:57:33 INFO - PROCESS | 13747 | 11:57:36 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:37 INFO - PROCESS | 13747 | RSS: Main: 221958144 11:57:37 INFO - PROCESS | 13747 | 11:57:38 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:57358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57358/tests/kraken/driver.html?testName=ai-astar) 11:57:39 INFO - PROCESS | 13747 | RSS: Main: 273506304 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | __start_tp_report 11:57:39 INFO - PROCESS | 13747 | _x_x_mozilla_page_load 11:57:39 INFO - PROCESS | 13747 | _x_x_mozilla_page_load_details 11:57:39 INFO - PROCESS | 13747 | |i|pagename|runs| 11:57:39 INFO - PROCESS | 13747 | |0;ai-astar;114;114;129;114;114;113;113;115;116;113 11:57:39 INFO - PROCESS | 13747 | |1;audio-beat-detection;153;124;150;179;123;143;143;125;184;124 11:57:39 INFO - PROCESS | 13747 | |2;audio-dft;162;162;162;160;162;161;161;161;160;160 11:57:39 INFO - PROCESS | 13747 | |3;audio-fft;75;75;75;165;76;75;77;75;154;76 11:57:39 INFO - PROCESS | 13747 | |4;audio-oscillator;87;87;150;87;87;87;142;87;86;152 11:57:39 INFO - PROCESS | 13747 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 11:57:39 INFO - PROCESS | 13747 | |6;imaging-darkroom;146;145;146;145;146;146;145;146;145;146 11:57:39 INFO - PROCESS | 13747 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;96;95 11:57:39 INFO - PROCESS | 13747 | |8;json-parse-financial;70;66;67;67;68;70;69;70;67;69 11:57:39 INFO - PROCESS | 13747 | |9;json-stringify-tinderbox;65;65;65;66;65;65;65;67;65;66 11:57:39 INFO - PROCESS | 13747 | |10;stanford-crypto-aes;85;83;92;84;87;82;83;85;82;83 11:57:39 INFO - PROCESS | 13747 | |11;stanford-crypto-ccm;141;143;139;146;142;131;142;138;147;149 11:57:39 INFO - PROCESS | 13747 | |12;stanford-crypto-pbkdf2;171;176;171;174;175;172;175;176;172;179 11:57:39 INFO - PROCESS | 13747 | |13;stanford-crypto-sha256-iterative;68;70;70;70;73;71;70;68;67;68 11:57:39 INFO - PROCESS | 13747 | __end_tp_report 11:57:39 INFO - PROCESS | 13747 | __start_cc_report 11:57:39 INFO - PROCESS | 13747 | _x_x_mozilla_cycle_collect,1967 11:57:39 INFO - PROCESS | 13747 | __end_cc_report 11:57:39 INFO - PROCESS | 13747 | __startTimestamp1471978659203__endTimestamp 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | ------- Summary: start ------- 11:57:39 INFO - PROCESS | 13747 | Number of tests: 14 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#0] ai-astar Cycles:10 Average:115.50 Median:114.00 stddev:4.84 (4.2%) stddev-sans-first:5.10 11:57:39 INFO - PROCESS | 13747 | Values: 114.0 114.0 129.0 114.0 114.0 113.0 113.0 115.0 116.0 113.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:146.50 stddev:22.46 (15.3%) stddev-sans-first:23.62 11:57:39 INFO - PROCESS | 13747 | Values: 153.0 124.0 150.0 179.0 123.0 143.0 143.0 125.0 184.0 124.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 11:57:39 INFO - PROCESS | 13747 | Values: 162.0 162.0 162.0 160.0 162.0 161.0 161.0 161.0 160.0 160.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:35.52 (47.4%) stddev-sans-first:37.12 11:57:39 INFO - PROCESS | 13747 | Values: 75.0 75.0 75.0 165.0 76.0 75.0 77.0 75.0 154.0 76.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:87.00 stddev:29.64 (34.1%) stddev-sans-first:30.70 11:57:39 INFO - PROCESS | 13747 | Values: 87.0 87.0 150.0 87.0 87.0 87.0 142.0 87.0 86.0 152.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:57:39 INFO - PROCESS | 13747 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:57:39 INFO - PROCESS | 13747 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:57:39 INFO - PROCESS | 13747 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.45 11:57:39 INFO - PROCESS | 13747 | Values: 70.0 66.0 67.0 67.0 68.0 70.0 69.0 70.0 67.0 69.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:57:39 INFO - PROCESS | 13747 | Values: 65.0 65.0 65.0 66.0 65.0 65.0 65.0 67.0 65.0 66.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:3.03 (3.6%) stddev-sans-first:3.21 11:57:39 INFO - PROCESS | 13747 | Values: 85.0 83.0 92.0 84.0 87.0 82.0 83.0 85.0 82.0 83.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:142.50 stddev:5.14 (3.6%) stddev-sans-first:5.44 11:57:39 INFO - PROCESS | 13747 | Values: 141.0 143.0 139.0 146.0 142.0 131.0 142.0 138.0 147.0 149.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:175.00 stddev:2.60 (1.5%) stddev-sans-first:2.51 11:57:39 INFO - PROCESS | 13747 | Values: 171.0 176.0 171.0 174.0 175.0 172.0 175.0 176.0 172.0 179.0 11:57:39 INFO - PROCESS | 13747 | 11:57:39 INFO - PROCESS | 13747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.78 (2.5%) stddev-sans-first:1.80 11:57:39 INFO - PROCESS | 13747 | Values: 68.0 70.0 70.0 70.0 73.0 71.0 70.0 68.0 67.0 68.0 11:57:39 INFO - PROCESS | 13747 | -------- Summary: end -------- 11:57:39 INFO - PROCESS | 13747 | 11:57:40 INFO - TEST-INFO | 13747: exit 0 11:57:40 INFO - TEST-OK | kraken | took 64799ms 11:57:40 INFO - SUITE-END | took 1186s 11:57:40 INFO - Completed test suite (00:19:46) 11:57:40 INFO - javascript benchmark 11:57:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.746025397459, 2565.371483986423, 2571.3314538220056, 2596.28602134413, 2601.5967525033616, 4600.551787332794, 4608.308753686949, 4643.837465688702, 4693.460252071013, 4740.4548476925165, 4610.769461526918, 4663.790129444174, 4670.836520721776, 4671.836485723001, 4747.311639812225, 4304.24675681756, 4311.116221174651, 4313.935290970638, 4329.134173165364, 4481.596656300932, 4425.66807489438, 4430.379746835446, 4431.534688857671, 4433.977830110861, 4460.821567137311, 4196.916061678749, 4247.256730072225, 4252.617264446184, 4289.613934745857, 4290.227759003378, 4271.316589345721, 4296.5273819879785, 4305.483341998949, 4312.504062032875, 4313.137372525476, 4241.406203131564, 4258.829646814123, 4263.0834370610155, 4277.272863613193, 4353.608175264209, 4669.229577119771, 4696.107739529479, 4699.459562150328, 4712.622990160813, 4729.527047295277, 4872.074305881906, 4897.04507621014, 4991.351124353847, 5001.499850015006, 5051.292819005343, 4956.826511072131, 4972.577330926875, 4985.277134815467, 4988.426330971948, 5037.924431133536, 4641.396618439581, 4645.094206629675, 4652.604528615038, 4665.883352916137, 4696.436427628706, 4980.5019498049905, 5041.168207245837, 5086.745662716849, 5096.0, 5106.617003724736, 4814.229723244334, 4819.6867203631655, 4830.227163653799, 4885.340479035285, 4889.2910527973245, 4881.974785295057, 4894.19245824435, 4901.264810278487, 4925.21196608541, 4961.305417241589, 4792.856214313576, 4865.9026819463415, 4875.219964805614, 4884.579778815255, 4941.777620007108, 4873.244647079709, 4916.754162291871, 4924.162892308316, 4982.60139188864, 4984.053029924376, 4159.500859896832, 4163.83344666216, 4165.75005499671, 4202.243596152722, 4216.051388437577, 3635.9818200908826, 3652.671259586597, 3662.0, 3663.8351274192723, 3724.925501489955, 4304.268274393298, 4331.436913201263, 4338.023944612437, 4344.370066340426, 4346.587074227943, 5033.496650334937, 5036.093503169464, 5038.193888977746, 5061.266116413173, 5090.516400941905, 4359.26380856241, 4365.323374876835, 4370.737755734666, 4420.270655341897, 4427.955720442818, 4329.935050974238, 4386.210482113251, 4417.977910110429, 4455.2648812946145, 4462.866114016585, 4695.990362072171, 4702.0360826031265, 4706.0823139487475, 4744.312074749073, 4762.16662084127, 4934.432540257916, 4983.925241121314, 4989.027139707868, 4994.9750251248515, 5035.622328325464, 4621.722696638212, 4693.131770622445, 4708.152532544175, 4719.126961511994, 4766.904661906673, 4917.6311776616185, 4940.036692845005, 4943.406791185081, 4980.153373926513, 4999.700017998932, 5016.172331565251, 5017.799288028438, 5024.547790698854, 5025.748712564284, 5080.364954380702, 4743.146233677971, 4746.976265118652, 4765.76171191446, 4884.12085824555, 4957.776900039435, 4798.47216806158, 4810.254410566367, 4824.49342818999, 4863.4650188479945, 4869.220924652039, 4754.7384893829785, 4756.7383793890285, 4757.952420475751, 4758.738269395078, 4803.759812009315, 4749.976250118727, 4839.975800120977, 4851.975740121276, 4881.0, 4884.340614017062, 4809.44691360484, 4824.903501930012, 4827.710337379768, 4861.805527778849, 4887.462379138363], "value": 4575.242854406034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6308218117133, 570.7602806821135, 574.8074395077649, 578.4158000419575, 583.0263460021763, 28327.858360708193, 31402.842985785068, 38428.0, 39530.40704389437, 39658.40512392316, 39897.60102398975, 40331.0, 40346.0, 40436.393454098215, 40486.59513404865, 7660.5403675779635, 7809.804754881116, 7812.726554570591, 7812.968628156692, 7816.843663126734, 7346.412287017052, 7472.439567032494, 7531.6610752516, 7535.585542795144, 7713.190115037924, 9797.84447421566, 10086.344387614818, 10086.546105425237, 10366.222533309994, 10372.533236004398, 9890.505474726271, 9962.501874906226, 9964.950175249078, 9985.550650220757, 9988.1510071644, 9894.406335619886, 9965.053319934595, 9966.20270378368, 9970.202383809277, 9971.90028099717, 38356.424653630216, 38559.614403855885, 38668.41997370042, 38675.41986870199, 38682.22635547273, 2740.7670348020442, 2747.3406382468065, 2851.2871782054485, 3274.96725032749, 3393.694567488913, 28561.428771424456, 29383.412331753458, 29390.41219175626, 29991.400171996655, 30751.692483075105, 3312.850921708529, 3370.9325813483592, 3385.743608138554, 3446.483027545888, 3459.7924124552605, 242306.0, 242959.0, 243415.0, 244090.0, 244330.0, 52526.737366312926, 52985.735071325165, 52991.0, 53066.7346663272, 53170.468295316554, 32021.199470013435, 33099.50350744741, 33240.83379583135, 35265.64734352624, 35318.644728750725, 14231.501897433747, 14479.466093433606, 14486.420543178365, 14492.550744925424, 14496.420143194366, 10966.670999870017, 11223.551057957753, 11224.607138750105, 11229.38238396896, 11235.438228088562, 15709.921450392903, 17498.475045748648, 17781.7332740009, 17888.463346099637, 17993.64012719738, 6683.832904177434, 6750.5274630775375, 6843.965780171067, 6901.792946211622, 6967.756128535579, 745.3329270303157, 814.8411059843273, 922.8938672052666, 949.9715008549755, 978.295627148452, 26807.463850722877, 28137.27744399243, 28661.426771464456, 28724.42551149007, 28752.424951500852, 894.5259012723267, 971.3491960386558, 1070.7537266428765, 1074.4412905289362, 1077.138289368502, 14113.0, 14929.477468288775, 15235.542933712006, 15253.771193432107, 15345.769813452807, 383701.0, 384625.0, 385242.0, 386810.0, 387435.0, 48629.0, 49141.75429122832, 49273.50726492761, 49310.75344623254, 49353.259701104515, 1156.5951916829042, 1199.9040076793835, 1203.6750077479032, 1204.0367705835297, 1207.2273744803508, 26202.86898565495, 27179.59230611582, 27508.0, 27894.86052569724, 28130.0, 43077.0, 43383.34924976191, 43418.565814341455, 43432.131357373306, 43488.56511434845, 304635.0, 304991.0, 305529.0, 305861.0, 306174.0, 22503.88748056249, 24308.270751877473, 25092.498150037263, 25629.743702562737, 26030.479390412464, 41403.0, 41552.79223603863, 42512.78743606386, 42694.57305426906, 42703.5729642712, 34213.65786342204, 35606.71568308929, 36595.0, 37087.44368834416, 37218.62781372152, 35799.82100089483, 35841.82079089588, 35970.28059438744, 36280.63719362878, 36283.45574816327, 34602.96191114271, 35098.82450587833, 35301.29397411986, 35606.821965890005, 36006.45990310095, 30330.69669303367, 32675.183120422178, 33115.0, 33367.33265334631, 33427.164320892174, 24549.63175552404, 25483.745162548137, 25675.614865776653, 25852.095176668725, 26133.60799588046], "value": 17520.09597357863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.861068488632, 368.682932677897, 372.8117300763115, 384.0628865568016, 385.8572328238552, 16180.757288640665, 17791.466256012307, 18174.365536788133, 18311.54221144472, 18386.448406547825, 14962.775558366633, 15415.69168616627, 15551.144687042208, 15569.84430155701, 15614.921925390385, 4888.242322440027, 5091.159958606825, 5120.231965205212, 5121.615878809085, 5124.846254612367, 3768.208676178006, 3837.1750073734142, 3905.1051526793176, 4968.3292755477905, 5049.4698056704065, 5435.347758269013, 5947.732352044169, 5949.196858424122, 5954.880902381949, 5955.9702201488935, 5743.5118014968775, 5938.613990090652, 5968.31364393096, 5972.492338151263, 6165.445109940127, 5438.048341540215, 5440.102383106782, 5444.809431669913, 5445.891082178374, 5450.291462109901, 20966.685499717518, 20996.895015524824, 21017.369478915658, 21061.578768424544, 21265.574688506298, 1846.3722334406232, 1850.0842083168918, 1912.4549503391606, 1949.2008276606523, 2574.84550926945, 13111.147775394664, 13496.325183740872, 13497.392617332243, 13674.863251367458, 13991.65020874476, 1691.560194349478, 1750.0724615953438, 1771.7342398640178, 1824.4161868202182, 1850.8056654051265, 66624.33375666279, 69433.0, 69459.0, 70737.0, 71092.6445367775, 9492.667756628485, 9685.951570242245, 9871.40771553709, 10007.732023046447, 10071.194304455626, 13877.722445551033, 13900.304984750723, 13911.234882081582, 13911.86088139126, 13917.164970101827, 7039.753608623673, 7164.856702866018, 7204.17152027513, 7435.665395057235, 7436.516626419266, 6759.188897332351, 6761.18865736105, 7000.299970002959, 7002.964985175144, 7008.088948436773, 6147.200863887755, 6281.183446151971, 6284.842878927972, 6300.857708379173, 6449.838754031093, 1753.1672455583496, 1754.824517548235, 1773.9911300443416, 1792.050213386907, 1830.2313028528051, 836.8033512124646, 853.2747164909777, 856.7643897927995, 892.1435421994958, 909.231699214163, 17183.65632687339, 17310.480685579452, 18038.909805451152, 18256.543586410447, 18319.450416487525, 851.45932332969, 880.9119088091268, 884.3234925282164, 917.5091326140483, 931.5388882503204, 9375.39059961114, 10083.848742268872, 10267.74330641725, 10277.229207809443, 10327.638532651321, 371293.0, 377604.0, 400200.0, 402627.0, 402806.0, 45752.0, 63063.32430081315, 64071.359286407474, 69912.0, 70641.99086155366, 829.4732844643574, 850.3452341696859, 885.8272636835756, 888.0542222532981, 917.4678686361895, 11682.88317116818, 14367.568972930829, 15908.920455397649, 16530.338786448407, 16895.155242237593, 36211.2062070078, 37627.623723762415, 38424.23151536898, 40458.190836182526, 41590.792046039576, 51891.740541297055, 51938.0, 52316.19800093297, 52648.0, 53187.4681253198, 7226.530275532074, 7495.0, 7583.203763604963, 7810.0, 7983.560904150328, 9801.558929848317, 11807.0, 11881.82177267359, 12070.27578345302, 12357.629271121881, 9993.400395976265, 10374.27380083387, 10378.377297362182, 10594.364338139736, 10791.460426978776, 4645.372874661877, 7240.710371585288, 10026.248031397528, 10045.547950342398, 10323.174146068446, 10465.424401657981, 10548.736281592715, 10631.840522392326, 10649.361038337725, 11080.778384432106, 7365.042544469399, 7534.585597792174, 7606.923930760621, 7857.057153141431, 8081.919180808117, 9219.44683319003, 10287.331323463952, 10348.741281467723, 10449.738756531147, 10470.947645261725], "value": 8330.424806498419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.523404191512, 1354.7425989062078, 1403.2352367959468, 1603.286537490817, 1639.0329705473775, 7118.679659415326, 7732.342750866176, 7735.883961740578, 7741.0, 7748.225177482249, 6622.337766223375, 7300.306470885257, 7526.134494533117, 7531.9623401883055, 7599.696012159521, 2116.0689296709475, 2163.8809865457392, 2164.145162660748, 2166.3825809644254, 2167.3822960456273, 2127.4894025433864, 2145.9248926287582, 2160.686700428445, 2160.7299087614047, 2164.0478189596606, 2113.3342996955985, 2131.435169680028, 2132.4775430019668, 2142.7428708554994, 2144.9034793434334, 2066.9896650516725, 2068.596623658387, 2068.7724350321378, 2071.0369678099605, 2079.812816846476, 2084.405944305881, 2152.0638522242875, 2154.569086182754, 2155.838312126597, 2156.202205184092, 7600.239976002411, 7708.03649543807, 7724.922750772476, 7755.0, 7760.534367937886, 4264.445622069111, 4368.104538569585, 4377.824887004516, 4379.167958087953, 4388.078503514266, 2652.7612514873754, 2705.147878418292, 2791.2184588315304, 2797.510435673749, 2803.243124356433, 836.4437648963432, 863.2834747159905, 865.485036403339, 881.1496905486237, 885.7209978856639, 10292.433916134609, 10329.741756456073, 10345.275830691855, 10377.740556486073, 10378.377297362182, 3811.5706610021243, 3953.2093581283857, 4086.67306615476, 4096.037431203665, 4097.467329247179, 8788.736337909873, 8788.824223515494, 8791.736247912573, 8793.384463087523, 8794.780130496789, 4428.955710442854, 4443.33349997503, 4445.82216711328, 4449.976505403775, 4459.2865141577195, 3457.3776720190103, 3871.8064096795047, 4056.553779084298, 4068.4710987571425, 4079.102597428561, 3481.268933523938, 3546.6985306248744, 3642.4172132459207, 3653.8173091345857, 3660.9450858237146, 1117.7987962166887, 1125.4429057616533, 1136.2727854173336, 1150.6433005768238, 1151.3955173533961, 709.8260926073145, 789.6880732110784, 813.2233716800441, 814.267159556404, 819.1276290750332, 4997.9500204997485, 5077.898442031139, 5182.093133701587, 5314.468553144732, 5401.567874570103, 353.3163328958474, 353.85668804134366, 357.5048557747538, 365.5029160341933, 368.85614610302, 3504.684578387957, 3563.8752643657867, 3573.6426357364057, 3631.3463576555946, 3678.3746763050344, 9096.590653420611, 9286.396384235004, 9364.110409511086, 9366.203872670763, 9366.391184572982, 9304.16262536375, 9311.348205625676, 9316.347855650174, 9322.067793220624, 9323.72028839136, 6955.130608673916, 7043.471739619549, 7075.433965282765, 7141.678624461912, 7144.785656430419, 4958.057968985881, 4986.202207646759, 5000.849974500771, 5086.593072554261, 5101.081805274937, 8371.204735550113, 8450.746477605682, 8519.531425771642, 8534.957325213334, 8760.386772925835, 8743.0, 8752.256058235122, 8949.149830766068, 9057.954710226406, 9069.501177435304, 5727.1695604138, 5877.764889404376, 6368.713407896748, 6509.479241660751, 6527.314631963575, 7166.426685865223, 7402.29678180572, 7430.96284518574, 7436.962815186106, 7437.702491900263, 6291.905621415591, 6421.068945002855, 6473.967630161819, 6501.837454063686, 6655.73377064912, 6052.061930400795, 6055.6063855849225, 6080.0, 6087.969560152171, 6194.0, 6032.065029920369, 6175.69121543912, 6177.1969643945995, 6182.227221597301, 6184.165137706352, 4242.321228603409, 4286.292761694285, 4321.719088259253, 4371.519132895315, 4481.0, 4304.849330273425, 4307.483102027777, 4398.362237475612, 4434.933475997798, 4523.457185137804], "value": 3903.2989701676574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.6979262396612, 293.62855987176226, 294.3480191376102, 295.55961617190366, 300.72333453223035, 4576.244919588264, 4727.409073865767, 4732.810687572497, 4766.61867050636, 4784.282357646351, 4546.227141385964, 4711.0, 4713.363695901053, 4737.928931066028, 4741.90516189676, 3741.158239396141, 3752.868649597251, 3762.3980163173896, 3765.548134223897, 3767.792771397572, 3591.7844929304197, 3764.1718821859286, 3767.6420740029653, 3769.246150769843, 3777.1690228149764, 3480.6519348065244, 3727.869524566641, 3742.644448777362, 3744.1014156602355, 3773.320872211867, 3712.6658600726064, 3714.2014466889477, 3714.8699795507027, 3717.5910649828766, 3766.472693822867, 3293.8682452701864, 3294.1435226840954, 3302.207470207157, 3304.653011433813, 3304.867805287786, 4549.294859296814, 4586.1286355592665, 4610.76946152691, 4640.396748422683, 4660.603848672867, 4227.767472788995, 4232.11125663611, 4232.666709986344, 4248.702590818644, 4248.723832950879, 4932.506749325074, 4961.280614310905, 4969.26075873445, 4969.35398398206, 4996.551000209971, 3446.7414943879057, 3590.299891521154, 3602.6937710294656, 3608.4226523756333, 3628.4738712886483, 5128.102582048126, 5183.896322073538, 5185.222216667492, 5189.896202075937, 5196.272521846907, 3662.1760103976394, 3663.9557726047947, 3668.834902429397, 3670.724695647837, 3671.1372827385544, 3720.051386896378, 3730.477733117366, 3740.8690695825517, 3747.950573839275, 3753.887383378503, 3930.3711406174875, 4135.1316223593385, 4144.274751918402, 4240.660747140221, 4247.936280955788, 4960.826371076995, 4968.751562421864, 4985.601151907838, 5005.824796132118, 5020.820107274788, 1208.1844754790482, 1222.7493363860387, 1273.3442277227236, 1282.993585032069, 1287.1569122224957, 847.639753104928, 858.0, 871.2986046232717, 871.6818361298207, 872.3021582733787, 4438.312061630452, 4440.800163992628, 4444.28891377378, 4455.398521199597, 4458.286674132123, 5102.872428189251, 5109.718965456936, 5116.718580478035, 5119.436861945183, 5131.56381707559, 4257.8509752158525, 4450.332450132441, 4481.75350355727, 4500.842470513517, 4534.59188673021, 2724.645796046541, 2752.651200911579, 2752.944941101167, 2754.394033312668, 2758.917232483029, 4907.852764417074, 4910.950890491121, 4923.606111511071, 4926.852194434173, 4935.457099719028, 5155.149400348901, 5221.269022336875, 5265.578753699695, 5277.8416647500635, 5285.656432331886, 4852.611791056707, 4865.70805751656, 4865.95134048655, 4876.341693871353, 4879.56083952446, 5046.066477701637, 5139.997700448376, 5147.305113809588, 5152.124138896322, 5181.932183236292, 4982.975085124551, 5058.013687330935, 5093.0, 5113.488651135006, 5130.101492656786, 4907.288443175791, 4910.189818680021, 4910.877228069184, 4911.361523001987, 4953.504649535018, 3639.1811842335264, 3645.2527231917925, 3647.4711166881184, 3647.6717095460476, 3654.1778099928365, 5048.242763585492, 5146.0, 5176.0, 5185.703574106474, 5190.455002224863, 5047.318611987334, 5049.2173713074535, 5055.241713742968, 5059.316992206005, 5071.4421413645205, 4936.43231028422, 4989.326440930573, 4992.975035124801, 5002.299678045004, 5076.390833100052, 4701.976490117664, 4769.546893045155, 4828.76866399066, 4907.975460122677, 4991.3511243538105, 5023.34696489454, 5043.722595257296, 5063.443021267584, 5064.924026139684, 5076.18780995039, 4944.728039957837, 4949.901001980013, 4960.842033715346, 4960.8759781005765, 4963.875903102451], "value": 3775.050538761184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.9488343490804, 632.1592282264588, 662.9602223866567, 671.1442910289377, 703.7677566403088, 12503.937480312587, 12807.935960320197, 13400.128991615538, 13404.66488337792, 13482.595522134327, 12972.545960891372, 13192.340382980836, 13249.271290079067, 13260.071794974356, 13265.1377660452, 616.9352218017111, 747.9252074792531, 767.6277005652254, 771.3327971304809, 771.3867475357105, 712.700665720396, 736.988945165823, 739.4121673269764, 747.1930315259507, 749.4791120171483, 785.4541093939714, 787.5117427195147, 787.7242964962275, 787.7951732549521, 788.1802924958065, 628.3653509954933, 788.0543347982444, 789.5460110436493, 791.0467886197176, 791.3273717340244, 563.5294529068233, 575.0569066730566, 577.4514211499051, 581.3198557687474, 581.5522048023041, 11846.940765296118, 11855.05159587231, 11967.102467314986, 11986.940065299705, 11991.400429978466, 12011.759764804743, 12533.857558096319, 12624.873751262461, 12831.87168128316, 13348.065635405526, 11322.377269250188, 11619.6514104577, 11669.416529173592, 11695.239809412362, 12112.576059837951, 3949.4865667463046, 4007.779572123532, 4035.1929614077303, 4137.089840235143, 4138.151678905847, 65781.67109164472, 66870.66564667145, 66916.66541667261, 67784.0, 68218.3178168217, 9178.19979059258, 9475.857862132074, 9626.807463850684, 9920.553575089138, 9951.15415189717, 17830.19764110618, 18129.54676133081, 18164.63670726578, 18182.363587276945, 18194.545136371697, 6751.493637977172, 6760.594364338155, 6789.558678685869, 7067.964660176769, 7075.292470752884, 3655.3968595182027, 3665.780053196817, 3670.155864151207, 3706.3328600852105, 3861.768293902375, 2688.153231731998, 2820.294926268433, 2823.745862872351, 2833.4049849531416, 2835.17779843843, 469.1765950756469, 473.7962676049332, 475.4935993167266, 482.6814302560364, 487.57093757493885, 404.641891925642, 434.0970780775978, 438.2002844808174, 439.2401146017408, 441.2124358020917, 6892.414144797648, 7252.0, 7252.927470725331, 7369.668364923591, 7869.213078692085, 452.8913060865369, 474.6487599176584, 474.89789695215006, 485.0250995499072, 494.97030178189425, 3282.8030318180986, 3347.7656564040285, 3430.2967891582166, 3549.8580056797437, 3562.7684200526883, 101747.0, 105739.0, 107541.0, 109277.0, 110439.44780276208, 90435.54782226047, 91024.54487727518, 91266.54366728124, 91351.0, 91811.54094229486, 79415.0, 80282.0, 81250.59374703089, 81729.59135204286, 82110.0, 6752.257251702211, 6799.694013769294, 6831.111955445959, 6923.273056329013, 7181.964090179516, 47002.52997469981, 47462.0, 47890.52109479, 48905.0, 49005.0, 67546.0, 69209.65395172992, 70484.64757676178, 70865.64567177132, 72910.63544682243, 8469.5341756204, 8651.653933842575, 8674.869876951978, 8688.739337819876, 8870.73387798367, 9540.809183816145, 9574.47340396285, 9843.60625574969, 9888.110070093726, 9892.604295828087, 7684.961575192312, 7896.921030789618, 7969.123396426273, 8329.0, 9138.588763505526, 7540.585267810104, 9467.195288400288, 9472.57373418184, 10074.0, 10124.291299608956, 10358.274920755475, 10497.2127090467, 10669.199810014125, 10795.784084318428, 10847.891521084688, 8249.79375515593, 8542.316614670935, 9317.254619630548, 9730.41617502952, 9864.408135511892, 8065.274125328749, 8312.70905518328, 8939.463632182089, 8991.955040224757, 9518.571664275263], "value": 6191.901708013833, "unit": "score"}], "name": "dromaeo_css", "value": 6272.994165303601, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 129.0, 114.0, 114.0, 113.0, 113.0, 115.0, 116.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 150.0, 179.0, 123.0, 143.0, 143.0, 125.0, 184.0, 124.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 165.0, 76.0, 75.0, 77.0, 75.0, 154.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 150.0, 87.0, 87.0, 87.0, 142.0, 87.0, 86.0, 152.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 67.0, 68.0, 70.0, 69.0, 70.0, 67.0, 69.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 92.0, 84.0, 87.0, 82.0, 83.0, 85.0, 82.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 139.0, 146.0, 142.0, 131.0, 142.0, 138.0, 147.0, 149.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 171.0, 174.0, 175.0, 172.0, 175.0, 176.0, 172.0, 179.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 70.0, 70.0, 73.0, 71.0, 70.0, 68.0, 67.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1580.3999999999999, "alertThreshold": 2.0}]} 11:57:40 INFO - Return code: 0 11:57:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:57:41 INFO - # TBPL SUCCESS # 11:57:41 INFO - Running post-action listener: _resource_record_post_action 11:57:41 INFO - [mozharness: 2016-08-23 18:57:41.007411Z] Finished run-tests step (success) 11:57:41 INFO - Running post-run listener: _resource_record_post_run 11:57:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 406822912; Read time: 0; Write time: 218724 11:57:41 INFO - TinderboxPrint: CPU usage
13.2% 11:57:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:57:41 INFO - TinderboxPrint: I/O write bytes / time
406,822,912 / 218,724 11:57:41 INFO - TinderboxPrint: CPU idle
8,328.5 (86.8%) 11:57:41 INFO - TinderboxPrint: CPU user
1,204.7 (12.5%) 11:57:41 INFO - TinderboxPrint: Swap in / out
0 / 0 11:57:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113516544; Read time: 0; Write time: 71232 11:57:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292327424; Read time: 0; Write time: 147468 11:57:41 INFO - Running post-run listener: _upload_blobber_files 11:57:41 INFO - Blob upload gear active. 11:57:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:57:41 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 11:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:57:42 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:42 INFO - (blobuploader) - INFO - Done attempting. 11:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:57:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:43 INFO - (blobuploader) - INFO - Done attempting. 11:57:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:57:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:47 INFO - (blobuploader) - INFO - Done attempting. 11:57:47 INFO - (blobuploader) - INFO - Iteration through files over. 11:57:47 INFO - Return code: 0 11:57:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:57:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:57:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a708b09593bfcd7cb41427d44615988545b73b2854c633da09f51b4ed6872a8a06048dbb7ecd11e9ab0443e4a91573cb402cc4e46a656eb7679bdd32bb19b78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e902c0e7dc50d9dd3fa97b42f17596ac52547e8dad34d2a890dbb2470bda8190017dcf4eacd21a6a9393751dc172393e830e80f970da719fc5713239ce4595", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d9df4cabd3877758bce0afe1645e2679f09b4e72bbad60757f99cf089051540595686d4f3ad9fe1aee7ce290bcadaa21ddb38ef3c88fcec6158dd5841e6bc34"} 11:57:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:57:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:57:47 INFO - Contents: 11:57:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a708b09593bfcd7cb41427d44615988545b73b2854c633da09f51b4ed6872a8a06048dbb7ecd11e9ab0443e4a91573cb402cc4e46a656eb7679bdd32bb19b78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e902c0e7dc50d9dd3fa97b42f17596ac52547e8dad34d2a890dbb2470bda8190017dcf4eacd21a6a9393751dc172393e830e80f970da719fc5713239ce4595", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d9df4cabd3877758bce0afe1645e2679f09b4e72bbad60757f99cf089051540595686d4f3ad9fe1aee7ce290bcadaa21ddb38ef3c88fcec6158dd5841e6bc34"} 11:57:47 INFO - Running post-run listener: copy_logs_to_upload_dir 11:57:47 INFO - Copying logs to upload dir... 11:57:47 INFO - mkdir: /builds/slave/test/build/upload/logs 11:57:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.017822 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 11:57:47.630613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:47.634406) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 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-Non-PGO/sha512/a708b09593bfcd7cb41427d44615988545b73b2854c633da09f51b4ed6872a8a06048dbb7ecd11e9ab0443e4a91573cb402cc4e46a656eb7679bdd32bb19b78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e902c0e7dc50d9dd3fa97b42f17596ac52547e8dad34d2a890dbb2470bda8190017dcf4eacd21a6a9393751dc172393e830e80f970da719fc5713239ce4595", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d9df4cabd3877758bce0afe1645e2679f09b4e72bbad60757f99cf089051540595686d4f3ad9fe1aee7ce290bcadaa21ddb38ef3c88fcec6158dd5841e6bc34"} build_url:https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/TtWoa8L8TjOWiu-gs17hsg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a708b09593bfcd7cb41427d44615988545b73b2854c633da09f51b4ed6872a8a06048dbb7ecd11e9ab0443e4a91573cb402cc4e46a656eb7679bdd32bb19b78d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e902c0e7dc50d9dd3fa97b42f17596ac52547e8dad34d2a890dbb2470bda8190017dcf4eacd21a6a9393751dc172393e830e80f970da719fc5713239ce4595", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7d9df4cabd3877758bce0afe1645e2679f09b4e72bbad60757f99cf089051540595686d4f3ad9fe1aee7ce290bcadaa21ddb38ef3c88fcec6158dd5841e6bc34"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:47.659696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:47.663697) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1471977418.429258-219634254 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:57:47.743145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:57:47.743518) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:57:47.743874) ========= ========= Total master_lag: 0.16 =========