builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1470951508.91 results: success (0) buildid: 20160811130435 builduid: 70e0739b3ec8487e810ac7c5345c6832 revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:28.913470) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:28.913905) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:28.914182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:28.931189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:28.931476) ========= 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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 14:38:29-- 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% 9.74M=0.001s 2016-08-11 14:38:29 (9.74 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128308 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.073624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.073943) ========= 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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.123121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.123478) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b --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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 14:38:29,592 truncating revision to first 12 chars 2016-08-11 14:38:29,592 Setting DEBUG logging. 2016-08-11 14:38:29,592 attempt 1/10 2016-08-11 14:38:29,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61340bd78a4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 14:38:29,914 unpacking tar archive at: fx-team-61340bd78a4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.790080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.790411) ========= script_repo_revision: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.790786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.791048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 14:38:29.799656) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 14:38:29.799920) ========= /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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:38:30 INFO - MultiFileLogger online at 20160811 14:38:30 in /builds/slave/test 14:38:30 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 14:38:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:30 INFO - {'append_to_log': False, 14:38:30 INFO - 'base_work_dir': '/builds/slave/test', 14:38:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:38:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:30 INFO - 'branch': 'Fx-Team-Non-PGO', 14:38:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:30 INFO - 'config_files': ('talos/linux_config.py',), 14:38:30 INFO - 'default_actions': ('clobber', 14:38:30 INFO - 'read-buildbot-config', 14:38:30 INFO - 'download-and-extract', 14:38:30 INFO - 'populate-webroot', 14:38:30 INFO - 'create-virtualenv', 14:38:30 INFO - 'install', 14:38:30 INFO - 'run-tests'), 14:38:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:30 INFO - 'download_minidump_stackwalk': True, 14:38:30 INFO - 'download_symbols': 'ondemand', 14:38:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:30 INFO - 'installer_path': 'installer.exe', 14:38:30 INFO - 'log_level': 'info', 14:38:30 INFO - 'log_name': 'talos', 14:38:30 INFO - 'log_to_console': True, 14:38:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:38:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:38:30 INFO - 'opt_config_files': (), 14:38:30 INFO - 'pip_index': False, 14:38:30 INFO - 'sps_profile': False, 14:38:30 INFO - 'sps_profile_interval': 0, 14:38:30 INFO - 'suite': 'dromaeojs', 14:38:30 INFO - 'system_bits': '32', 14:38:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:30 INFO - 'title': 'talos-linux64-ix-035', 14:38:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:30 INFO - 'use_talos_json': True, 14:38:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:30 INFO - 'work_dir': 'build'} 14:38:30 INFO - [mozharness: 2016-08-11 21:38:30.357033Z] Running clobber step. 14:38:30 INFO - Running pre-action listener: _resource_record_pre_action 14:38:30 INFO - Running main action method: clobber 14:38:30 INFO - rmtree: /builds/slave/test/build 14:38:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:31 INFO - Running post-action listener: _resource_record_post_action 14:38:31 INFO - [mozharness: 2016-08-11 21:38:31.325780Z] Finished clobber step (success) 14:38:31 INFO - [mozharness: 2016-08-11 21:38:31.325881Z] Running read-buildbot-config step. 14:38:31 INFO - Running pre-action listener: _resource_record_pre_action 14:38:31 INFO - Running main action method: read_buildbot_config 14:38:31 INFO - Using buildbot properties: 14:38:31 INFO - { 14:38:31 INFO - "project": "", 14:38:31 INFO - "product": "firefox", 14:38:31 INFO - "script_repo_revision": "production", 14:38:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:38:31 INFO - "repository": "", 14:38:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:38:31 INFO - "buildid": "20160811130435", 14:38:31 INFO - "pgo_build": "False", 14:38:31 INFO - "basedir": "/builds/slave/test", 14:38:31 INFO - "buildnumber": 3229, 14:38:31 INFO - "slavename": "talos-linux64-ix-035", 14:38:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:38:31 INFO - "platform": "ubuntu64_hw", 14:38:31 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 14:38:31 INFO - "branch": "fx-team", 14:38:31 INFO - "repo_path": "integration/fx-team", 14:38:31 INFO - "revision": "61340bd78a4bf05890f4b84a6ca57ba01c0ee29b", 14:38:31 INFO - "stage_platform": "linux64", 14:38:31 INFO - "builduid": "70e0739b3ec8487e810ac7c5345c6832", 14:38:31 INFO - "slavebuilddir": "test" 14:38:31 INFO - } 14:38:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 14:38:31 INFO - Running post-action listener: _resource_record_post_action 14:38:31 INFO - [mozharness: 2016-08-11 21:38:31.328617Z] Finished read-buildbot-config step (success) 14:38:31 INFO - [mozharness: 2016-08-11 21:38:31.328707Z] Running download-and-extract step. 14:38:31 INFO - Running pre-action listener: _resource_record_pre_action 14:38:31 INFO - Running main action method: download_and_extract 14:38:31 INFO - mkdir: /builds/slave/test/build/tests 14:38:31 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')]} 14:38:31 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:38:31 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:31 INFO - Downloaded 1361 bytes. 14:38:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 14:38:31 INFO - Using the following test package requirements: 14:38:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:38:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:38:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'jsshell-linux-x86_64.zip'], 14:38:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:38:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:38:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:38:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:38:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:38:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:38:31 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')]} 14:38:31 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:38:31 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:32 INFO - Downloaded 20262322 bytes. 14:38:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:38:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:38:33 INFO - Return code: 0 14:38:33 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 14:38: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')]} 14:38:33 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 14:38:33 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:35 INFO - Downloaded 20262322 bytes. 14:38:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:38:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:38:36 INFO - Return code: 0 14:38:36 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')]} 14:38:36 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 14:38:36 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:37 INFO - Downloaded 14413719 bytes. 14:38:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:38:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:38:37 INFO - Return code: 0 14:38: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')]} 14:38:37 INFO - trying https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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 14:38:38 INFO - Downloaded 55620330 bytes. 14:38:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:38:38 INFO - mkdir: /builds/slave/test/properties 14:38:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:38:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:38:38 INFO - Contents: 14:38:38 INFO - build_url:https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 14:38:39 INFO - Running post-action listener: _resource_record_post_action 14:38:39 INFO - Running post-action listener: set_extra_try_arguments 14:38:39 INFO - [mozharness: 2016-08-11 21:38:39.447015Z] Finished download-and-extract step (success) 14:38:39 INFO - [mozharness: 2016-08-11 21:38:39.447247Z] Running populate-webroot step. 14:38:39 INFO - Running pre-action listener: _resource_record_pre_action 14:38:39 INFO - Running main action method: populate_webroot 14:38:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:38:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:38:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:38:39 INFO - '--tppagecycles', 14:38:39 INFO - '7'], 14:38:39 INFO - 'tests': ['tsvgm']}}, 14:38:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:38:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:38:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:38:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:38:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['damp', 'tps']}, 14:38:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'tests': ['damp', 'tps']}, 14:38:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['dromaeo_dom']}, 14:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:38:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['basic_compositor_video']}, 14:38:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:38:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['a11yr', 14:38:39 INFO - 'ts_paint', 14:38:39 INFO - 'tpaint', 14:38:39 INFO - 'sessionrestore', 14:38:39 INFO - 'sessionrestore_no_auto_restore', 14:38:39 INFO - 'tabpaint']}, 14:38:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['tsvgx', 14:38:39 INFO - 'tsvgr_opacity', 14:38:39 INFO - 'tart', 14:38:39 INFO - 'tscrollx', 14:38:39 INFO - 'cart']}, 14:38:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:38:39 INFO - 'tsvgr_opacity', 14:38:39 INFO - 'tart', 14:38:39 INFO - 'tscrollx', 14:38:39 INFO - 'cart']}, 14:38:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'talos_options': ['--disable-e10s'], 14:38:39 INFO - 'tests': ['tp5o']}, 14:38:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'tests': ['tp5o']}, 14:38:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'talos_options': ['--disable-e10s', 14:38:39 INFO - '--xperf_path', 14:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:39 INFO - 'tests': ['tp5n']}, 14:38:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:39 INFO - 'talos_options': ['--xperf_path', 14:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:39 INFO - 'tests': ['tp5n']}}, 14:38:39 INFO - 'talos.zip': {'path': '', 14:38:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:38:39 INFO - Running post-action listener: _resource_record_post_action 14:38:39 INFO - [mozharness: 2016-08-11 21:38:39.463732Z] Finished populate-webroot step (success) 14:38:39 INFO - [mozharness: 2016-08-11 21:38:39.463821Z] Running create-virtualenv step. 14:38:39 INFO - Running pre-action listener: _resource_record_pre_action 14:38:39 INFO - Running main action method: create_virtualenv 14:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:38:39 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 14:38:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:38:39 INFO - Using real prefix '/usr' 14:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:38:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:38:42 INFO - Installing pip.................done. 14:38:42 INFO - Return code: 0 14:38:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:38:42 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')]} 14:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:42 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')]} 14:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:42 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:42 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 14:38:42 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 14:38:42 INFO - Using env: {'DISPLAY': ':0', 14:38:42 INFO - 'HOME': '/home/cltbld', 14:38:42 INFO - 'LANG': 'en_US.UTF-8', 14:38:42 INFO - 'LANGUAGE': 'en_US:en', 14:38:42 INFO - 'LOGNAME': 'cltbld', 14:38:42 INFO - 'MAIL': '/var/mail/cltbld', 14:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:42 INFO - 'MOZ_NO_REMOTE': '1', 14:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:42 INFO - 'NO_EM_RESTART': '1', 14:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:42 INFO - 'PWD': '/builds/slave/test', 14:38:42 INFO - 'SHELL': '/bin/bash', 14:38:42 INFO - 'SHLVL': '1', 14:38:42 INFO - 'TERM': 'linux', 14:38:42 INFO - 'TMOUT': '86400', 14:38:42 INFO - 'USER': 'cltbld', 14:38:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:42 INFO - '_': '/tools/buildbot/bin/python'} 14:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:42 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 14:38:42 INFO - Cleaning up... 14:38:42 INFO - Return code: 0 14:38:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:38:42 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')]} 14:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:42 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')]} 14:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:42 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:42 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 14:38:42 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 14:38:42 INFO - Using env: {'DISPLAY': ':0', 14:38:42 INFO - 'HOME': '/home/cltbld', 14:38:42 INFO - 'LANG': 'en_US.UTF-8', 14:38:42 INFO - 'LANGUAGE': 'en_US:en', 14:38:42 INFO - 'LOGNAME': 'cltbld', 14:38:42 INFO - 'MAIL': '/var/mail/cltbld', 14:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:42 INFO - 'MOZ_NO_REMOTE': '1', 14:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:42 INFO - 'NO_EM_RESTART': '1', 14:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:42 INFO - 'PWD': '/builds/slave/test', 14:38:42 INFO - 'SHELL': '/bin/bash', 14:38:42 INFO - 'SHLVL': '1', 14:38:42 INFO - 'TERM': 'linux', 14:38:42 INFO - 'TMOUT': '86400', 14:38:42 INFO - 'USER': 'cltbld', 14:38:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:42 INFO - '_': '/tools/buildbot/bin/python'} 14:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:42 INFO - Downloading/unpacking psutil>=3.1.1 14:38:42 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 14:38:42 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 14:38:42 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 14:38:42 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 14:38:42 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 14:38:42 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 14:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:44 INFO - Installing collected packages: psutil 14:38:44 INFO - Running setup.py install for psutil 14:38:44 INFO - building 'psutil._psutil_linux' extension 14:38:44 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 14:38:44 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 14:38:44 INFO - building 'psutil._psutil_posix' extension 14:38:44 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 14:38:44 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 14:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:45 INFO - Successfully installed psutil 14:38:45 INFO - Cleaning up... 14:38:45 INFO - Return code: 0 14:38:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:45 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:45 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 14:38:45 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 14:38:45 INFO - Using env: {'DISPLAY': ':0', 14:38:45 INFO - 'HOME': '/home/cltbld', 14:38:45 INFO - 'LANG': 'en_US.UTF-8', 14:38:45 INFO - 'LANGUAGE': 'en_US:en', 14:38:45 INFO - 'LOGNAME': 'cltbld', 14:38:45 INFO - 'MAIL': '/var/mail/cltbld', 14:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:45 INFO - 'MOZ_NO_REMOTE': '1', 14:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:45 INFO - 'NO_EM_RESTART': '1', 14:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:45 INFO - 'PWD': '/builds/slave/test', 14:38:45 INFO - 'SHELL': '/bin/bash', 14:38:45 INFO - 'SHLVL': '1', 14:38:45 INFO - 'TERM': 'linux', 14:38:45 INFO - 'TMOUT': '86400', 14:38:45 INFO - 'USER': 'cltbld', 14:38:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:45 INFO - '_': '/tools/buildbot/bin/python'} 14:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:38:45 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 14:38:45 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 14:38:45 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 14:38:45 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 14:38:45 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 14:38:45 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 14:38:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:38:47 INFO - Installing collected packages: mozsystemmonitor 14:38:47 INFO - Running setup.py install for mozsystemmonitor 14:38:47 INFO - Successfully installed mozsystemmonitor 14:38:47 INFO - Cleaning up... 14:38:47 INFO - Return code: 0 14:38:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:38:47 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')]} 14:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:47 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')]} 14:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:47 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:47 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 14:38:47 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 14:38:47 INFO - Using env: {'DISPLAY': ':0', 14:38:47 INFO - 'HOME': '/home/cltbld', 14:38:47 INFO - 'LANG': 'en_US.UTF-8', 14:38:47 INFO - 'LANGUAGE': 'en_US:en', 14:38:47 INFO - 'LOGNAME': 'cltbld', 14:38:47 INFO - 'MAIL': '/var/mail/cltbld', 14:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:47 INFO - 'MOZ_NO_REMOTE': '1', 14:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:47 INFO - 'NO_EM_RESTART': '1', 14:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:47 INFO - 'PWD': '/builds/slave/test', 14:38:47 INFO - 'SHELL': '/bin/bash', 14:38:47 INFO - 'SHLVL': '1', 14:38:47 INFO - 'TERM': 'linux', 14:38:47 INFO - 'TMOUT': '86400', 14:38:47 INFO - 'USER': 'cltbld', 14:38:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:47 INFO - '_': '/tools/buildbot/bin/python'} 14:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:47 INFO - Downloading/unpacking jsonschema==2.5.1 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:38:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:38:49 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 14:38:49 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 14:38:49 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 14:38:49 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 14:38:49 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 14:38:49 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 14:38:49 INFO - Downloading functools32-3.2.3-2.tar.gz 14:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:38:49 INFO - warning: no files found matching '*.txt' 14:38:49 INFO - no previously-included directories found matching 'build' 14:38:49 INFO - no previously-included directories found matching 'dist' 14:38:49 INFO - no previously-included directories found matching '.git*' 14:38:49 INFO - Installing collected packages: jsonschema, functools32 14:38:49 INFO - Running setup.py install for functools32 14:38:49 INFO - warning: no files found matching '*.txt' 14:38:49 INFO - no previously-included directories found matching 'build' 14:38:49 INFO - no previously-included directories found matching 'dist' 14:38:49 INFO - no previously-included directories found matching '.git*' 14:38:49 INFO - Successfully installed jsonschema functools32 14:38:49 INFO - Cleaning up... 14:38:49 INFO - Return code: 0 14:38:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:38:49 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')]} 14:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:49 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')]} 14:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:49 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:49 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 14:38:49 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 14:38:49 INFO - Using env: {'DISPLAY': ':0', 14:38:49 INFO - 'HOME': '/home/cltbld', 14:38:49 INFO - 'LANG': 'en_US.UTF-8', 14:38:49 INFO - 'LANGUAGE': 'en_US:en', 14:38:49 INFO - 'LOGNAME': 'cltbld', 14:38:49 INFO - 'MAIL': '/var/mail/cltbld', 14:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:49 INFO - 'MOZ_NO_REMOTE': '1', 14:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:49 INFO - 'NO_EM_RESTART': '1', 14:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:49 INFO - 'PWD': '/builds/slave/test', 14:38:49 INFO - 'SHELL': '/bin/bash', 14:38:49 INFO - 'SHLVL': '1', 14:38:49 INFO - 'TERM': 'linux', 14:38:49 INFO - 'TMOUT': '86400', 14:38:49 INFO - 'USER': 'cltbld', 14:38:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:49 INFO - '_': '/tools/buildbot/bin/python'} 14:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:38:50 INFO - Cleaning up... 14:38:50 INFO - Return code: 0 14:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:50 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:50 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 14:38:50 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 14:38:50 INFO - Using env: {'DISPLAY': ':0', 14:38:50 INFO - 'HOME': '/home/cltbld', 14:38:50 INFO - 'LANG': 'en_US.UTF-8', 14:38:50 INFO - 'LANGUAGE': 'en_US:en', 14:38:50 INFO - 'LOGNAME': 'cltbld', 14:38:50 INFO - 'MAIL': '/var/mail/cltbld', 14:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:50 INFO - 'MOZ_NO_REMOTE': '1', 14:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:50 INFO - 'NO_EM_RESTART': '1', 14:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:50 INFO - 'PWD': '/builds/slave/test', 14:38:50 INFO - 'SHELL': '/bin/bash', 14:38:50 INFO - 'SHLVL': '1', 14:38:50 INFO - 'TERM': 'linux', 14:38:50 INFO - 'TMOUT': '86400', 14:38:50 INFO - 'USER': 'cltbld', 14:38:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:50 INFO - '_': '/tools/buildbot/bin/python'} 14:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 14:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:38:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:38:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 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 14:38:52 INFO - Downloading docopt-0.6.1.tar.gz 14:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:38:53 INFO - Installing collected packages: blobuploader, requests, docopt 14:38:53 INFO - Running setup.py install for blobuploader 14:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:38:53 INFO - Running setup.py install for requests 14:38:53 INFO - Running setup.py install for docopt 14:38:53 INFO - Successfully installed blobuploader requests docopt 14:38:53 INFO - Cleaning up... 14:38:53 INFO - Return code: 0 14:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:53 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')]} 14:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:53 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')]} 14:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:53 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:53 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 14:38:53 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 14:38:53 INFO - Using env: {'DISPLAY': ':0', 14:38:53 INFO - 'HOME': '/home/cltbld', 14:38:53 INFO - 'LANG': 'en_US.UTF-8', 14:38:53 INFO - 'LANGUAGE': 'en_US:en', 14:38:53 INFO - 'LOGNAME': 'cltbld', 14:38:53 INFO - 'MAIL': '/var/mail/cltbld', 14:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:53 INFO - 'MOZ_NO_REMOTE': '1', 14:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:53 INFO - 'NO_EM_RESTART': '1', 14:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:53 INFO - 'PWD': '/builds/slave/test', 14:38:53 INFO - 'SHELL': '/bin/bash', 14:38:53 INFO - 'SHLVL': '1', 14:38:53 INFO - 'TERM': 'linux', 14:38:53 INFO - 'TMOUT': '86400', 14:38:53 INFO - 'USER': 'cltbld', 14:38:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:53 INFO - '_': '/tools/buildbot/bin/python'} 14:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:53 INFO - Running setup.py (path:/tmp/pip-XAg7xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:53 INFO - Running setup.py (path:/tmp/pip-SReG80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:53 INFO - Running setup.py (path:/tmp/pip-e2U9Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:54 INFO - Running setup.py (path:/tmp/pip-ly8l8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:54 INFO - Running setup.py (path:/tmp/pip-AzFtqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:54 INFO - Running setup.py (path:/tmp/pip-f7hZMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:54 INFO - Running setup.py (path:/tmp/pip-Qnz_hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:54 INFO - Running setup.py (path:/tmp/pip-9K5jfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:54 INFO - Running setup.py (path:/tmp/pip-EPt4Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:54 INFO - Running setup.py (path:/tmp/pip-qZQhyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:54 INFO - Running setup.py (path:/tmp/pip-pXZTt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:54 INFO - Running setup.py (path:/tmp/pip-Huvq5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:54 INFO - Running setup.py (path:/tmp/pip-1lE8bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:54 INFO - Running setup.py (path:/tmp/pip-JRh7f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:54 INFO - Running setup.py (path:/tmp/pip-TpVQk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:54 INFO - Running setup.py (path:/tmp/pip-qhs2MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:55 INFO - Running setup.py (path:/tmp/pip-ZTVoSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:38:55 INFO - Running setup.py install for manifestparser 14:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Running setup.py install for mozcrash 14:38:55 INFO - Running setup.py install for mozdebug 14:38:55 INFO - Running setup.py install for mozdevice 14:38:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Running setup.py install for mozfile 14:38:55 INFO - Running setup.py install for mozhttpd 14:38:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Running setup.py install for mozinfo 14:38:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Running setup.py install for mozInstall 14:38:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:38:55 INFO - Running setup.py install for mozleak 14:38:55 INFO - Running setup.py install for mozlog 14:38:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Running setup.py install for moznetwork 14:38:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Running setup.py install for mozprocess 14:38:56 INFO - Running setup.py install for mozprofile 14:38:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Running setup.py install for mozrunner 14:38:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Running setup.py install for mozscreenshot 14:38:56 INFO - Running setup.py install for moztest 14:38:56 INFO - Running setup.py install for mozversion 14:38:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:38:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:38:56 INFO - Cleaning up... 14:38:56 INFO - Return code: 0 14:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:56 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:38:56 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 14:38:56 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 14:38:56 INFO - Using env: {'DISPLAY': ':0', 14:38:56 INFO - 'HOME': '/home/cltbld', 14:38:56 INFO - 'LANG': 'en_US.UTF-8', 14:38:56 INFO - 'LANGUAGE': 'en_US:en', 14:38:56 INFO - 'LOGNAME': 'cltbld', 14:38:56 INFO - 'MAIL': '/var/mail/cltbld', 14:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:56 INFO - 'MOZ_NO_REMOTE': '1', 14:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:56 INFO - 'NO_EM_RESTART': '1', 14:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:56 INFO - 'PWD': '/builds/slave/test', 14:38:56 INFO - 'SHELL': '/bin/bash', 14:38:56 INFO - 'SHLVL': '1', 14:38:56 INFO - 'TERM': 'linux', 14:38:56 INFO - 'TMOUT': '86400', 14:38:56 INFO - 'USER': 'cltbld', 14:38:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:56 INFO - '_': '/tools/buildbot/bin/python'} 14:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:57 INFO - Running setup.py (path:/tmp/pip-oA3yFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:57 INFO - Running setup.py (path:/tmp/pip-CLWsSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:57 INFO - Running setup.py (path:/tmp/pip-KHVv74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:57 INFO - Running setup.py (path:/tmp/pip-YcuZzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:57 INFO - Running setup.py (path:/tmp/pip-bLXRMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:57 INFO - Running setup.py (path:/tmp/pip-T3GDw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:57 INFO - Running setup.py (path:/tmp/pip-CL31hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:57 INFO - Running setup.py (path:/tmp/pip-b3Yjsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:57 INFO - Running setup.py (path:/tmp/pip-66sdBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:57 INFO - Running setup.py (path:/tmp/pip-BzD2_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:57 INFO - Running setup.py (path:/tmp/pip-ignwbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:57 INFO - Running setup.py (path:/tmp/pip-yLpofG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:57 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)) 14:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:57 INFO - Running setup.py (path:/tmp/pip-TRrAOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:58 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)) 14:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:58 INFO - Running setup.py (path:/tmp/pip-yayAN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:58 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)) 14:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:58 INFO - Running setup.py (path:/tmp/pip-yHeDXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:58 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)) 14:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:58 INFO - Running setup.py (path:/tmp/pip-o_NOXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:58 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)) 14:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:58 INFO - Running setup.py (path:/tmp/pip-trKKr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:58 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)) 14:38:58 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)) 14:38:58 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)) 14:38:58 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)) 14:38:58 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)) 14:38:58 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)) 14:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:39:00 INFO - Downloading blessings-1.6.tar.gz 14:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:00 INFO - Installing collected packages: blessings 14:39:00 INFO - Running setup.py install for blessings 14:39:00 INFO - Successfully installed blessings 14:39:00 INFO - Cleaning up... 14:39:00 INFO - Return code: 0 14:39:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:00 INFO - Reading from file tmpfile_stdout 14:39:00 INFO - Current package versions: 14:39:00 INFO - argparse == 1.2.1 14:39:00 INFO - blessings == 1.6 14:39:00 INFO - blobuploader == 1.2.4 14:39:00 INFO - docopt == 0.6.1 14:39:00 INFO - functools32 == 3.2.3-2 14:39:00 INFO - jsonschema == 2.5.1 14:39:00 INFO - manifestparser == 1.1 14:39:00 INFO - mozInstall == 1.12 14:39:00 INFO - mozcrash == 0.17 14:39:00 INFO - mozdebug == 0.1 14:39:00 INFO - mozdevice == 0.48 14:39:00 INFO - mozfile == 1.2 14:39:00 INFO - mozhttpd == 0.7 14:39:00 INFO - mozinfo == 0.9 14:39:00 INFO - mozleak == 0.1 14:39:00 INFO - mozlog == 3.3 14:39:00 INFO - moznetwork == 0.27 14:39:00 INFO - mozprocess == 0.23 14:39:00 INFO - mozprofile == 0.28 14:39:00 INFO - mozrunner == 6.12 14:39:00 INFO - mozscreenshot == 0.1 14:39:00 INFO - mozsystemmonitor == 0.3 14:39:00 INFO - moztest == 0.7 14:39:00 INFO - mozversion == 1.4 14:39:00 INFO - psutil == 3.1.1 14:39:00 INFO - requests == 1.2.3 14:39:00 INFO - wsgiref == 0.1.2 14:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:00 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:39:00 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 14:39:00 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 14:39:00 INFO - Using env: {'DISPLAY': ':0', 14:39:00 INFO - 'HOME': '/home/cltbld', 14:39:00 INFO - 'LANG': 'en_US.UTF-8', 14:39:00 INFO - 'LANGUAGE': 'en_US:en', 14:39:00 INFO - 'LOGNAME': 'cltbld', 14:39:00 INFO - 'MAIL': '/var/mail/cltbld', 14:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:00 INFO - 'MOZ_NO_REMOTE': '1', 14:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:00 INFO - 'NO_EM_RESTART': '1', 14:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:00 INFO - 'PWD': '/builds/slave/test', 14:39:00 INFO - 'SHELL': '/bin/bash', 14:39:00 INFO - 'SHLVL': '1', 14:39:00 INFO - 'TERM': 'linux', 14:39:00 INFO - 'TMOUT': '86400', 14:39:00 INFO - 'USER': 'cltbld', 14:39:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:00 INFO - '_': '/tools/buildbot/bin/python'} 14:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 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)) 14:39:00 INFO - Cleaning up... 14:39:00 INFO - Return code: 0 14:39:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1172180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', '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 14:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:39:00 INFO - Using env: {'DISPLAY': ':0', 14:39:00 INFO - 'HOME': '/home/cltbld', 14:39:00 INFO - 'LANG': 'en_US.UTF-8', 14:39:00 INFO - 'LANGUAGE': 'en_US:en', 14:39:00 INFO - 'LOGNAME': 'cltbld', 14:39:00 INFO - 'MAIL': '/var/mail/cltbld', 14:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:00 INFO - 'MOZ_NO_REMOTE': '1', 14:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:00 INFO - 'NO_EM_RESTART': '1', 14:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:00 INFO - 'PWD': '/builds/slave/test', 14:39:00 INFO - 'SHELL': '/bin/bash', 14:39:00 INFO - 'SHLVL': '1', 14:39:00 INFO - 'TERM': 'linux', 14:39:00 INFO - 'TMOUT': '86400', 14:39:00 INFO - 'USER': 'cltbld', 14:39:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:00 INFO - '_': '/tools/buildbot/bin/python'} 14:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:39:01 INFO - Cleaning up... 14:39:01 INFO - Return code: 0 14:39:01 INFO - Running post-action listener: _resource_record_post_action 14:39:01 INFO - Running post-action listener: _start_resource_monitoring 14:39:01 INFO - Starting resource monitoring. 14:39:01 INFO - [mozharness: 2016-08-11 21:39:01.106133Z] Finished create-virtualenv step (success) 14:39:01 INFO - [mozharness: 2016-08-11 21:39:01.106562Z] Running install step. 14:39:01 INFO - Running pre-action listener: _resource_record_pre_action 14:39:01 INFO - Running main action method: install 14:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:01 INFO - Reading from file tmpfile_stdout 14:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:01 INFO - Reading from file tmpfile_stdout 14:39:01 INFO - Output received: 14:39:01 INFO - Usage: mozinstall [options] installer 14:39:01 INFO - Options: 14:39:01 INFO - -h, --help show this help message and exit 14:39:01 INFO - -d DEST, --destination=DEST 14:39:01 INFO - Directory to install application into. [default: 14:39:01 INFO - "/builds/slave/test"] 14:39:01 INFO - --app=APP Application being installed. [default: firefox] 14:39:01 INFO - mkdir: /builds/slave/test/build/application 14:39:01 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'] 14:39:01 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 14:39:17 INFO - Reading from file tmpfile_stdout 14:39:17 INFO - Output received: 14:39:17 INFO - /builds/slave/test/build/application/firefox/firefox 14:39:17 INFO - Running post-action listener: _resource_record_post_action 14:39:17 INFO - [mozharness: 2016-08-11 21:39:17.458808Z] Finished install step (success) 14:39:17 INFO - [mozharness: 2016-08-11 21:39:17.459055Z] Running run-tests step. 14:39:17 INFO - Running pre-action listener: _resource_record_pre_action 14:39:17 INFO - Running main action method: run_tests 14:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:39:17 INFO - Python 2.7.3 14:39:17 INFO - Return code: 0 14:39:17 INFO - grabbing minidump binary from tooltool 14:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:17 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 0x11703b0>, '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 0x11712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1171740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:39:17 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 14:39:17 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 14:39:17 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 14:39:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:39:17 INFO - Return code: 0 14:39:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:39:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:39:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:39:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:39:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:39:17 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/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 14:39:17 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/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 14:39:17 INFO - Using env: {'DISPLAY': ':0', 14:39:17 INFO - 'HOME': '/home/cltbld', 14:39:17 INFO - 'LANG': 'en_US.UTF-8', 14:39:17 INFO - 'LANGUAGE': 'en_US:en', 14:39:17 INFO - 'LOGNAME': 'cltbld', 14:39:17 INFO - 'MAIL': '/var/mail/cltbld', 14:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:17 INFO - 'MOZ_NO_REMOTE': '1', 14:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:17 INFO - 'NO_EM_RESTART': '1', 14:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:17 INFO - 'PWD': '/builds/slave/test', 14:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:17 INFO - 'SHELL': '/bin/bash', 14:39:17 INFO - 'SHLVL': '1', 14:39:17 INFO - 'TERM': 'linux', 14:39:17 INFO - 'TMOUT': '86400', 14:39:17 INFO - 'USER': 'cltbld', 14:39:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895', 14:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:17 INFO - '_': '/tools/buildbot/bin/python'} 14:39:17 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/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 14:39:17 INFO - mozversion application_buildid: 20160811130435 14:39:17 INFO - mozversion application_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 14:39:17 INFO - mozversion application_display_name: Nightly 14:39:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:39:17 INFO - mozversion application_name: Firefox 14:39:17 INFO - mozversion application_remotingname: firefox 14:39:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:39:17 INFO - mozversion application_vendor: Mozilla 14:39:17 INFO - mozversion application_version: 51.0a1 14:39:17 INFO - mozversion platform_buildid: 20160811130435 14:39:17 INFO - mozversion platform_changeset: 61340bd78a4bf05890f4b84a6ca57ba01c0ee29b 14:39:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:39:17 INFO - mozversion platform_version: 51.0a1 14:39:17 INFO - using testdate: 1470951557 14:39:17 INFO - actual date: 1470951557 14:39:17 INFO - starting webserver on 'localhost:57724' 14:39:17 INFO - SUITE-START | Running 2 tests 14:39:17 INFO - TEST-START | dromaeo_css 14:39:17 INFO - operating with platform_type : linux_ 14:39:17 INFO - Initialising browser for dromaeo_css test... 14:39:17 INFO - TEST-INFO | started process 17210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp7SUQ/profile http://localhost:57724/getInfo.html) 14:39:21 INFO - PROCESS | 17210 | __metrics Screen width/height:1600/1200 14:39:21 INFO - PROCESS | 17210 | colorDepth:24 14:39:21 INFO - PROCESS | 17210 | Browser inner width/height: 1024/697 14:39:21 INFO - PROCESS | 17210 | __metrics 14:39:22 INFO - PROCESS | 17210 | 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" 14:39:22 INFO - PROCESS | 17210 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:39:23 INFO - TEST-INFO | 17210: exit 0 14:39:23 INFO - Browser initialized. 14:39:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:39:23 INFO - TEST-INFO | started process 17288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOp7SUQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:35 INFO - PROCESS | 17288 | RSS: Main: 157069312 14:39:35 INFO - PROCESS | 17288 | 14:40:26 INFO - PROCESS | 17288 | 1470951626368 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] 14:42:39 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57724/tests/dromaeo/cssquery-ext.html) 14:42:40 INFO - PROCESS | 17288 | RSS: Main: 273059840 14:42:40 INFO - PROCESS | 17288 | 14:45:43 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-ext.html (next: http://localhost:57724/tests/dromaeo/cssquery-jquery.html) 14:45:44 INFO - PROCESS | 17288 | RSS: Main: 250175488 14:45:44 INFO - PROCESS | 17288 | 14:48:46 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57724/tests/dromaeo/cssquery-mootools.html) 14:48:46 INFO - PROCESS | 17288 | RSS: Main: 187965440 14:48:46 INFO - PROCESS | 17288 | 14:51:49 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57724/tests/dromaeo/cssquery-prototype.html) 14:51:49 INFO - PROCESS | 17288 | RSS: Main: 221773824 14:51:49 INFO - PROCESS | 17288 | 14:54:52 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57724/tests/dromaeo/cssquery-yui.html) 14:54:53 INFO - PROCESS | 17288 | RSS: Main: 189685760 14:54:53 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | Cycle 1(1): loaded http://localhost:57724/tests/dromaeo/cssquery-yui.html (next: http://localhost:57724/tests/dromaeo/cssquery-dojo.html) 14:57:56 INFO - PROCESS | 17288 | RSS: Main: 225771520 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | __start_tp_report 14:57:56 INFO - PROCESS | 17288 | _x_x_mozilla_page_load 14:57:56 INFO - PROCESS | 17288 | _x_x_mozilla_page_load_details 14:57:56 INFO - PROCESS | 17288 | |i|pagename|runs| 14:57:56 INFO - PROCESS | 17288 | |0;dojo.html;2652.986735066325;2670.8798104085313;2698.9865050674744;2707.2284398946317;2710.1733971138806;4638.8608341749805;4711.882202944928;4800.90398192036;4942;4946.703197808134;4772.832950846721;4800.111979283835;4814.590759785414;4885.291632713263;4910.091633047879;4482.372467854503;4521.841735539257;4542.114287713897;4550.49944506104;4579.129965306598;4463.174312752151;4497.887552811173;4553.408056952591;4572.565606267399;4605.055963527486;4551.7724113794175;4554.863354099382;4578.771061446914;4595.058013107322;4595.701279416844;4273.551277115889;4465.307877279027;4494.752788596626;4523.027549076948;4528.660350473695;4284.314509678467;4388.934165987513;4431.091626216617;4434.911301773978;4497.685162038659;4808.783604737795;4824.300476430933;4876.122297986361;4876.195427754416;4881.780319885614;5248.448912864133;5259.184826351921;5259.842204733826;5260.447652996457;5265.394479634814;4872.366592342973;4973.62697797663;5123.077845987721;5205.531502164786;5281.260623512711;4905.533974272474;4906.681065730716;4910.582600478928;4910.90178196434;4922.040202160616;5366.758495867695;5375.7849686012905;5379.435159308295;5379.515843574019;5385.219143224211;4892.68197567157;5026.371703537058;5082.034413461431;5099.847004589868;5183.740812959337;5204.037253108111;5210.270562121306;5210.895782084337;5245.580353571705;5258.2375555544995;5136.614753893473;5157;5176.7411629418375;5182.196759502283;5227.320448341691;4923.975380123148;4983.07813054586;5001.374828146481;5149.665271757323;5162.174052151638;4222.662187025031;4285.207236661166;4288.656907447396;4319.287317592562;4332.1985432695055;3725.385311423585;3765.3034188675183;3766.8116594170183;3785.1104990327253;3800.9809950950066;4205.558416366299;4425;4461.174682683649;4471.150481408522;4478.39541661878;5216.321878155892;5249.081410753103;5270.973645131749;5312.5218730314455;5327.413984461706;4527.954720452819;4536.682432229778;4537.478190008125;4540.909181816412;4582.88542786433;4381.342798580238;4528.864134075983;4695.154872122982;4707.29390591414;4738.218193998021;4805.9038819224115;4809.398825146856;4840.467548569584;4869.391326084239;4888.95111048885;5115.5396014358885;5136.049830781318;5137;5137.152369858932;5188.688678679291;4671.509491503343;4866.780994855169;4936.950630493649;4953.801847926186;5003.949960500348;5090.974545127398;5158.252053452154;5161.561267292323;5181.55956743666;5203.8178663746585;5233.345831771028;5241.423443421144;5247.239150323258;5251.448597897166;5289.6032797539565;4834.081524510332;4932.235503496964;5060.2156665716875;5074.6194035448225;5076.441591424867;4949.010197960494;5023.472535383732;5023.648344615842;5057.8229761958155;5063.924041139312;4935.555799978019;4942.950570494249;4979.800807967786;4980.701157930391;4982.078315511642;4847.345608342828;4920.950790492192;5039.445660977363;5048.545630893237;5050.84847454577;4801.399825021872;4844.61243100544;4848.466668666373;4866.148424025852;4866.172750632471 14:57:56 INFO - PROCESS | 17288 | |1;ext.html;564.771267636607;567.8182981445939;574.1989924055941;578.2049681687679;578.4013545979911;28649.427011459757;39617.207655846905;40907.977300567465;41006.38490422646;44896.55103448965;41006.58993410065;41379.58620413795;41450.58549414505;41517.7924110379;41550;7699.3070623644;7869.370450363957;7872.803179920519;7872.842543149162;7877.8030549236155;7652.273034061755;7770.650320735581;7773.572453515055;7776.416768742367;7780.221977802203;7787.260210280015;7836.608169591497;7842.921570784276;7846.882296765524;7857.057153141631;7770.4560680752365;7804.804879877992;7809.648565814552;7815.0231221097365;7817.179196184433;7626.275503827128;7631.694732210705;7673.309402153777;7680.6159692015735;7690.769276921701;38579;38957.22085558273;39068.41397379042;39113.80443097766;39120.80439597784;2998.100569829064;3015.6079709637825;3028.6819883912094;3093.133922501703;3100.875964961399;28925.85537072322;29494.70505294941;29561.55657665137;30307.242318941982;30856.53715194274;3346.882859099944;3363.899083027513;3371.342588195303;3385.4075536780965;3403.3703764803345;184160;185220;185261;185515;185674;54258.45741542613;54704.72647636816;54727.17909231365;54744;54749.45250547523;33295.16762080919;34071.31857362889;34185;55954.72022639861;56408.43591564114;15100.244987750568;15313.387464501518;15321.387144514094;15325.46360877364;15341.386344546094;11535.596254131233;11647.59233426826;11655.417229138679;11675.065994720402;11678.70803229926;18373.438257747974;18445.446636600922;18479.44561663152;18488.907555462138;18539.72190417145;6638.236602790741;6879.486512967139;6888.965555172293;6924.376806087476;6998.195207551197;806.6571707024491;885.2740752582949;904.4347282948157;972.4991629310769;989.8317286061387;27505.449891002067;27562.862185688944;28026.719732802412;28161.295967600974;28260.15219543417;910.8633704944178;949.6106596295624;952.6514302227675;962.5860879821604;967.5936106835146;14351.282435878373;14918.328675209641;14965.92517037408;15059.397624095132;15306.846931530765;390711;394443;395374;396137;397132;48840.51159488431;49145.26282105771;49359.75320123376;49408.50591494039;49537.75231123893;1059.9629012984508;1098.4946924414699;1140.8745038045809;1160.2400427719688;1218.9939050304693;27859.303517412227;28503.58194479859;29302.85348573329;29893.103206902957;29898;42158.78920605377;42592;42654.36018459663;42682;42713.35929960991;290335;292325;292469;293027;293753;22826.201082962016;25722.35694107662;26473.602895956963;27618.72381276242;27658.308542286602;41711.582884171985;42169.578304216564;42261.78869105635;42447.5755242456;43716.12567748691;35231.647683523865;35764.46353304754;35845;36265.27469450649;36378.636213637525;35436.46845297374;36127.27745445024;36387.45418818667;36486.63513364832;36962;35275.82362088173;36191;36514.8174259127;36623;36651.633483664824;30033.249168770082;31355;31923.680763193;32250.516242256854;32566.34867302688;24902.50194996126;25061.24816255515;25095.623565646896;25297.367565810266;25388.74611253938 14:57:56 INFO - PROCESS | 17288 | |2;jquery.html;334.2879666310758;353.466265938433;359.24379181822263;360.13387802335376;367.26730173304264;12531.812022819653;12916.999999999989;13720.794188087175;16414.425495107673;16645.750313745302;16597.66804663909;16613.335466581324;16668.33326666935;16694.499165025038;16755.162241887916;4831.516848315176;4997.775100120485;5046.5710414614805;5078.162103252959;5081.898362032757;3697.796621185834;5074;5149.098907691157;5153.381594208681;5645.8588535286535;5911.556633252523;5988.7604495820115;6010.669413182273;6018;6020.969895150518;5823.126531020339;5956.047032474783;6004.969975150118;6019.819405417845;6021.217241758543;5242.60680448964;5276.076686579871;5284.524392804666;5286.471352864722;5289.2859463972645;19941.302054428026;20716.689249661267;20831.687524687142;20896.79103208979;21008.26471073505;2012.7987201279902;2097.2345094040716;2190.9811937449003;2399.460121472672;2534.239728081568;8603.655853765842;9104.908950910472;12874.420651070724;13197.406116724771;13777.448902043907;1709.880308378414;1771.4508502364179;1785.5179101642484;1814.1926842555067;1827;64147.67926160339;66840.33159668438;67765;69473.65263173652;71463.64268178625;9564.378315409476;9892.901070989197;9930.80138397228;10223.846642300372;10257.846132308021;13638;13665.726685466236;13699.246541440316;13702.52041178574;13703.862961370258;6843.520953533304;7016.859662806715;7030.296970303031;7224.711011559479;7416.295451932057;6865.141857267841;6912.585244885323;6941.514094013371;7076;7092.574445533284;3826;3894.2406230784727;4129.752214867118;4259.87220383389;4275.850345237902;1698.830116988316;1699.8470137687668;1726.7755191824983;1755.9385421510442;1787.8033416324195;844.8817165596821;859.3168431097167;866.4281574161149;898.6854600889636;904.1139683110457;16473.67052658964;16725;17192.570185745455;17479.905578629532;17498.512626426895;841.5455653946923;841.8526757817358;861.8793368928355;887.7026196224338;933.2394098809449;9307.581158847868;9665.323427360017;9724.367916085432;9736.610535578639;9913;181929;183860;396663;401309;402444;49485.09245767135;61979.83283262398;84245;86010.56994714987;86913;887.573964497045;908.6683360573343;917.40368760305;950.4107453378949;956.799072194833;15235.238238088274;15735.291911864222;15998;16085.678286433971;16584.08787516698;35816.283674325845;36943.44584831283;37820;40106.799466002485;42217;52475.73762131165;53356;53533.464665354404;54763.45236547743;55376.169357458864;4736.976315118402;5462.617616766788;5821.09772985171;7334.413246940126;7560.886586701094;9815;11765.882341176479;12129.21160124589;12451.066170037102;12572.497100115894;9667.371620844622;9802.117809397188;9960.302778805704;10005.949970250102;10376.844347334947;10517.05346518817;10589.841152382874;10673.199510036624;10817.405042722727;11132.610358637408;10561.788764224519;10582.80830329597;10666.89333106659;10670.35977841332;10711.357318560911;7406.740764073232;7637.541747495168;7700.19147989453;7710.151883292721;7711.228877112244;8343.499390036617;10423.739406514898;10650.8402373966;10871.565137394417;10883.401412922365 14:57:56 INFO - PROCESS | 17288 | |3;mootools.html;1339.109492187695;1425.1876430434654;1442.2284078018263;1635.5665748576637;1651.4054940221517;6631.171103612049;6831.658417079151;7107.928920710791;7601.505902116365;7607.239276072397;7321.524100933436;7601.809954751134;7615.8857617135645;7800.946872172255;7804.102528209258;2106.9367918962416;2132.9040193191267;2135.370065830576;2136.6260904341757;2140.2295173737443;1811.7282407638893;2083.5207902182506;2099.401670523901;2126.138913739938;2141.6038032963875;2082.7084208210863;2107.0202355904503;2108.4939614492487;2110.3985364171212;2110.8416868734907;2043;2045.1512622261744;2053.435305291042;2068.338131797825;2071.2543484345624;2069.7412823397076;2083.2812679625504;2104;2106.0207003743335;2108.7996640319143;7643.044619422572;7762.146163921964;7764.495307804975;7766.57283849388;7767.6892924282965;4334.978325108385;4469.776511174461;4472.373867658531;4472.44094488189;4481.753503557303;2736.822106563067;2838.630977972871;2890.4797136515417;2896.3048868271676;2949.6165498485275;966.9371490853072;973.5035132082618;974.2303580171726;986.2504496582649;987.5802783816849;10036.247281453847;10045.246606504468;10053.497325133714;10090.394576325443;10095;3828.2343531293855;3938.8424463021156;4086.346184610448;4126.463559737275;4177.979110104491;8330.375221858385;8413.579321033923;8435.11431299717;8438.493690378475;8448.83102337962;4493.213687604656;4499.55004499554;4501.41481607389;4501.707389019769;4502;4049.817758200888;4124.752514849119;4194.077302993336;4197.9370309445385;4204.789760511962;3111.5177147542167;3159.273367125574;3232.046546268856;3235.530848027023;3255.967440325614;815.355868863603;901.7520181950016;927.4296307770672;1122.4836575175348;1187.679326581818;690.6374153569416;745.4632664481564;789.135896193667;805.4643661964728;825.3067621589029;4933.555979961749;4960.156773348539;5033.84898453047;5033.949660503421;5336.866578335573;842.1872892658491;846.504794695098;890.7283278599959;891.1133422244908;905.3798148268457;3431.1765176357994;3544.4506101554302;3601.9099522512147;3602.2615363850346;3696.926061478809;9090.090990900857;9453.385529940531;9467.053294670615;9473.952630236943;9481.431114133175;8601.096884827128;9348.813023739487;9373.297002724823;9383.24934005278;9423.811523769624;7052.2595127511895;7264.673089710976;7266.128064632172;7268.6729097190755;7270.963645181634;5213;5444.537214336826;5534.39121696605;5543.1408131739645;5616.831495055155;8450.154984501747;8685.739427817176;8717.869231961653;8807.955960220157;8843.115688431106;8734.344924130588;8827.16141966512;8898;8911.598978045873;9015.278777697637;6627.834304142435;6765.797026089225;6781;6783.321667833177;6787.389134977876;6668.899966500409;7051.647417628996;7195.352418282379;7234.493585448968;7247.383972362408;5505.889882202254;5633.690147041952;6402.743890244338;6413.8717225656155;6542.214934207926;6347.555671103163;6382.840428989312;6404.231492220777;6426.228852537725;6428.614283143026;6109.358517355614;6114.2357205349335;6158.599691020069;6159.784407545714;6161.815145545641;4325.113351762818;4439.156560253541;4472.44094488189;4473.977630111829;4481.708688935209;4656.743879086683;4658.231391820312;4658.627309815139;4683.297505374221;4780.259059845729 14:57:56 INFO - PROCESS | 17288 | |4;prototype.html;284.2566688110589;288.13846598669977;294.5228729458277;295.0278831251028;296.4589623936317;4607.654425918061;4741.928871066937;4801.751544598408;4876.536729010747;4878.48775878533;4548.772561371927;4692.296155576665;4699.459562150354;4704.082703872747;4708.43498780146;3761.11613770765;3763.1344790698017;3768.284026035058;3769.453429252757;3774.867879624214;3541.982290088546;3613.5844377896483;3749.7187710921653;3763.9862673469697;3783.924321513568;3724.7578907370935;3747.5128233329765;3749.9812500937455;3765.454009168669;3772.6038765929457;3757.0607348162957;3758.9060273493383;3760.6615404613444;3767.8304476298495;3778.7732736035928;3311.718503927145;3312.188513814107;3318.435865902802;3323.4848598467274;3336.6830151135846;4493.707908985938;4637.489876113625;4640.2343613303765;4665.953340466586;4678.532146785328;4256.914861702749;4257.254980378421;4259.637930775888;4267.4025636410925;4267.893302667459;4939.8024079036795;4954.7274899880495;4961.578265847407;4972.701637901738;4974.403071631391;3326.652705654214;3529;3617.8733744318824;3620.8913732588067;3630.7095432365613;5169.793208271664;5170.767315470813;5185.455527169631;5198.2202669599865;5219.947800521984;3594.1194407370363;3607.8376473058775;3610.7291953103622;3612.4581312802766;3628.600853906068;3658.634136586373;3661.8352174151696;3662.322470342942;3665;3671.375866102769;3937;4143.854965076208;4183.874483765492;4191.987845834016;4198;4985.302057711923;4990.975045124751;4994.72845286338;4995.750212489361;5007.749612519359;1197.928124312544;1223.1315765806198;1243.6393445900587;1246.9712487197917;1254.930978796175;835.9884539707023;847.4322204123129;863.1929146248278;863.4344504349662;870.9738707838775;4425.933610995773;4435.534268901783;4438.733675979452;4455.665825063068;4459.643228541709;5100.744962751847;5102.744862756922;5103.489651034867;5105.8723531912;5108.770105345268;4440;4441.977790111029;4449.754068860724;4452.977735111369;4455.6658250631335;2285.6000199964938;2373.4896997145697;2393.222202784067;2421.7941474974473;2422.551827911842;4311.48262208537;4327.199468098412;4327.502337231259;4348.434703488526;4357.934630980538;4609.2574917923785;4620.903994323811;4621.491635920046;4660.347551342815;4674.392328997209;4120.546739858613;4209.515905670826;4263.59495847894;4300.419443375167;4348.5216626171095;4499.235130027838;4500.097437153084;4511.398453548943;4521.412216411845;4522.547745225583;4412.6249268811225;4429.601335879786;4449.688521803443;4451.710638808467;4488.316881169561;4089.2434899543678;4256.914861702687;4263.87208383749;4267.97866010668;4345.630621397217;3269.9019029429155;3270.296886169485;3279.885204017848;3294.1435226841672;3298.323843612102;4510.909781804411;4530.909381812279;4536.138133754576;4538.432695913011;4889.242167464049;4749.786259618395;4949.876253093701;4961.652684312208;4979.726115063706;4986.8753281168265;4957.4794646561595;4966.850994470172;4967.503249675004;4968.577670897869;4969.875753106201;4735.83424580138;4891.315215869852;4891.755412229445;4893;4895.143349913822;4940.728259945738;5005.924911126263;5027.723475208899;5030.4466508684745;5032.3206367139965;4875.195592727302;4877.6829506081995;4884.731339776346;4888.682235654671;4905.877353066202 14:57:56 INFO - PROCESS | 17288 | |5;yui.html;589.5961266532428;610.7404353149913;622.1290193728779;628.2774808969684;724.4928550014987;12764.106512544126;13085.738285234289;13846.376913038912;13915.44338226471;13923.582292531215;14042.57872263831;14052.086614370059;14153.363098660586;14185.71628567428;14189.78715319271;621.8911690454175;734.9559026458417;768.6310570925959;778.4550814429894;778.7858338956776;754.6566312327877;771.1440301265619;781.4334607409611;792.0495405513378;792.7304716396424;827.1852225557851;828.9792755181138;831.7255305749119;831.8377916306323;832.8001279692891;645.1806206118204;818.2758258940821;824.7814329202766;824.9463784853996;825.3273582030656;577.8410936992319;579.1688926390643;592.3129170162633;598.407576499267;598.7455331484102;13039.86960130396;13129.343532823415;13155.671108222372;13155.802662960063;13163.802542961863;11768.941155294255;11984.400779960966;12570.622881313575;13240;13871.098378605358;11657.591984280594;11692.766144677144;11770.9305633894;11985.101117416141;12098.758024839542;4097.487814023247;4097.725762201977;4155.480564929384;4293.420388247578;4294.269974104379;63600.68199658972;63904.68047659779;64898;64939.67530162319;64975.67512162409;10140.695779126638;10230.693079207636;10479.423631700178;10604.734881628021;10846.728831779112;19448.4165475036;19458.124384402738;19469.902650486656;19489.635725499364;19534.511637209183;6906.205786334535;6950.374466298057;7182.281771822776;7182.281771822881;7183.89224161638;3838.846446142179;3910.1006768443417;3931.253061918226;4002.1795531915886;4005.0588111793704;2666.480036392885;2758.70340939758;2758.820676656011;2760.213339198319;2778.583212518098;461.4347424405077;468.8312207605259;502.92456131580553;513.1891611254209;527.1276038156857;507.84764570628664;530.7001544127555;587.4477990688739;601.9367966363557;653.2977049671622;8648.697295594624;8660.783480412914;8709.825803483895;8750.956245218733;8860.113988601088;543.234040003593;550.3066136667748;589.1869220475802;599.1671576508656;616.9912193563556;3855.267499175148;3871.7483363581277;4094.1811637672586;4096.713230073866;4120.320147175682;99381;99941.50029249807;100419;100533;102452.48773756233;86211.56894215614;87297;88581;89112.5544372287;91571;79193;80035;80685.59657201794;82230.76653850196;82327.1789180027;7648.961755191189;7935.2064793520185;8027.357811375193;8086.87869681967;8222.855020428377;46031;46269.30596040995;46598.53401466078;46765.2985205229;47061.52938470572;53943.46056539541;56206.43793562012;56610;61023.694881525305;61767.6911615439;11341.489632966372;11485.310881347146;11545.942270288595;11725.648230553097;11811.82282265784;13024.609261722164;13066.150700204456;13262.602121936357;13401;13409.262490562722;12419.689507762378;12451;12748.745025099632;12938.417771200131;13345.199288042748;11285.266457680225;12129.272243665408;12246.571370002008;12505.93747031259;12947.352632368156;12099.455524501242;12634.747305054032;12705.42825572833;13091.869081309065;13094.541691040768;9565.473898935625;9933.255005874444;10314.226433017404;10476.63331783384;10699.839502407314;8845.159709827556;9848.950755246464;10108.747281318027;10165.72928383952;10589.311694739818 14:57:56 INFO - PROCESS | 17288 | __end_tp_report 14:57:56 INFO - PROCESS | 17288 | __start_cc_report 14:57:56 INFO - PROCESS | 17288 | _x_x_mozilla_cycle_collect,1123 14:57:56 INFO - PROCESS | 17288 | __end_cc_report 14:57:56 INFO - PROCESS | 17288 | __startTimestamp1470952676767__endTimestamp 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | ------- Summary: start ------- 14:57:56 INFO - PROCESS | 17288 | Number of tests: 6 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#0] dojo.html Cycles:165 Average:4782.79 Median:4892.68 stddev:511.11 (10.4%) stddev-sans-first:484.60 14:57:56 INFO - PROCESS | 17288 | Values: 2653.0 2670.9 2699.0 2707.2 2710.2 4638.9 4711.9 4800.9 4942.0 4946.7 4772.8 4800.1 4814.6 4885.3 4910.1 4482.4 4521.8 4542.1 4550.5 4579.1 4463.2 4497.9 4553.4 4572.6 4605.1 4551.8 4554.9 4578.8 4595.1 4595.7 4273.6 4465.3 4494.8 4523.0 4528.7 4284.3 4388.9 4431.1 4434.9 4497.7 4808.8 4824.3 4876.1 4876.2 4881.8 5248.4 5259.2 5259.8 5260.4 5265.4 4872.4 4973.6 5123.1 5205.5 5281.3 4905.5 4906.7 4910.6 4910.9 4922.0 5366.8 5375.8 5379.4 5379.5 5385.2 4892.7 5026.4 5082.0 5099.8 5183.7 5204.0 5210.3 5210.9 5245.6 5258.2 5136.6 5157.0 5176.7 5182.2 5227.3 4924.0 4983.1 5001.4 5149.7 5162.2 4222.7 4285.2 4288.7 4319.3 4332.2 3725.4 3765.3 3766.8 3785.1 3801.0 4205.6 4425.0 4461.2 4471.2 4478.4 5216.3 5249.1 5271.0 5312.5 5327.4 4528.0 4536.7 4537.5 4540.9 4582.9 4381.3 4528.9 4695.2 4707.3 4738.2 4805.9 4809.4 4840.5 4869.4 4889.0 5115.5 5136.0 5137.0 5137.2 5188.7 4671.5 4866.8 4937.0 4953.8 5003.9 5091.0 5158.3 5161.6 5181.6 5203.8 5233.3 5241.4 5247.2 5251.4 5289.6 4834.1 4932.2 5060.2 5074.6 5076.4 4949.0 5023.5 5023.6 5057.8 5063.9 4935.6 4943.0 4979.8 4980.7 4982.1 4847.3 4921.0 5039.4 5048.5 5050.8 4801.4 4844.6 4848.5 4866.1 4866.2 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#1] ext.html Cycles:180 Average:44930.71 Median:36568.91 stddev:79936.56 (218.6%) stddev-sans-first:80091.39 14:57:56 INFO - PROCESS | 17288 | Values: 564.8 567.8 574.2 578.2 578.4 28649.4 39617.2 40908.0 41006.4 44896.6 41006.6 41379.6 41450.6 41517.8 41550.0 7699.3 7869.4 7872.8 7872.8 7877.8 7652.3 7770.7 7773.6 7776.4 7780.2 7787.3 7836.6 7842.9 7846.9 7857.1 7770.5 7804.8 7809.6 7815.0 7817.2 7626.3 7631.7 7673.3 7680.6 7690.8 38579.0 38957.2 39068.4 39113.8 39120.8 2998.1 3015.6 3028.7 3093.1 3100.9 28925.9 29494.7 29561.6 30307.2 30856.5 3346.9 3363.9 3371.3 3385.4 3403.4 184160.0 185220.0 185261.0 185515.0 185674.0 54258.5 54704.7 54727.2 54744.0 54749.5 33295.2 34071.3 34185.0 55954.7 56408.4 15100.2 15313.4 15321.4 15325.5 15341.4 11535.6 11647.6 11655.4 11675.1 11678.7 18373.4 18445.4 18479.4 18488.9 18539.7 6638.2 6879.5 6889.0 6924.4 6998.2 806.7 885.3 904.4 972.5 989.8 27505.4 27562.9 28026.7 28161.3 28260.2 910.9 949.6 952.7 962.6 967.6 14351.3 14918.3 14965.9 15059.4 15306.8 390711.0 394443.0 395374.0 396137.0 397132.0 48840.5 49145.3 49359.8 49408.5 49537.8 1060.0 1098.5 1140.9 1160.2 1219.0 27859.3 28503.6 29302.9 29893.1 29898.0 42158.8 42592.0 42654.4 42682.0 42713.4 290335.0 292325.0 292469.0 293027.0 293753.0 22826.2 25722.4 26473.6 27618.7 27658.3 41711.6 42169.6 42261.8 42447.6 43716.1 35231.6 35764.5 35845.0 36265.3 36378.6 35436.5 36127.3 36387.5 36486.6 36962.0 35275.8 36191.0 36514.8 36623.0 36651.6 30033.2 31355.0 31923.7 32250.5 32566.3 24902.5 25061.2 25095.6 25297.4 25388.7 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#2] jquery.html Cycles:180 Average:22174.83 Median:4506.41 stddev:55271.86 (1226.5%) stddev-sans-first:55402.58 14:57:56 INFO - PROCESS | 17288 | Values: 334.3 353.5 359.2 360.1 367.3 12531.8 12917.0 13720.8 16414.4 16645.8 16597.7 16613.3 16668.3 16694.5 16755.2 4831.5 4997.8 5046.6 5078.2 5081.9 3697.8 5074.0 5149.1 5153.4 5645.9 5911.6 5988.8 6010.7 6018.0 6021.0 5823.1 5956.0 6005.0 6019.8 6021.2 5242.6 5276.1 5284.5 5286.5 5289.3 19941.3 20716.7 20831.7 20896.8 21008.3 2012.8 2097.2 2191.0 2399.5 2534.2 8603.7 9104.9 12874.4 13197.4 13777.4 1709.9 1771.5 1785.5 1814.2 1827.0 64147.7 66840.3 67765.0 69473.7 71463.6 9564.4 9892.9 9930.8 10223.8 10257.8 13638.0 13665.7 13699.2 13702.5 13703.9 6843.5 7016.9 7030.3 7224.7 7416.3 6865.1 6912.6 6941.5 7076.0 7092.6 3826.0 3894.2 4129.8 4259.9 4275.9 1698.8 1699.8 1726.8 1755.9 1787.8 844.9 859.3 866.4 898.7 904.1 16473.7 16725.0 17192.6 17479.9 17498.5 841.5 841.9 861.9 887.7 933.2 9307.6 9665.3 9724.4 9736.6 9913.0 181929.0 183860.0 396663.0 401309.0 402444.0 49485.1 61979.8 84245.0 86010.6 86913.0 887.6 908.7 917.4 950.4 956.8 15235.2 15735.3 15998.0 16085.7 16584.1 35816.3 36943.4 37820.0 40106.8 42217.0 52475.7 53356.0 53533.5 54763.5 55376.2 4737.0 5462.6 5821.1 7334.4 7560.9 9815.0 11765.9 12129.2 12451.1 12572.5 9667.4 9802.1 9960.3 10005.9 10376.8 10517.1 10589.8 10673.2 10817.4 11132.6 10561.8 10582.8 10666.9 10670.4 10711.4 7406.7 7637.5 7700.2 7710.2 7711.2 8343.5 10423.7 10650.8 10871.6 10883.4 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#3] mootools.html Cycles:180 Average:4968.53 Median:5538.77 stddev:2767.86 (50.0%) stddev-sans-first:2762.19 14:57:56 INFO - PROCESS | 17288 | Values: 1339.1 1425.2 1442.2 1635.6 1651.4 6631.2 6831.7 7107.9 7601.5 7607.2 7321.5 7601.8 7615.9 7800.9 7804.1 2106.9 2132.9 2135.4 2136.6 2140.2 1811.7 2083.5 2099.4 2126.1 2141.6 2082.7 2107.0 2108.5 2110.4 2110.8 2043.0 2045.2 2053.4 2068.3 2071.3 2069.7 2083.3 2104.0 2106.0 2108.8 7643.0 7762.1 7764.5 7766.6 7767.7 4335.0 4469.8 4472.4 4472.4 4481.8 2736.8 2838.6 2890.5 2896.3 2949.6 966.9 973.5 974.2 986.3 987.6 10036.2 10045.2 10053.5 10090.4 10095.0 3828.2 3938.8 4086.3 4126.5 4178.0 8330.4 8413.6 8435.1 8438.5 8448.8 4493.2 4499.6 4501.4 4501.7 4502.0 4049.8 4124.8 4194.1 4197.9 4204.8 3111.5 3159.3 3232.0 3235.5 3256.0 815.4 901.8 927.4 1122.5 1187.7 690.6 745.5 789.1 805.5 825.3 4933.6 4960.2 5033.8 5033.9 5336.9 842.2 846.5 890.7 891.1 905.4 3431.2 3544.5 3601.9 3602.3 3696.9 9090.1 9453.4 9467.1 9474.0 9481.4 8601.1 9348.8 9373.3 9383.2 9423.8 7052.3 7264.7 7266.1 7268.7 7271.0 5213.0 5444.5 5534.4 5543.1 5616.8 8450.2 8685.7 8717.9 8808.0 8843.1 8734.3 8827.2 8898.0 8911.6 9015.3 6627.8 6765.8 6781.0 6783.3 6787.4 6668.9 7051.6 7195.4 7234.5 7247.4 5505.9 5633.7 6402.7 6413.9 6542.2 6347.6 6382.8 6404.2 6426.2 6428.6 6109.4 6114.2 6158.6 6159.8 6161.8 4325.1 4439.2 4472.4 4474.0 4481.7 4656.7 4658.2 4658.6 4683.3 4780.3 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#4] prototype.html Cycles:180 Average:4012.11 Median:4440.99 stddev:1157.93 (26.1%) stddev-sans-first:1126.86 14:57:56 INFO - PROCESS | 17288 | Values: 284.3 288.1 294.5 295.0 296.5 4607.7 4741.9 4801.8 4876.5 4878.5 4548.8 4692.3 4699.5 4704.1 4708.4 3761.1 3763.1 3768.3 3769.5 3774.9 3542.0 3613.6 3749.7 3764.0 3783.9 3724.8 3747.5 3750.0 3765.5 3772.6 3757.1 3758.9 3760.7 3767.8 3778.8 3311.7 3312.2 3318.4 3323.5 3336.7 4493.7 4637.5 4640.2 4666.0 4678.5 4256.9 4257.3 4259.6 4267.4 4267.9 4939.8 4954.7 4961.6 4972.7 4974.4 3326.7 3529.0 3617.9 3620.9 3630.7 5169.8 5170.8 5185.5 5198.2 5219.9 3594.1 3607.8 3610.7 3612.5 3628.6 3658.6 3661.8 3662.3 3665.0 3671.4 3937.0 4143.9 4183.9 4192.0 4198.0 4985.3 4991.0 4994.7 4995.8 5007.7 1197.9 1223.1 1243.6 1247.0 1254.9 836.0 847.4 863.2 863.4 871.0 4425.9 4435.5 4438.7 4455.7 4459.6 5100.7 5102.7 5103.5 5105.9 5108.8 4440.0 4442.0 4449.8 4453.0 4455.7 2285.6 2373.5 2393.2 2421.8 2422.6 4311.5 4327.2 4327.5 4348.4 4357.9 4609.3 4620.9 4621.5 4660.3 4674.4 4120.5 4209.5 4263.6 4300.4 4348.5 4499.2 4500.1 4511.4 4521.4 4522.5 4412.6 4429.6 4449.7 4451.7 4488.3 4089.2 4256.9 4263.9 4268.0 4345.6 3269.9 3270.3 3279.9 3294.1 3298.3 4510.9 4530.9 4536.1 4538.4 4889.2 4749.8 4949.9 4961.7 4979.7 4986.9 4957.5 4966.9 4967.5 4968.6 4969.9 4735.8 4891.3 4891.8 4893.0 4895.1 4940.7 5005.9 5027.7 5030.4 5032.3 4875.2 4877.7 4884.7 4888.7 4905.9 14:57:56 INFO - PROCESS | 17288 | 14:57:56 INFO - PROCESS | 17288 | [#5] yui.html Cycles:180 Average:18374.24 Median:23365.37 stddev:26221.86 (112.2%) stddev-sans-first:26261.42 14:57:56 INFO - PROCESS | 17288 | Values: 589.6 610.7 622.1 628.3 724.5 12764.1 13085.7 13846.4 13915.4 13923.6 14042.6 14052.1 14153.4 14185.7 14189.8 621.9 735.0 768.6 778.5 778.8 754.7 771.1 781.4 792.0 792.7 827.2 829.0 831.7 831.8 832.8 645.2 818.3 824.8 824.9 825.3 577.8 579.2 592.3 598.4 598.7 13039.9 13129.3 13155.7 13155.8 13163.8 11768.9 11984.4 12570.6 13240.0 13871.1 11657.6 11692.8 11770.9 11985.1 12098.8 4097.5 4097.7 4155.5 4293.4 4294.3 63600.7 63904.7 64898.0 64939.7 64975.7 10140.7 10230.7 10479.4 10604.7 10846.7 19448.4 19458.1 19469.9 19489.6 19534.5 6906.2 6950.4 7182.3 7182.3 7183.9 3838.8 3910.1 3931.3 4002.2 4005.1 2666.5 2758.7 2758.8 2760.2 2778.6 461.4 468.8 502.9 513.2 527.1 507.8 530.7 587.4 601.9 653.3 8648.7 8660.8 8709.8 8751.0 8860.1 543.2 550.3 589.2 599.2 617.0 3855.3 3871.7 4094.2 4096.7 4120.3 99381.0 99941.5 100419.0 100533.0 102452.5 86211.6 87297.0 88581.0 89112.6 91571.0 79193.0 80035.0 80685.6 82230.8 82327.2 7649.0 7935.2 8027.4 8086.9 8222.9 46031.0 46269.3 46598.5 46765.3 47061.5 53943.5 56206.4 56610.0 61023.7 61767.7 11341.5 11485.3 11545.9 11725.6 11811.8 13024.6 13066.2 13262.6 13401.0 13409.3 12419.7 12451.0 12748.7 12938.4 13345.2 11285.3 12129.3 12246.6 12505.9 12947.4 12099.5 12634.7 12705.4 13091.9 13094.5 9565.5 9933.3 10314.2 10476.6 10699.8 8845.2 9849.0 10108.7 10165.7 10589.3 14:57:56 INFO - PROCESS | 17288 | -------- Summary: end -------- 14:57:56 INFO - PROCESS | 17288 | 14:57:57 INFO - TEST-INFO | 17288: exit 0 14:57:57 INFO - TEST-OK | dromaeo_css | took 1119795ms 14:57:57 INFO - TEST-START | kraken 14:57:57 INFO - operating with platform_type : linux_ 14:57:57 INFO - Initialising browser for kraken test... 14:57:57 INFO - TEST-INFO | started process 17473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaV68lH/profile http://localhost:57724/getInfo.html) 14:58:01 INFO - PROCESS | 17473 | __metrics Screen width/height:1600/1200 14:58:01 INFO - PROCESS | 17473 | colorDepth:24 14:58:01 INFO - PROCESS | 17473 | Browser inner width/height: 1024/697 14:58:01 INFO - PROCESS | 17473 | __metrics 14:58:02 INFO - PROCESS | 17473 | 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" 14:58:02 INFO - PROCESS | 17473 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:58:03 INFO - TEST-INFO | 17473: exit 0 14:58:03 INFO - Browser initialized. 14:58:03 INFO - Running cycle 1/1 for kraken test... 14:58:03 INFO - TEST-INFO | started process 17551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaV68lH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:15 INFO - PROCESS | 17551 | RSS: Main: 157315072 14:58:15 INFO - PROCESS | 17551 | 14:58:18 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57724/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:18 INFO - PROCESS | 17551 | RSS: Main: 212312064 14:58:18 INFO - PROCESS | 17551 | 14:58:21 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57724/tests/kraken/driver.html?testName=audio-dft) 14:58:22 INFO - PROCESS | 17551 | RSS: Main: 188289024 14:58:22 INFO - PROCESS | 17551 | 14:58:25 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57724/tests/kraken/driver.html?testName=audio-fft) 14:58:26 INFO - PROCESS | 17551 | RSS: Main: 270327808 14:58:26 INFO - PROCESS | 17551 | 14:58:28 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57724/tests/kraken/driver.html?testName=audio-oscillator) 14:58:28 INFO - PROCESS | 17551 | RSS: Main: 179937280 14:58:28 INFO - PROCESS | 17551 | 14:58:31 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57724/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:58:31 INFO - PROCESS | 17551 | RSS: Main: 184770560 14:58:31 INFO - PROCESS | 17551 | 14:58:34 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57724/tests/kraken/driver.html?testName=imaging-darkroom) 14:58:35 INFO - PROCESS | 17551 | RSS: Main: 220958720 14:58:35 INFO - PROCESS | 17551 | 14:58:39 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57724/tests/kraken/driver.html?testName=imaging-desaturate) 14:58:39 INFO - PROCESS | 17551 | RSS: Main: 214482944 14:58:39 INFO - PROCESS | 17551 | 14:58:42 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57724/tests/kraken/driver.html?testName=json-parse-financial) 14:58:43 INFO - PROCESS | 17551 | RSS: Main: 218075136 14:58:43 INFO - PROCESS | 17551 | 14:58:44 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57724/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:58:45 INFO - PROCESS | 17551 | RSS: Main: 183631872 14:58:45 INFO - PROCESS | 17551 | 14:58:47 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:58:47 INFO - PROCESS | 17551 | RSS: Main: 189276160 14:58:47 INFO - PROCESS | 17551 | 14:58:50 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:58:50 INFO - PROCESS | 17551 | RSS: Main: 192884736 14:58:50 INFO - PROCESS | 17551 | 14:58:53 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:54 INFO - PROCESS | 17551 | RSS: Main: 187944960 14:58:54 INFO - PROCESS | 17551 | 14:58:57 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:58:57 INFO - PROCESS | 17551 | RSS: Main: 191627264 14:58:57 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | Cycle 1(1): loaded http://localhost:57724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57724/tests/kraken/driver.html?testName=ai-astar) 14:58:59 INFO - PROCESS | 17551 | RSS: Main: 241954816 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | __start_tp_report 14:58:59 INFO - PROCESS | 17551 | _x_x_mozilla_page_load 14:58:59 INFO - PROCESS | 17551 | _x_x_mozilla_page_load_details 14:58:59 INFO - PROCESS | 17551 | |i|pagename|runs| 14:58:59 INFO - PROCESS | 17551 | |0;ai-astar;103;114;115;113;112;113;113;114;114;115 14:58:59 INFO - PROCESS | 17551 | |1;audio-beat-detection;144;123;122;179;122;125;148;121;168;121 14:58:59 INFO - PROCESS | 17551 | |2;audio-dft;163;162;160;163;162;161;160;161;163;161 14:58:59 INFO - PROCESS | 17551 | |3;audio-fft;77;76;75;105;78;75;75;75;99;75 14:58:59 INFO - PROCESS | 17551 | |4;audio-oscillator;85;86;120;86;85;85;133;84;85;130 14:58:59 INFO - PROCESS | 17551 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;117;116;117 14:58:59 INFO - PROCESS | 17551 | |6;imaging-darkroom;146;147;146;145;146;145;147;146;145;145 14:58:59 INFO - PROCESS | 17551 | |7;imaging-desaturate;95;94;94;96;94;95;95;95;95;94 14:58:59 INFO - PROCESS | 17551 | |8;json-parse-financial;62;62;62;63;63;65;64;62;64;63 14:58:59 INFO - PROCESS | 17551 | |9;json-stringify-tinderbox;65;66;67;65;66;66;65;66;66;67 14:58:59 INFO - PROCESS | 17551 | |10;stanford-crypto-aes;79;79;82;82;79;90;84;79;80;84 14:58:59 INFO - PROCESS | 17551 | |11;stanford-crypto-ccm;132;138;131;129;128;128;129;137;147;152 14:58:59 INFO - PROCESS | 17551 | |12;stanford-crypto-pbkdf2;165;175;168;173;169;164;165;167;165;166 14:58:59 INFO - PROCESS | 17551 | |13;stanford-crypto-sha256-iterative;70;70;66;71;68;66;66;69;67;72 14:58:59 INFO - PROCESS | 17551 | __end_tp_report 14:58:59 INFO - PROCESS | 17551 | __start_cc_report 14:58:59 INFO - PROCESS | 17551 | _x_x_mozilla_cycle_collect,1981 14:58:59 INFO - PROCESS | 17551 | __end_cc_report 14:58:59 INFO - PROCESS | 17551 | __startTimestamp1470952739730__endTimestamp 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | ------- Summary: start ------- 14:58:59 INFO - PROCESS | 17551 | Number of tests: 14 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:1.00 14:58:59 INFO - PROCESS | 17551 | Values: 103.0 114.0 115.0 113.0 112.0 113.0 113.0 114.0 114.0 115.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:134.50 stddev:21.59 (16.1%) stddev-sans-first:22.77 14:58:59 INFO - PROCESS | 17551 | Values: 144.0 123.0 122.0 179.0 122.0 125.0 148.0 121.0 168.0 121.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 14:58:59 INFO - PROCESS | 17551 | Values: 163.0 162.0 160.0 163.0 162.0 161.0 160.0 161.0 163.0 161.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.50 stddev:11.21 (14.8%) stddev-sans-first:11.79 14:58:59 INFO - PROCESS | 17551 | Values: 77.0 76.0 75.0 105.0 78.0 75.0 75.0 75.0 99.0 75.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.00 stddev:20.80 (24.5%) stddev-sans-first:21.53 14:58:59 INFO - PROCESS | 17551 | Values: 85.0 86.0 120.0 86.0 85.0 85.0 133.0 84.0 85.0 130.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:58:59 INFO - PROCESS | 17551 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:58:59 INFO - PROCESS | 17551 | Values: 146.0 147.0 146.0 145.0 146.0 145.0 147.0 146.0 145.0 145.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:58:59 INFO - PROCESS | 17551 | Values: 95.0 94.0 94.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:1.05 14:58:59 INFO - PROCESS | 17551 | Values: 62.0 62.0 62.0 63.0 63.0 65.0 64.0 62.0 64.0 63.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:58:59 INFO - PROCESS | 17551 | Values: 65.0 66.0 67.0 65.0 66.0 66.0 65.0 66.0 66.0 67.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.52 (4.3%) stddev-sans-first:3.59 14:58:59 INFO - PROCESS | 17551 | Values: 79.0 79.0 82.0 82.0 79.0 90.0 84.0 79.0 80.0 84.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:134.50 stddev:8.44 (6.3%) stddev-sans-first:8.88 14:58:59 INFO - PROCESS | 17551 | Values: 132.0 138.0 131.0 129.0 128.0 128.0 129.0 137.0 147.0 152.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:167.50 stddev:3.68 (2.2%) stddev-sans-first:3.77 14:58:59 INFO - PROCESS | 17551 | Values: 165.0 175.0 168.0 173.0 169.0 164.0 165.0 167.0 165.0 166.0 14:58:59 INFO - PROCESS | 17551 | 14:58:59 INFO - PROCESS | 17551 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:2.22 (3.2%) stddev-sans-first:2.29 14:58:59 INFO - PROCESS | 17551 | Values: 70.0 70.0 66.0 71.0 68.0 66.0 66.0 69.0 67.0 72.0 14:58:59 INFO - PROCESS | 17551 | -------- Summary: end -------- 14:58:59 INFO - PROCESS | 17551 | 14:59:00 INFO - TEST-INFO | 17551: exit 0 14:59:00 INFO - TEST-OK | kraken | took 63302ms 14:59:00 INFO - SUITE-END | took 1183s 14:59:00 INFO - Completed test suite (00:19:43) 14:59:00 INFO - javascript benchmark 14:59:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.986735066325, 2670.8798104085313, 2698.9865050674744, 2707.2284398946317, 2710.1733971138806, 4638.8608341749805, 4711.882202944928, 4800.90398192036, 4942.0, 4946.703197808134, 4772.832950846721, 4800.111979283835, 4814.590759785414, 4885.291632713263, 4910.091633047879, 4482.372467854503, 4521.841735539257, 4542.114287713897, 4550.49944506104, 4579.129965306598, 4463.174312752151, 4497.887552811173, 4553.408056952591, 4572.565606267399, 4605.055963527486, 4551.7724113794175, 4554.863354099382, 4578.771061446914, 4595.058013107322, 4595.701279416844, 4273.551277115889, 4465.307877279027, 4494.752788596626, 4523.027549076948, 4528.660350473695, 4284.314509678467, 4388.934165987513, 4431.091626216617, 4434.911301773978, 4497.685162038659, 4808.783604737795, 4824.300476430933, 4876.122297986361, 4876.195427754416, 4881.780319885614, 5248.448912864133, 5259.184826351921, 5259.842204733826, 5260.447652996457, 5265.394479634814, 4872.366592342973, 4973.62697797663, 5123.077845987721, 5205.531502164786, 5281.260623512711, 4905.533974272474, 4906.681065730716, 4910.582600478928, 4910.90178196434, 4922.040202160616, 5366.758495867695, 5375.7849686012905, 5379.435159308295, 5379.515843574019, 5385.219143224211, 4892.68197567157, 5026.371703537058, 5082.034413461431, 5099.847004589868, 5183.740812959337, 5204.037253108111, 5210.270562121306, 5210.895782084337, 5245.580353571705, 5258.2375555544995, 5136.614753893473, 5157.0, 5176.7411629418375, 5182.196759502283, 5227.320448341691, 4923.975380123148, 4983.07813054586, 5001.374828146481, 5149.665271757323, 5162.174052151638, 4222.662187025031, 4285.207236661166, 4288.656907447396, 4319.287317592562, 4332.1985432695055, 3725.385311423585, 3765.3034188675183, 3766.8116594170183, 3785.1104990327253, 3800.9809950950066, 4205.558416366299, 4425.0, 4461.174682683649, 4471.150481408522, 4478.39541661878, 5216.321878155892, 5249.081410753103, 5270.973645131749, 5312.5218730314455, 5327.413984461706, 4527.954720452819, 4536.682432229778, 4537.478190008125, 4540.909181816412, 4582.88542786433, 4381.342798580238, 4528.864134075983, 4695.154872122982, 4707.29390591414, 4738.218193998021, 4805.9038819224115, 4809.398825146856, 4840.467548569584, 4869.391326084239, 4888.95111048885, 5115.5396014358885, 5136.049830781318, 5137.0, 5137.152369858932, 5188.688678679291, 4671.509491503343, 4866.780994855169, 4936.950630493649, 4953.801847926186, 5003.949960500348, 5090.974545127398, 5158.252053452154, 5161.561267292323, 5181.55956743666, 5203.8178663746585, 5233.345831771028, 5241.423443421144, 5247.239150323258, 5251.448597897166, 5289.6032797539565, 4834.081524510332, 4932.235503496964, 5060.2156665716875, 5074.6194035448225, 5076.441591424867, 4949.010197960494, 5023.472535383732, 5023.648344615842, 5057.8229761958155, 5063.924041139312, 4935.555799978019, 4942.950570494249, 4979.800807967786, 4980.701157930391, 4982.078315511642, 4847.345608342828, 4920.950790492192, 5039.445660977363, 5048.545630893237, 5050.84847454577, 4801.399825021872, 4844.61243100544, 4848.466668666373, 4866.148424025852, 4866.172750632471], "value": 4749.7748043883275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.771267636607, 567.8182981445939, 574.1989924055941, 578.2049681687679, 578.4013545979911, 28649.427011459757, 39617.207655846905, 40907.977300567465, 41006.38490422646, 44896.55103448965, 41006.58993410065, 41379.58620413795, 41450.58549414505, 41517.7924110379, 41550.0, 7699.3070623644, 7869.370450363957, 7872.803179920519, 7872.842543149162, 7877.8030549236155, 7652.273034061755, 7770.650320735581, 7773.572453515055, 7776.416768742367, 7780.221977802203, 7787.260210280015, 7836.608169591497, 7842.921570784276, 7846.882296765524, 7857.057153141631, 7770.4560680752365, 7804.804879877992, 7809.648565814552, 7815.0231221097365, 7817.179196184433, 7626.275503827128, 7631.694732210705, 7673.309402153777, 7680.6159692015735, 7690.769276921701, 38579.0, 38957.22085558273, 39068.41397379042, 39113.80443097766, 39120.80439597784, 2998.100569829064, 3015.6079709637825, 3028.6819883912094, 3093.133922501703, 3100.875964961399, 28925.85537072322, 29494.70505294941, 29561.55657665137, 30307.242318941982, 30856.53715194274, 3346.882859099944, 3363.899083027513, 3371.342588195303, 3385.4075536780965, 3403.3703764803345, 184160.0, 185220.0, 185261.0, 185515.0, 185674.0, 54258.45741542613, 54704.72647636816, 54727.17909231365, 54744.0, 54749.45250547523, 33295.16762080919, 34071.31857362889, 34185.0, 55954.72022639861, 56408.43591564114, 15100.244987750568, 15313.387464501518, 15321.387144514094, 15325.46360877364, 15341.386344546094, 11535.596254131233, 11647.59233426826, 11655.417229138679, 11675.065994720402, 11678.70803229926, 18373.438257747974, 18445.446636600922, 18479.44561663152, 18488.907555462138, 18539.72190417145, 6638.236602790741, 6879.486512967139, 6888.965555172293, 6924.376806087476, 6998.195207551197, 806.6571707024491, 885.2740752582949, 904.4347282948157, 972.4991629310769, 989.8317286061387, 27505.449891002067, 27562.862185688944, 28026.719732802412, 28161.295967600974, 28260.15219543417, 910.8633704944178, 949.6106596295624, 952.6514302227675, 962.5860879821604, 967.5936106835146, 14351.282435878373, 14918.328675209641, 14965.92517037408, 15059.397624095132, 15306.846931530765, 390711.0, 394443.0, 395374.0, 396137.0, 397132.0, 48840.51159488431, 49145.26282105771, 49359.75320123376, 49408.50591494039, 49537.75231123893, 1059.9629012984508, 1098.4946924414699, 1140.8745038045809, 1160.2400427719688, 1218.9939050304693, 27859.303517412227, 28503.58194479859, 29302.85348573329, 29893.103206902957, 29898.0, 42158.78920605377, 42592.0, 42654.36018459663, 42682.0, 42713.35929960991, 290335.0, 292325.0, 292469.0, 293027.0, 293753.0, 22826.201082962016, 25722.35694107662, 26473.602895956963, 27618.72381276242, 27658.308542286602, 41711.582884171985, 42169.578304216564, 42261.78869105635, 42447.5755242456, 43716.12567748691, 35231.647683523865, 35764.46353304754, 35845.0, 36265.27469450649, 36378.636213637525, 35436.46845297374, 36127.27745445024, 36387.45418818667, 36486.63513364832, 36962.0, 35275.82362088173, 36191.0, 36514.8174259127, 36623.0, 36651.633483664824, 30033.249168770082, 31355.0, 31923.680763193, 32250.516242256854, 32566.34867302688, 24902.50194996126, 25061.24816255515, 25095.623565646896, 25297.367565810266, 25388.74611253938], "value": 17296.819577210346, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.2879666310758, 353.466265938433, 359.24379181822263, 360.13387802335376, 367.26730173304264, 12531.812022819653, 12916.999999999989, 13720.794188087175, 16414.425495107673, 16645.750313745302, 16597.66804663909, 16613.335466581324, 16668.33326666935, 16694.499165025038, 16755.162241887916, 4831.516848315176, 4997.775100120485, 5046.5710414614805, 5078.162103252959, 5081.898362032757, 3697.796621185834, 5074.0, 5149.098907691157, 5153.381594208681, 5645.8588535286535, 5911.556633252523, 5988.7604495820115, 6010.669413182273, 6018.0, 6020.969895150518, 5823.126531020339, 5956.047032474783, 6004.969975150118, 6019.819405417845, 6021.217241758543, 5242.60680448964, 5276.076686579871, 5284.524392804666, 5286.471352864722, 5289.2859463972645, 19941.302054428026, 20716.689249661267, 20831.687524687142, 20896.79103208979, 21008.26471073505, 2012.7987201279902, 2097.2345094040716, 2190.9811937449003, 2399.460121472672, 2534.239728081568, 8603.655853765842, 9104.908950910472, 12874.420651070724, 13197.406116724771, 13777.448902043907, 1709.880308378414, 1771.4508502364179, 1785.5179101642484, 1814.1926842555067, 1827.0, 64147.67926160339, 66840.33159668438, 67765.0, 69473.65263173652, 71463.64268178625, 9564.378315409476, 9892.901070989197, 9930.80138397228, 10223.846642300372, 10257.846132308021, 13638.0, 13665.726685466236, 13699.246541440316, 13702.52041178574, 13703.862961370258, 6843.520953533304, 7016.859662806715, 7030.296970303031, 7224.711011559479, 7416.295451932057, 6865.141857267841, 6912.585244885323, 6941.514094013371, 7076.0, 7092.574445533284, 3826.0, 3894.2406230784727, 4129.752214867118, 4259.87220383389, 4275.850345237902, 1698.830116988316, 1699.8470137687668, 1726.7755191824983, 1755.9385421510442, 1787.8033416324195, 844.8817165596821, 859.3168431097167, 866.4281574161149, 898.6854600889636, 904.1139683110457, 16473.67052658964, 16725.0, 17192.570185745455, 17479.905578629532, 17498.512626426895, 841.5455653946923, 841.8526757817358, 861.8793368928355, 887.7026196224338, 933.2394098809449, 9307.581158847868, 9665.323427360017, 9724.367916085432, 9736.610535578639, 9913.0, 181929.0, 183860.0, 396663.0, 401309.0, 402444.0, 49485.09245767135, 61979.83283262398, 84245.0, 86010.56994714987, 86913.0, 887.573964497045, 908.6683360573343, 917.40368760305, 950.4107453378949, 956.799072194833, 15235.238238088274, 15735.291911864222, 15998.0, 16085.678286433971, 16584.08787516698, 35816.283674325845, 36943.44584831283, 37820.0, 40106.799466002485, 42217.0, 52475.73762131165, 53356.0, 53533.464665354404, 54763.45236547743, 55376.169357458864, 4736.976315118402, 5462.617616766788, 5821.09772985171, 7334.413246940126, 7560.886586701094, 9815.0, 11765.882341176479, 12129.21160124589, 12451.066170037102, 12572.497100115894, 9667.371620844622, 9802.117809397188, 9960.302778805704, 10005.949970250102, 10376.844347334947, 10517.05346518817, 10589.841152382874, 10673.199510036624, 10817.405042722727, 11132.610358637408, 10561.788764224519, 10582.80830329597, 10666.89333106659, 10670.35977841332, 10711.357318560911, 7406.740764073232, 7637.541747495168, 7700.19147989453, 7710.151883292721, 7711.228877112244, 8343.499390036617, 10423.739406514898, 10650.8402373966, 10871.565137394417, 10883.401412922365], "value": 8177.746278504286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.109492187695, 1425.1876430434654, 1442.2284078018263, 1635.5665748576637, 1651.4054940221517, 6631.171103612049, 6831.658417079151, 7107.928920710791, 7601.505902116365, 7607.239276072397, 7321.524100933436, 7601.809954751134, 7615.8857617135645, 7800.946872172255, 7804.102528209258, 2106.9367918962416, 2132.9040193191267, 2135.370065830576, 2136.6260904341757, 2140.2295173737443, 1811.7282407638893, 2083.5207902182506, 2099.401670523901, 2126.138913739938, 2141.6038032963875, 2082.7084208210863, 2107.0202355904503, 2108.4939614492487, 2110.3985364171212, 2110.8416868734907, 2043.0, 2045.1512622261744, 2053.435305291042, 2068.338131797825, 2071.2543484345624, 2069.7412823397076, 2083.2812679625504, 2104.0, 2106.0207003743335, 2108.7996640319143, 7643.044619422572, 7762.146163921964, 7764.495307804975, 7766.57283849388, 7767.6892924282965, 4334.978325108385, 4469.776511174461, 4472.373867658531, 4472.44094488189, 4481.753503557303, 2736.822106563067, 2838.630977972871, 2890.4797136515417, 2896.3048868271676, 2949.6165498485275, 966.9371490853072, 973.5035132082618, 974.2303580171726, 986.2504496582649, 987.5802783816849, 10036.247281453847, 10045.246606504468, 10053.497325133714, 10090.394576325443, 10095.0, 3828.2343531293855, 3938.8424463021156, 4086.346184610448, 4126.463559737275, 4177.979110104491, 8330.375221858385, 8413.579321033923, 8435.11431299717, 8438.493690378475, 8448.83102337962, 4493.213687604656, 4499.55004499554, 4501.41481607389, 4501.707389019769, 4502.0, 4049.817758200888, 4124.752514849119, 4194.077302993336, 4197.9370309445385, 4204.789760511962, 3111.5177147542167, 3159.273367125574, 3232.046546268856, 3235.530848027023, 3255.967440325614, 815.355868863603, 901.7520181950016, 927.4296307770672, 1122.4836575175348, 1187.679326581818, 690.6374153569416, 745.4632664481564, 789.135896193667, 805.4643661964728, 825.3067621589029, 4933.555979961749, 4960.156773348539, 5033.84898453047, 5033.949660503421, 5336.866578335573, 842.1872892658491, 846.504794695098, 890.7283278599959, 891.1133422244908, 905.3798148268457, 3431.1765176357994, 3544.4506101554302, 3601.9099522512147, 3602.2615363850346, 3696.926061478809, 9090.090990900857, 9453.385529940531, 9467.053294670615, 9473.952630236943, 9481.431114133175, 8601.096884827128, 9348.813023739487, 9373.297002724823, 9383.24934005278, 9423.811523769624, 7052.2595127511895, 7264.673089710976, 7266.128064632172, 7268.6729097190755, 7270.963645181634, 5213.0, 5444.537214336826, 5534.39121696605, 5543.1408131739645, 5616.831495055155, 8450.154984501747, 8685.739427817176, 8717.869231961653, 8807.955960220157, 8843.115688431106, 8734.344924130588, 8827.16141966512, 8898.0, 8911.598978045873, 9015.278777697637, 6627.834304142435, 6765.797026089225, 6781.0, 6783.321667833177, 6787.389134977876, 6668.899966500409, 7051.647417628996, 7195.352418282379, 7234.493585448968, 7247.383972362408, 5505.889882202254, 5633.690147041952, 6402.743890244338, 6413.8717225656155, 6542.214934207926, 6347.555671103163, 6382.840428989312, 6404.231492220777, 6426.228852537725, 6428.614283143026, 6109.358517355614, 6114.2357205349335, 6158.599691020069, 6159.784407545714, 6161.815145545641, 4325.113351762818, 4439.156560253541, 4472.44094488189, 4473.977630111829, 4481.708688935209, 4656.743879086683, 4658.231391820312, 4658.627309815139, 4683.297505374221, 4780.259059845729], "value": 4003.531287446128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2566688110589, 288.13846598669977, 294.5228729458277, 295.0278831251028, 296.4589623936317, 4607.654425918061, 4741.928871066937, 4801.751544598408, 4876.536729010747, 4878.48775878533, 4548.772561371927, 4692.296155576665, 4699.459562150354, 4704.082703872747, 4708.43498780146, 3761.11613770765, 3763.1344790698017, 3768.284026035058, 3769.453429252757, 3774.867879624214, 3541.982290088546, 3613.5844377896483, 3749.7187710921653, 3763.9862673469697, 3783.924321513568, 3724.7578907370935, 3747.5128233329765, 3749.9812500937455, 3765.454009168669, 3772.6038765929457, 3757.0607348162957, 3758.9060273493383, 3760.6615404613444, 3767.8304476298495, 3778.7732736035928, 3311.718503927145, 3312.188513814107, 3318.435865902802, 3323.4848598467274, 3336.6830151135846, 4493.707908985938, 4637.489876113625, 4640.2343613303765, 4665.953340466586, 4678.532146785328, 4256.914861702749, 4257.254980378421, 4259.637930775888, 4267.4025636410925, 4267.893302667459, 4939.8024079036795, 4954.7274899880495, 4961.578265847407, 4972.701637901738, 4974.403071631391, 3326.652705654214, 3529.0, 3617.8733744318824, 3620.8913732588067, 3630.7095432365613, 5169.793208271664, 5170.767315470813, 5185.455527169631, 5198.2202669599865, 5219.947800521984, 3594.1194407370363, 3607.8376473058775, 3610.7291953103622, 3612.4581312802766, 3628.600853906068, 3658.634136586373, 3661.8352174151696, 3662.322470342942, 3665.0, 3671.375866102769, 3937.0, 4143.854965076208, 4183.874483765492, 4191.987845834016, 4198.0, 4985.302057711923, 4990.975045124751, 4994.72845286338, 4995.750212489361, 5007.749612519359, 1197.928124312544, 1223.1315765806198, 1243.6393445900587, 1246.9712487197917, 1254.930978796175, 835.9884539707023, 847.4322204123129, 863.1929146248278, 863.4344504349662, 870.9738707838775, 4425.933610995773, 4435.534268901783, 4438.733675979452, 4455.665825063068, 4459.643228541709, 5100.744962751847, 5102.744862756922, 5103.489651034867, 5105.8723531912, 5108.770105345268, 4440.0, 4441.977790111029, 4449.754068860724, 4452.977735111369, 4455.6658250631335, 2285.6000199964938, 2373.4896997145697, 2393.222202784067, 2421.7941474974473, 2422.551827911842, 4311.48262208537, 4327.199468098412, 4327.502337231259, 4348.434703488526, 4357.934630980538, 4609.2574917923785, 4620.903994323811, 4621.491635920046, 4660.347551342815, 4674.392328997209, 4120.546739858613, 4209.515905670826, 4263.59495847894, 4300.419443375167, 4348.5216626171095, 4499.235130027838, 4500.097437153084, 4511.398453548943, 4521.412216411845, 4522.547745225583, 4412.6249268811225, 4429.601335879786, 4449.688521803443, 4451.710638808467, 4488.316881169561, 4089.2434899543678, 4256.914861702687, 4263.87208383749, 4267.97866010668, 4345.630621397217, 3269.9019029429155, 3270.296886169485, 3279.885204017848, 3294.1435226841672, 3298.323843612102, 4510.909781804411, 4530.909381812279, 4536.138133754576, 4538.432695913011, 4889.242167464049, 4749.786259618395, 4949.876253093701, 4961.652684312208, 4979.726115063706, 4986.8753281168265, 4957.4794646561595, 4966.850994470172, 4967.503249675004, 4968.577670897869, 4969.875753106201, 4735.83424580138, 4891.315215869852, 4891.755412229445, 4893.0, 4895.143349913822, 4940.728259945738, 5005.924911126263, 5027.723475208899, 5030.4466508684745, 5032.3206367139965, 4875.195592727302, 4877.6829506081995, 4884.731339776346, 4888.682235654671, 4905.877353066202], "value": 3646.815045100798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5961266532428, 610.7404353149913, 622.1290193728779, 628.2774808969684, 724.4928550014987, 12764.106512544126, 13085.738285234289, 13846.376913038912, 13915.44338226471, 13923.582292531215, 14042.57872263831, 14052.086614370059, 14153.363098660586, 14185.71628567428, 14189.78715319271, 621.8911690454175, 734.9559026458417, 768.6310570925959, 778.4550814429894, 778.7858338956776, 754.6566312327877, 771.1440301265619, 781.4334607409611, 792.0495405513378, 792.7304716396424, 827.1852225557851, 828.9792755181138, 831.7255305749119, 831.8377916306323, 832.8001279692891, 645.1806206118204, 818.2758258940821, 824.7814329202766, 824.9463784853996, 825.3273582030656, 577.8410936992319, 579.1688926390643, 592.3129170162633, 598.407576499267, 598.7455331484102, 13039.86960130396, 13129.343532823415, 13155.671108222372, 13155.802662960063, 13163.802542961863, 11768.941155294255, 11984.400779960966, 12570.622881313575, 13240.0, 13871.098378605358, 11657.591984280594, 11692.766144677144, 11770.9305633894, 11985.101117416141, 12098.758024839542, 4097.487814023247, 4097.725762201977, 4155.480564929384, 4293.420388247578, 4294.269974104379, 63600.68199658972, 63904.68047659779, 64898.0, 64939.67530162319, 64975.67512162409, 10140.695779126638, 10230.693079207636, 10479.423631700178, 10604.734881628021, 10846.728831779112, 19448.4165475036, 19458.124384402738, 19469.902650486656, 19489.635725499364, 19534.511637209183, 6906.205786334535, 6950.374466298057, 7182.281771822776, 7182.281771822881, 7183.89224161638, 3838.846446142179, 3910.1006768443417, 3931.253061918226, 4002.1795531915886, 4005.0588111793704, 2666.480036392885, 2758.70340939758, 2758.820676656011, 2760.213339198319, 2778.583212518098, 461.4347424405077, 468.8312207605259, 502.92456131580553, 513.1891611254209, 527.1276038156857, 507.84764570628664, 530.7001544127555, 587.4477990688739, 601.9367966363557, 653.2977049671622, 8648.697295594624, 8660.783480412914, 8709.825803483895, 8750.956245218733, 8860.113988601088, 543.234040003593, 550.3066136667748, 589.1869220475802, 599.1671576508656, 616.9912193563556, 3855.267499175148, 3871.7483363581277, 4094.1811637672586, 4096.713230073866, 4120.320147175682, 99381.0, 99941.50029249807, 100419.0, 100533.0, 102452.48773756233, 86211.56894215614, 87297.0, 88581.0, 89112.5544372287, 91571.0, 79193.0, 80035.0, 80685.59657201794, 82230.76653850196, 82327.1789180027, 7648.961755191189, 7935.2064793520185, 8027.357811375193, 8086.87869681967, 8222.855020428377, 46031.0, 46269.30596040995, 46598.53401466078, 46765.2985205229, 47061.52938470572, 53943.46056539541, 56206.43793562012, 56610.0, 61023.694881525305, 61767.6911615439, 11341.489632966372, 11485.310881347146, 11545.942270288595, 11725.648230553097, 11811.82282265784, 13024.609261722164, 13066.150700204456, 13262.602121936357, 13401.0, 13409.262490562722, 12419.689507762378, 12451.0, 12748.745025099632, 12938.417771200131, 13345.199288042748, 11285.266457680225, 12129.272243665408, 12246.571370002008, 12505.93747031259, 12947.352632368156, 12099.455524501242, 12634.747305054032, 12705.42825572833, 13091.869081309065, 13094.541691040768, 9565.473898935625, 9933.255005874444, 10314.226433017404, 10476.63331783384, 10699.839502407314, 8845.159709827556, 9848.950755246464, 10108.747281318027, 10165.72928383952, 10589.311694739818], "value": 6723.142508437285, "unit": "score"}], "name": "dromaeo_css", "value": 6356.367620245263, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 113.0, 112.0, 113.0, 113.0, 114.0, 114.0, 115.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 122.0, 179.0, 122.0, 125.0, 148.0, 121.0, 168.0, 121.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 163.0, 162.0, 161.0, 160.0, 161.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 105.0, 78.0, 75.0, 75.0, 75.0, 99.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 120.0, 86.0, 85.0, 85.0, 133.0, 84.0, 85.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 65.0, 64.0, 62.0, 64.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 82.0, 79.0, 90.0, 84.0, 79.0, 80.0, 84.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 131.0, 129.0, 128.0, 128.0, 129.0, 137.0, 147.0, 152.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 175.0, 168.0, 173.0, 169.0, 164.0, 165.0, 167.0, 165.0, 166.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 66.0, 71.0, 68.0, 66.0, 66.0, 69.0, 67.0, 72.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1529.5, "alertThreshold": 2.0}]} 14:59:00 INFO - Return code: 0 14:59:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:01 INFO - # TBPL SUCCESS # 14:59:01 INFO - Running post-action listener: _resource_record_post_action 14:59:01 INFO - [mozharness: 2016-08-11 21:59:01.025335Z] Finished run-tests step (success) 14:59:01 INFO - Running post-run listener: _resource_record_post_run 14:59:01 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527245312; Read time: 12; Write time: 364872 14:59:01 INFO - TinderboxPrint: CPU usage
13.0% 14:59:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:59:01 INFO - TinderboxPrint: I/O write bytes / time
527,245,312 / 364,872 14:59:01 INFO - TinderboxPrint: CPU idle
8,321.8 (87.0%) 14:59:01 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 14:59:01 INFO - TinderboxPrint: Swap in / out
0 / 0 14:59:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237256704; Read time: 0; Write time: 192396 14:59:01 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285491200; Read time: 12; Write time: 171620 14:59:01 INFO - Running post-run listener: _upload_blobber_files 14:59:01 INFO - Blob upload gear active. 14:59:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:01 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 14:59:01 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'] 14:59:01 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 14:59:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:03 INFO - (blobuploader) - INFO - Done attempting. 14:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:06 INFO - (blobuploader) - INFO - Done attempting. 14:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:07 INFO - (blobuploader) - INFO - Done attempting. 14:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:07 INFO - Return code: 0 14:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a23bce41482ca2158f1846a8aa0b5714f0023ba29f56a74b551389fb488e72aac9e214584503966c41c7d4e6e3ad3b380add538351949d71f5c88906f118027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afaec5d68359723c2fe095aaa77e160ff9ae50dccdb7104c5365712dd6bf24b89f2638660f12899304c7a290b6bfc37002e739f53e245125552c3249e6e4b33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84fd132c46660133601c59c51689c01cd3597cf84659532151c09715837e583cc41dc1354ec0375db0a90b1ec64d87cc0436718c408aed0f47436ed12945ee0f"} 14:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:07 INFO - Contents: 14:59:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a23bce41482ca2158f1846a8aa0b5714f0023ba29f56a74b551389fb488e72aac9e214584503966c41c7d4e6e3ad3b380add538351949d71f5c88906f118027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afaec5d68359723c2fe095aaa77e160ff9ae50dccdb7104c5365712dd6bf24b89f2638660f12899304c7a290b6bfc37002e739f53e245125552c3249e6e4b33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84fd132c46660133601c59c51689c01cd3597cf84659532151c09715837e583cc41dc1354ec0375db0a90b1ec64d87cc0436718c408aed0f47436ed12945ee0f"} 14:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:07 INFO - Copying logs to upload dir... 14:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.404305 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 14:59:07.213782) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 14:59:07.217840) ========= 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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 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/6a23bce41482ca2158f1846a8aa0b5714f0023ba29f56a74b551389fb488e72aac9e214584503966c41c7d4e6e3ad3b380add538351949d71f5c88906f118027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afaec5d68359723c2fe095aaa77e160ff9ae50dccdb7104c5365712dd6bf24b89f2638660f12899304c7a290b6bfc37002e739f53e245125552c3249e6e4b33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84fd132c46660133601c59c51689c01cd3597cf84659532151c09715837e583cc41dc1354ec0375db0a90b1ec64d87cc0436718c408aed0f47436ed12945ee0f"} build_url:https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/L2u-JaBPTcOLCbrrSURIIA/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/6a23bce41482ca2158f1846a8aa0b5714f0023ba29f56a74b551389fb488e72aac9e214584503966c41c7d4e6e3ad3b380add538351949d71f5c88906f118027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/afaec5d68359723c2fe095aaa77e160ff9ae50dccdb7104c5365712dd6bf24b89f2638660f12899304c7a290b6bfc37002e739f53e245125552c3249e6e4b33c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84fd132c46660133601c59c51689c01cd3597cf84659532151c09715837e583cc41dc1354ec0375db0a90b1ec64d87cc0436718c408aed0f47436ed12945ee0f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 14:59:07.243542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:59:07.243884) ========= 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=ed14279e38b05397cf4aa391000001a4-1470951508.494984-154681895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 14:59:07.328379) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 14:59:07.328695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 14:59:07.329015) ========= ========= Total master_lag: 0.16 =========