builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1470626319.37 results: success (0) buildid: 20160807173002 builduid: 5c1a786ee8f9494cb29e5e4a36c0cfc0 revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.367547) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.367883) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.368159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.401314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.401572) ========= 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=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 20:18:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-07 20:18:39 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.509243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.509517) ========= 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=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.560412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:39.560701) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c --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=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 20:18:39,738 truncating revision to first 12 chars 2016-08-07 20:18:39,738 Setting DEBUG logging. 2016-08-07 20:18:39,738 attempt 1/10 2016-08-07 20:18:39,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/763fe887c37c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 20:18:40,081 unpacking tar archive at: fx-team-763fe887c37c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:40.241113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:40.241439) ========= script_repo_revision: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:40.241835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:40.242094) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 20:18:40.260004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-07 20:18:40.260259) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:18:40 INFO - MultiFileLogger online at 20160807 20:18:40 in /builds/slave/test 20:18:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:18:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:18:40 INFO - {'append_to_log': False, 20:18:40 INFO - 'base_work_dir': '/builds/slave/test', 20:18:40 INFO - 'blob_upload_branch': 'Fx-Team', 20:18:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:18:40 INFO - 'branch': 'Fx-Team', 20:18:40 INFO - 'buildbot_json_path': 'buildprops.json', 20:18:40 INFO - 'config_files': ('talos/linux_config.py',), 20:18:40 INFO - 'default_actions': ('clobber', 20:18:40 INFO - 'read-buildbot-config', 20:18:40 INFO - 'download-and-extract', 20:18:40 INFO - 'populate-webroot', 20:18:40 INFO - 'create-virtualenv', 20:18:40 INFO - 'install', 20:18:40 INFO - 'run-tests'), 20:18:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:18:40 INFO - 'download_minidump_stackwalk': True, 20:18:40 INFO - 'download_symbols': 'ondemand', 20:18:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:18:40 INFO - 'tooltool.py': '/tools/tooltool.py', 20:18:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:18:40 INFO - '/tools/misc-python/virtualenv.py')}, 20:18:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:18:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:18:40 INFO - 'installer_path': 'installer.exe', 20:18:40 INFO - 'log_level': 'info', 20:18:40 INFO - 'log_name': 'talos', 20:18:40 INFO - 'log_to_console': True, 20:18:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:18:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:18:40 INFO - 'opt_config_files': (), 20:18:40 INFO - 'pip_index': False, 20:18:40 INFO - 'sps_profile': False, 20:18:40 INFO - 'sps_profile_interval': 0, 20:18:40 INFO - 'suite': 'dromaeojs', 20:18:40 INFO - 'system_bits': '32', 20:18:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:18:40 INFO - 'title': 'talos-linux64-ix-026', 20:18:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:18:40 INFO - 'use_talos_json': True, 20:18:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:18:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:18:40 INFO - 'work_dir': 'build'} 20:18:40 INFO - [mozharness: 2016-08-08 03:18:40.531429Z] Running clobber step. 20:18:40 INFO - Running pre-action listener: _resource_record_pre_action 20:18:40 INFO - Running main action method: clobber 20:18:40 INFO - rmtree: /builds/slave/test/build 20:18:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:18:40 INFO - Running post-action listener: _resource_record_post_action 20:18:40 INFO - [mozharness: 2016-08-08 03:18:40.980888Z] Finished clobber step (success) 20:18:40 INFO - [mozharness: 2016-08-08 03:18:40.980988Z] Running read-buildbot-config step. 20:18:40 INFO - Running pre-action listener: _resource_record_pre_action 20:18:40 INFO - Running main action method: read_buildbot_config 20:18:40 INFO - Using buildbot properties: 20:18:40 INFO - { 20:18:40 INFO - "project": "", 20:18:40 INFO - "product": "firefox", 20:18:40 INFO - "script_repo_revision": "production", 20:18:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:18:40 INFO - "repository": "", 20:18:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:18:40 INFO - "buildid": "20160807173002", 20:18:40 INFO - "pgo_build": "True", 20:18:40 INFO - "basedir": "/builds/slave/test", 20:18:40 INFO - "buildnumber": 961, 20:18:40 INFO - "slavename": "talos-linux64-ix-026", 20:18:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:18:40 INFO - "platform": "ubuntu64_hw", 20:18:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:18:40 INFO - "branch": "fx-team", 20:18:40 INFO - "repo_path": "integration/fx-team", 20:18:40 INFO - "revision": "763fe887c37cee5fcfe0f00e94fdffc84a41ea1c", 20:18:40 INFO - "stage_platform": "linux64-pgo", 20:18:40 INFO - "builduid": "5c1a786ee8f9494cb29e5e4a36c0cfc0", 20:18:40 INFO - "slavebuilddir": "test" 20:18:40 INFO - } 20:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:18:40 INFO - Running post-action listener: _resource_record_post_action 20:18:40 INFO - [mozharness: 2016-08-08 03:18:40.983460Z] Finished read-buildbot-config step (success) 20:18:40 INFO - [mozharness: 2016-08-08 03:18:40.983550Z] Running download-and-extract step. 20:18:40 INFO - Running pre-action listener: _resource_record_pre_action 20:18:40 INFO - Running main action method: download_and_extract 20:18:40 INFO - mkdir: /builds/slave/test/build/tests 20:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:40 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:41 INFO - Downloaded 1361 bytes. 20:18:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:41 INFO - Using the following test package requirements: 20:18:41 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:18:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:18:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'jsshell-linux-x86_64.zip'], 20:18:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:18:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:18:41 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:18:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:18:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:18:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:18:41 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')]} 20:18:41 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:43 INFO - Downloaded 21828560 bytes. 20:18:43 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'] 20:18:43 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 20:18:44 INFO - Return code: 0 20:18:44 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 20:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:44 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:45 INFO - Downloaded 21828560 bytes. 20:18:45 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'] 20:18:45 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 20:18:46 INFO - Return code: 0 20:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:18:46 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:18:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:50 INFO - Downloaded 14413723 bytes. 20:18:50 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'] 20:18:50 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 20:18:50 INFO - Return code: 0 20:18: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')]} 20:18:50 INFO - trying https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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 20:18:54 INFO - Downloaded 59972841 bytes. 20:18:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:54 INFO - mkdir: /builds/slave/test/properties 20:18:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:18:54 INFO - Writing to file /builds/slave/test/properties/build_url 20:18:54 INFO - Contents: 20:18:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:18:55 INFO - Running post-action listener: _resource_record_post_action 20:18:55 INFO - Running post-action listener: set_extra_try_arguments 20:18:55 INFO - [mozharness: 2016-08-08 03:18:55.159817Z] Finished download-and-extract step (success) 20:18:55 INFO - [mozharness: 2016-08-08 03:18:55.160057Z] Running populate-webroot step. 20:18:55 INFO - Running pre-action listener: _resource_record_pre_action 20:18:55 INFO - Running main action method: populate_webroot 20:18:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:18:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:18:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:18:55 INFO - '--tppagecycles', 20:18:55 INFO - '7'], 20:18:55 INFO - 'tests': ['tsvgm']}}, 20:18:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:18:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:18:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:18:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:18:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:18:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['damp', 'tps']}, 20:18:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'tests': ['damp', 'tps']}, 20:18:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['dromaeo_dom']}, 20:18:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:18:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['basic_compositor_video']}, 20:18:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:18:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'other-e10s': {'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['a11yr', 20:18:55 INFO - 'ts_paint', 20:18:55 INFO - 'tpaint', 20:18:55 INFO - 'sessionrestore', 20:18:55 INFO - 'sessionrestore_no_auto_restore', 20:18:55 INFO - 'tabpaint']}, 20:18:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['tsvgx', 20:18:55 INFO - 'tsvgr_opacity', 20:18:55 INFO - 'tart', 20:18:55 INFO - 'tscrollx', 20:18:55 INFO - 'cart']}, 20:18:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:18:55 INFO - 'tsvgr_opacity', 20:18:55 INFO - 'tart', 20:18:55 INFO - 'tscrollx', 20:18:55 INFO - 'cart']}, 20:18:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'talos_options': ['--disable-e10s'], 20:18:55 INFO - 'tests': ['tp5o']}, 20:18:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'tests': ['tp5o']}, 20:18:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'talos_options': ['--disable-e10s', 20:18:55 INFO - '--xperf_path', 20:18:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:55 INFO - 'tests': ['tp5n']}, 20:18:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:18:55 INFO - 'talos_options': ['--xperf_path', 20:18:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:18:55 INFO - 'tests': ['tp5n']}}, 20:18:55 INFO - 'talos.zip': {'path': '', 20:18:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:18:55 INFO - Running post-action listener: _resource_record_post_action 20:18:55 INFO - [mozharness: 2016-08-08 03:18:55.187761Z] Finished populate-webroot step (success) 20:18:55 INFO - [mozharness: 2016-08-08 03:18:55.187850Z] Running create-virtualenv step. 20:18:55 INFO - Running pre-action listener: _resource_record_pre_action 20:18:55 INFO - Running main action method: create_virtualenv 20:18:55 INFO - Creating virtualenv /builds/slave/test/build/venv 20:18:55 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 20:18:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:18:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:18:55 INFO - Using real prefix '/usr' 20:18:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:18:55 INFO - Installing distribute.............................................................................................................................................................................................done. 20:18:57 INFO - Installing pip.................done. 20:18:57 INFO - Return code: 0 20:18:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:18:57 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')]} 20:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:57 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')]} 20:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:57 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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:18:57 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 20:18:57 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 20:18:57 INFO - Using env: {'DISPLAY': ':0', 20:18:57 INFO - 'HOME': '/home/cltbld', 20:18:57 INFO - 'LANG': 'en_US.UTF-8', 20:18:57 INFO - 'LANGUAGE': 'en_US:en', 20:18:57 INFO - 'LOGNAME': 'cltbld', 20:18:57 INFO - 'MAIL': '/var/mail/cltbld', 20:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:57 INFO - 'MOZ_NO_REMOTE': '1', 20:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:57 INFO - 'NO_EM_RESTART': '1', 20:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:57 INFO - 'PWD': '/builds/slave/test', 20:18:57 INFO - 'SHELL': '/bin/bash', 20:18:57 INFO - 'SHLVL': '1', 20:18:57 INFO - 'TERM': 'linux', 20:18:57 INFO - 'TMOUT': '86400', 20:18:57 INFO - 'USER': 'cltbld', 20:18:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:57 INFO - '_': '/tools/buildbot/bin/python'} 20:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:57 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 20:18:57 INFO - Cleaning up... 20:18:57 INFO - Return code: 0 20:18:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:18:57 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')]} 20:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:57 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')]} 20:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:18:57 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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:18:57 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 20:18:57 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 20:18:57 INFO - Using env: {'DISPLAY': ':0', 20:18:57 INFO - 'HOME': '/home/cltbld', 20:18:57 INFO - 'LANG': 'en_US.UTF-8', 20:18:57 INFO - 'LANGUAGE': 'en_US:en', 20:18:57 INFO - 'LOGNAME': 'cltbld', 20:18:57 INFO - 'MAIL': '/var/mail/cltbld', 20:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:18:57 INFO - 'MOZ_NO_REMOTE': '1', 20:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:18:57 INFO - 'NO_EM_RESTART': '1', 20:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:18:57 INFO - 'PWD': '/builds/slave/test', 20:18:57 INFO - 'SHELL': '/bin/bash', 20:18:57 INFO - 'SHLVL': '1', 20:18:57 INFO - 'TERM': 'linux', 20:18:57 INFO - 'TMOUT': '86400', 20:18:57 INFO - 'USER': 'cltbld', 20:18:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:18:57 INFO - '_': '/tools/buildbot/bin/python'} 20:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:18:58 INFO - Downloading/unpacking psutil>=3.1.1 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:18: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 20:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:00 INFO - Installing collected packages: psutil 20:19:00 INFO - Running setup.py install for psutil 20:19:00 INFO - building 'psutil._psutil_linux' extension 20:19:00 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 20:19:00 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 20:19:00 INFO - building 'psutil._psutil_posix' extension 20:19:00 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 20:19:00 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 20:19:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:01 INFO - Successfully installed psutil 20:19:01 INFO - Cleaning up... 20:19:01 INFO - Return code: 0 20:19:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:19:01 INFO - Using env: {'DISPLAY': ':0', 20:19:01 INFO - 'HOME': '/home/cltbld', 20:19:01 INFO - 'LANG': 'en_US.UTF-8', 20:19:01 INFO - 'LANGUAGE': 'en_US:en', 20:19:01 INFO - 'LOGNAME': 'cltbld', 20:19:01 INFO - 'MAIL': '/var/mail/cltbld', 20:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:01 INFO - 'MOZ_NO_REMOTE': '1', 20:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:01 INFO - 'NO_EM_RESTART': '1', 20:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:01 INFO - 'PWD': '/builds/slave/test', 20:19:01 INFO - 'SHELL': '/bin/bash', 20:19:01 INFO - 'SHLVL': '1', 20:19:01 INFO - 'TERM': 'linux', 20:19:01 INFO - 'TMOUT': '86400', 20:19:01 INFO - 'USER': 'cltbld', 20:19:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:01 INFO - '_': '/tools/buildbot/bin/python'} 20:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:03 INFO - Installing collected packages: mozsystemmonitor 20:19:03 INFO - Running setup.py install for mozsystemmonitor 20:19:03 INFO - Successfully installed mozsystemmonitor 20:19:03 INFO - Cleaning up... 20:19:03 INFO - Return code: 0 20:19:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:19:03 INFO - Using env: {'DISPLAY': ':0', 20:19:03 INFO - 'HOME': '/home/cltbld', 20:19:03 INFO - 'LANG': 'en_US.UTF-8', 20:19:03 INFO - 'LANGUAGE': 'en_US:en', 20:19:03 INFO - 'LOGNAME': 'cltbld', 20:19:03 INFO - 'MAIL': '/var/mail/cltbld', 20:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:03 INFO - 'MOZ_NO_REMOTE': '1', 20:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:03 INFO - 'NO_EM_RESTART': '1', 20:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:03 INFO - 'PWD': '/builds/slave/test', 20:19:03 INFO - 'SHELL': '/bin/bash', 20:19:03 INFO - 'SHLVL': '1', 20:19:03 INFO - 'TERM': 'linux', 20:19:03 INFO - 'TMOUT': '86400', 20:19:03 INFO - 'USER': 'cltbld', 20:19:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:03 INFO - '_': '/tools/buildbot/bin/python'} 20:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:03 INFO - Downloading/unpacking jsonschema==2.5.1 20:19:03 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 20:19:03 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 20:19:03 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 20:19:03 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 20:19:03 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 20:19:03 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 20:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:19:05 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 20:19:05 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 20:19:05 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 20:19:05 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 20:19:05 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 20:19:05 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 20:19:05 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:05 INFO - warning: no files found matching '*.txt' 20:19:05 INFO - no previously-included directories found matching 'build' 20:19:05 INFO - no previously-included directories found matching 'dist' 20:19:05 INFO - no previously-included directories found matching '.git*' 20:19:05 INFO - Installing collected packages: jsonschema, functools32 20:19:05 INFO - Running setup.py install for functools32 20:19:06 INFO - warning: no files found matching '*.txt' 20:19:06 INFO - no previously-included directories found matching 'build' 20:19:06 INFO - no previously-included directories found matching 'dist' 20:19:06 INFO - no previously-included directories found matching '.git*' 20:19:06 INFO - Successfully installed jsonschema functools32 20:19:06 INFO - Cleaning up... 20:19:06 INFO - Return code: 0 20:19:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:19:06 INFO - Using env: {'DISPLAY': ':0', 20:19:06 INFO - 'HOME': '/home/cltbld', 20:19:06 INFO - 'LANG': 'en_US.UTF-8', 20:19:06 INFO - 'LANGUAGE': 'en_US:en', 20:19:06 INFO - 'LOGNAME': 'cltbld', 20:19:06 INFO - 'MAIL': '/var/mail/cltbld', 20:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:06 INFO - 'MOZ_NO_REMOTE': '1', 20:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:06 INFO - 'NO_EM_RESTART': '1', 20:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:06 INFO - 'PWD': '/builds/slave/test', 20:19:06 INFO - 'SHELL': '/bin/bash', 20:19:06 INFO - 'SHLVL': '1', 20:19:06 INFO - 'TERM': 'linux', 20:19:06 INFO - 'TMOUT': '86400', 20:19:06 INFO - 'USER': 'cltbld', 20:19:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:06 INFO - '_': '/tools/buildbot/bin/python'} 20:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:19:06 INFO - Cleaning up... 20:19:06 INFO - Return code: 0 20:19:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:19:06 INFO - Using env: {'DISPLAY': ':0', 20:19:06 INFO - 'HOME': '/home/cltbld', 20:19:06 INFO - 'LANG': 'en_US.UTF-8', 20:19:06 INFO - 'LANGUAGE': 'en_US:en', 20:19:06 INFO - 'LOGNAME': 'cltbld', 20:19:06 INFO - 'MAIL': '/var/mail/cltbld', 20:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:06 INFO - 'MOZ_NO_REMOTE': '1', 20:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:06 INFO - 'NO_EM_RESTART': '1', 20:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:06 INFO - 'PWD': '/builds/slave/test', 20:19:06 INFO - 'SHELL': '/bin/bash', 20:19:06 INFO - 'SHLVL': '1', 20:19:06 INFO - 'TERM': 'linux', 20:19:06 INFO - 'TMOUT': '86400', 20:19:06 INFO - 'USER': 'cltbld', 20:19:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:06 INFO - '_': '/tools/buildbot/bin/python'} 20:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:06 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:08 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:09 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 20:19:09 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 20:19:09 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 20:19:09 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 20:19:09 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 20:19:09 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 20:19:09 INFO - Downloading docopt-0.6.1.tar.gz 20:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:09 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:09 INFO - Running setup.py install for blobuploader 20:19:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:09 INFO - Running setup.py install for requests 20:19:10 INFO - Running setup.py install for docopt 20:19:10 INFO - Successfully installed blobuploader requests docopt 20:19:10 INFO - Cleaning up... 20:19:10 INFO - Return code: 0 20:19:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:10 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')]} 20:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 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')]} 20:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:10 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 20:19:10 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 20:19:10 INFO - Using env: {'DISPLAY': ':0', 20:19:10 INFO - 'HOME': '/home/cltbld', 20:19:10 INFO - 'LANG': 'en_US.UTF-8', 20:19:10 INFO - 'LANGUAGE': 'en_US:en', 20:19:10 INFO - 'LOGNAME': 'cltbld', 20:19:10 INFO - 'MAIL': '/var/mail/cltbld', 20:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:10 INFO - 'MOZ_NO_REMOTE': '1', 20:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:10 INFO - 'NO_EM_RESTART': '1', 20:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:10 INFO - 'PWD': '/builds/slave/test', 20:19:10 INFO - 'SHELL': '/bin/bash', 20:19:10 INFO - 'SHLVL': '1', 20:19:10 INFO - 'TERM': 'linux', 20:19:10 INFO - 'TMOUT': '86400', 20:19:10 INFO - 'USER': 'cltbld', 20:19:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:10 INFO - '_': '/tools/buildbot/bin/python'} 20:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:10 INFO - Running setup.py (path:/tmp/pip-glyes0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:10 INFO - Running setup.py (path:/tmp/pip-L0XYXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:10 INFO - Running setup.py (path:/tmp/pip-jbdGIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:10 INFO - Running setup.py (path:/tmp/pip-XVNEPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:10 INFO - Running setup.py (path:/tmp/pip-sCVfSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:11 INFO - Running setup.py (path:/tmp/pip-HLnCpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:11 INFO - Running setup.py (path:/tmp/pip-8wI55m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:11 INFO - Running setup.py (path:/tmp/pip-cytYZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:11 INFO - Running setup.py (path:/tmp/pip-IZTOsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:11 INFO - Running setup.py (path:/tmp/pip-Pa6Zok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:11 INFO - Running setup.py (path:/tmp/pip-i4cmqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:11 INFO - Running setup.py (path:/tmp/pip-6xaf1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:11 INFO - Running setup.py (path:/tmp/pip-mb_6B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:11 INFO - Running setup.py (path:/tmp/pip-KexJlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:11 INFO - Running setup.py (path:/tmp/pip-gWo6ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:11 INFO - Running setup.py (path:/tmp/pip-xYwFVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:11 INFO - Running setup.py (path:/tmp/pip-c4JgHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:11 INFO - Running setup.py install for manifestparser 20:19:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for mozcrash 20:19:12 INFO - Running setup.py install for mozdebug 20:19:12 INFO - Running setup.py install for mozdevice 20:19:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for mozfile 20:19:12 INFO - Running setup.py install for mozhttpd 20:19:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for mozinfo 20:19:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for mozInstall 20:19:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for mozleak 20:19:12 INFO - Running setup.py install for mozlog 20:19:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:12 INFO - Running setup.py install for moznetwork 20:19:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Running setup.py install for mozprocess 20:19:13 INFO - Running setup.py install for mozprofile 20:19:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Running setup.py install for mozrunner 20:19:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Running setup.py install for mozscreenshot 20:19:13 INFO - Running setup.py install for moztest 20:19:13 INFO - Running setup.py install for mozversion 20:19:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:13 INFO - Cleaning up... 20:19:13 INFO - Return code: 0 20:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:13 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')]} 20:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:13 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')]} 20:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:13 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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:13 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 20:19:13 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 20:19:13 INFO - Using env: {'DISPLAY': ':0', 20:19:13 INFO - 'HOME': '/home/cltbld', 20:19:13 INFO - 'LANG': 'en_US.UTF-8', 20:19:13 INFO - 'LANGUAGE': 'en_US:en', 20:19:13 INFO - 'LOGNAME': 'cltbld', 20:19:13 INFO - 'MAIL': '/var/mail/cltbld', 20:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:13 INFO - 'MOZ_NO_REMOTE': '1', 20:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:13 INFO - 'NO_EM_RESTART': '1', 20:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:13 INFO - 'PWD': '/builds/slave/test', 20:19:13 INFO - 'SHELL': '/bin/bash', 20:19:13 INFO - 'SHLVL': '1', 20:19:13 INFO - 'TERM': 'linux', 20:19:13 INFO - 'TMOUT': '86400', 20:19:13 INFO - 'USER': 'cltbld', 20:19:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:13 INFO - '_': '/tools/buildbot/bin/python'} 20:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:13 INFO - Running setup.py (path:/tmp/pip-mlG2es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:14 INFO - Running setup.py (path:/tmp/pip-WEnPsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:14 INFO - Running setup.py (path:/tmp/pip-Jyadsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:14 INFO - Running setup.py (path:/tmp/pip-LCli8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:14 INFO - Running setup.py (path:/tmp/pip-SVaC8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:14 INFO - Running setup.py (path:/tmp/pip-8oVk5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:14 INFO - Running setup.py (path:/tmp/pip-vqC1lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:14 INFO - Running setup.py (path:/tmp/pip-rTYpTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:14 INFO - Running setup.py (path:/tmp/pip-KkdTU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:14 INFO - Running setup.py (path:/tmp/pip-8VzILF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:14 INFO - Running setup.py (path:/tmp/pip-Bw38Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:14 INFO - Running setup.py (path:/tmp/pip-hFAGLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:14 INFO - Running setup.py (path:/tmp/pip-KFRSCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:14 INFO - Running setup.py (path:/tmp/pip-nJ7h9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:14 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)) 20:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:14 INFO - Running setup.py (path:/tmp/pip-RLdjFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:15 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)) 20:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:15 INFO - Running setup.py (path:/tmp/pip-XAFhSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:15 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)) 20:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:15 INFO - Running setup.py (path:/tmp/pip-JZlwQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:15 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)) 20:19:15 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)) 20:19:15 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)) 20:19:15 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)) 20:19:15 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)) 20:19:15 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)) 20:19:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:17 INFO - Downloading blessings-1.6.tar.gz 20:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:17 INFO - Installing collected packages: blessings 20:19:17 INFO - Running setup.py install for blessings 20:19:17 INFO - Successfully installed blessings 20:19:17 INFO - Cleaning up... 20:19:17 INFO - Return code: 0 20:19:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:17 INFO - Reading from file tmpfile_stdout 20:19:17 INFO - Current package versions: 20:19:17 INFO - argparse == 1.2.1 20:19:17 INFO - blessings == 1.6 20:19:17 INFO - blobuploader == 1.2.4 20:19:17 INFO - docopt == 0.6.1 20:19:17 INFO - functools32 == 3.2.3-2 20:19:17 INFO - jsonschema == 2.5.1 20:19:17 INFO - manifestparser == 1.1 20:19:17 INFO - mozInstall == 1.12 20:19:17 INFO - mozcrash == 0.17 20:19:17 INFO - mozdebug == 0.1 20:19:17 INFO - mozdevice == 0.48 20:19:17 INFO - mozfile == 1.2 20:19:17 INFO - mozhttpd == 0.7 20:19:17 INFO - mozinfo == 0.9 20:19:17 INFO - mozleak == 0.1 20:19:17 INFO - mozlog == 3.3 20:19:17 INFO - moznetwork == 0.27 20:19:17 INFO - mozprocess == 0.23 20:19:17 INFO - mozprofile == 0.28 20:19:17 INFO - mozrunner == 6.12 20:19:17 INFO - mozscreenshot == 0.1 20:19:17 INFO - mozsystemmonitor == 0.3 20:19:17 INFO - moztest == 0.7 20:19:17 INFO - mozversion == 1.4 20:19:17 INFO - psutil == 3.1.1 20:19:17 INFO - requests == 1.2.3 20:19:17 INFO - wsgiref == 0.1.2 20:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:17 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 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:17 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 20:19:17 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 20:19:17 INFO - Using env: {'DISPLAY': ':0', 20:19:17 INFO - 'HOME': '/home/cltbld', 20:19:17 INFO - 'LANG': 'en_US.UTF-8', 20:19:17 INFO - 'LANGUAGE': 'en_US:en', 20:19:17 INFO - 'LOGNAME': 'cltbld', 20:19:17 INFO - 'MAIL': '/var/mail/cltbld', 20:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:17 INFO - 'MOZ_NO_REMOTE': '1', 20:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:17 INFO - 'NO_EM_RESTART': '1', 20:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:17 INFO - 'PWD': '/builds/slave/test', 20:19:17 INFO - 'SHELL': '/bin/bash', 20:19:17 INFO - 'SHLVL': '1', 20:19:17 INFO - 'TERM': 'linux', 20:19:17 INFO - 'TMOUT': '86400', 20:19:17 INFO - 'USER': 'cltbld', 20:19:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:17 INFO - '_': '/tools/buildbot/bin/python'} 20:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 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)) 20:19:17 INFO - Cleaning up... 20:19:17 INFO - Return code: 0 20:19:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfbd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, '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': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', '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 20:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:19:17 INFO - Using env: {'DISPLAY': ':0', 20:19:17 INFO - 'HOME': '/home/cltbld', 20:19:17 INFO - 'LANG': 'en_US.UTF-8', 20:19:17 INFO - 'LANGUAGE': 'en_US:en', 20:19:17 INFO - 'LOGNAME': 'cltbld', 20:19:17 INFO - 'MAIL': '/var/mail/cltbld', 20:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:17 INFO - 'MOZ_NO_REMOTE': '1', 20:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:17 INFO - 'NO_EM_RESTART': '1', 20:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:17 INFO - 'PWD': '/builds/slave/test', 20:19:17 INFO - 'SHELL': '/bin/bash', 20:19:17 INFO - 'SHLVL': '1', 20:19:17 INFO - 'TERM': 'linux', 20:19:17 INFO - 'TMOUT': '86400', 20:19:17 INFO - 'USER': 'cltbld', 20:19:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:17 INFO - '_': '/tools/buildbot/bin/python'} 20:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:19:18 INFO - Cleaning up... 20:19:18 INFO - Return code: 0 20:19:18 INFO - Running post-action listener: _resource_record_post_action 20:19:18 INFO - Running post-action listener: _start_resource_monitoring 20:19:18 INFO - Starting resource monitoring. 20:19:18 INFO - [mozharness: 2016-08-08 03:19:18.215710Z] Finished create-virtualenv step (success) 20:19:18 INFO - [mozharness: 2016-08-08 03:19:18.216194Z] Running install step. 20:19:18 INFO - Running pre-action listener: _resource_record_pre_action 20:19:18 INFO - Running main action method: install 20:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:18 INFO - Reading from file tmpfile_stdout 20:19:18 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:18 INFO - Reading from file tmpfile_stdout 20:19:18 INFO - Output received: 20:19:18 INFO - Usage: mozinstall [options] installer 20:19:18 INFO - Options: 20:19:18 INFO - -h, --help show this help message and exit 20:19:18 INFO - -d DEST, --destination=DEST 20:19:18 INFO - Directory to install application into. [default: 20:19:18 INFO - "/builds/slave/test"] 20:19:18 INFO - --app=APP Application being installed. [default: firefox] 20:19:18 INFO - mkdir: /builds/slave/test/build/application 20:19:18 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'] 20:19:18 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 20:19:35 INFO - Reading from file tmpfile_stdout 20:19:35 INFO - Output received: 20:19:35 INFO - /builds/slave/test/build/application/firefox/firefox 20:19:35 INFO - Running post-action listener: _resource_record_post_action 20:19:35 INFO - [mozharness: 2016-08-08 03:19:35.597870Z] Finished install step (success) 20:19:35 INFO - [mozharness: 2016-08-08 03:19:35.598115Z] Running run-tests step. 20:19:35 INFO - Running pre-action listener: _resource_record_pre_action 20:19:35 INFO - Running main action method: run_tests 20:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:19:35 INFO - Python 2.7.3 20:19:35 INFO - Return code: 0 20:19:35 INFO - grabbing minidump binary from tooltool 20:19:35 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')]} 20:19:35 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 0x127c3b0>, '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 0x127d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x127d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:19:35 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 20:19:35 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 20:19:35 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 20:19:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:19:35 INFO - Return code: 0 20:19:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:19:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:19:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:19:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:19:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:19:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 20:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 20:19:35 INFO - Using env: {'DISPLAY': ':0', 20:19:35 INFO - 'HOME': '/home/cltbld', 20:19:35 INFO - 'LANG': 'en_US.UTF-8', 20:19:35 INFO - 'LANGUAGE': 'en_US:en', 20:19:35 INFO - 'LOGNAME': 'cltbld', 20:19:35 INFO - 'MAIL': '/var/mail/cltbld', 20:19:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:19:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:35 INFO - 'MOZ_NO_REMOTE': '1', 20:19:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:35 INFO - 'NO_EM_RESTART': '1', 20:19:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:35 INFO - 'PWD': '/builds/slave/test', 20:19:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:19:35 INFO - 'SHELL': '/bin/bash', 20:19:35 INFO - 'SHLVL': '1', 20:19:35 INFO - 'TERM': 'linux', 20:19:35 INFO - 'TMOUT': '86400', 20:19:35 INFO - 'USER': 'cltbld', 20:19:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693', 20:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:35 INFO - '_': '/tools/buildbot/bin/python'} 20:19:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 20:19:35 INFO - mozversion application_buildid: 20160807173002 20:19:35 INFO - mozversion application_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 20:19:35 INFO - mozversion application_display_name: Nightly 20:19:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:19:35 INFO - mozversion application_name: Firefox 20:19:35 INFO - mozversion application_remotingname: firefox 20:19:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:19:35 INFO - mozversion application_vendor: Mozilla 20:19:35 INFO - mozversion application_version: 51.0a1 20:19:35 INFO - mozversion platform_buildid: 20160807173002 20:19:35 INFO - mozversion platform_changeset: 763fe887c37cee5fcfe0f00e94fdffc84a41ea1c 20:19:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:19:35 INFO - mozversion platform_version: 51.0a1 20:19:35 INFO - using testdate: 1470626375 20:19:35 INFO - actual date: 1470626375 20:19:35 INFO - starting webserver on 'localhost:47429' 20:19:35 INFO - SUITE-START | Running 2 tests 20:19:35 INFO - TEST-START | dromaeo_css 20:19:35 INFO - operating with platform_type : linux_ 20:19:35 INFO - Initialising browser for dromaeo_css test... 20:19:35 INFO - TEST-INFO | started process 17746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbF91B/profile http://localhost:47429/getInfo.html) 20:19:39 INFO - PROCESS | 17746 | __metrics Screen width/height:1600/1200 20:19:39 INFO - PROCESS | 17746 | colorDepth:24 20:19:39 INFO - PROCESS | 17746 | Browser inner width/height: 1024/697 20:19:39 INFO - PROCESS | 17746 | __metrics 20:19:40 INFO - PROCESS | 17746 | 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" 20:19:40 INFO - PROCESS | 17746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:41 INFO - TEST-INFO | 17746: exit 0 20:19:41 INFO - Browser initialized. 20:19:41 INFO - Running cycle 1/1 for dromaeo_css test... 20:19:41 INFO - TEST-INFO | started process 17829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbF91B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:19:53 INFO - PROCESS | 17829 | RSS: Main: 156372992 20:19:53 INFO - PROCESS | 17829 | 20:20:44 INFO - PROCESS | 17829 | 1470626444953 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] 20:22:53 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47429/tests/dromaeo/cssquery-ext.html) 20:22:55 INFO - PROCESS | 17829 | RSS: Main: 289411072 20:22:55 INFO - PROCESS | 17829 | 20:25:57 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-ext.html (next: http://localhost:47429/tests/dromaeo/cssquery-jquery.html) 20:25:58 INFO - PROCESS | 17829 | RSS: Main: 245153792 20:25:58 INFO - PROCESS | 17829 | 20:29:00 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47429/tests/dromaeo/cssquery-mootools.html) 20:29:00 INFO - PROCESS | 17829 | RSS: Main: 242294784 20:29:00 INFO - PROCESS | 17829 | 20:32:02 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47429/tests/dromaeo/cssquery-prototype.html) 20:32:03 INFO - PROCESS | 17829 | RSS: Main: 242831360 20:32:03 INFO - PROCESS | 17829 | 20:35:05 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47429/tests/dromaeo/cssquery-yui.html) 20:35:06 INFO - PROCESS | 17829 | RSS: Main: 190455808 20:35:06 INFO - PROCESS | 17829 | 20:38:09 INFO - PROCESS | 17829 | Cycle 1(1): loaded http://localhost:47429/tests/dromaeo/cssquery-yui.html (next: http://localhost:47429/tests/dromaeo/cssquery-dojo.html) 20:38:10 INFO - PROCESS | 17829 | RSS: Main: 281722880 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | __start_tp_report 20:38:10 INFO - PROCESS | 17829 | _x_x_mozilla_page_load 20:38:10 INFO - PROCESS | 17829 | _x_x_mozilla_page_load_details 20:38:10 INFO - PROCESS | 17829 | |i|pagename|runs| 20:38:10 INFO - PROCESS | 17829 | |0;dojo.html;3033.090072978106;3046.862891169897;3075.2158199659084;3087.7221050105495;3091.5980922480076;5113.360829896263;5167.715775632339;5259.710715910624;5280.86797830054;5305.681659100452;5280.287161233232;5337.546308563767;5339.5728341732665;5387.946120538793;5415.620906536544;4731.243001119821;4753.3582966299455;4821.662483626147;4822.421309442854;4951.8514444566545;4887.047025829965;4902.558769710726;4915.8525244242555;4932.950670493285;4933.654644174909;4711.882202944937;4751.7624118794265;4754.78603462845;4773.474917759044;4865.854024379274;4798.664093513456;4800.135975524404;4827.637927155477;4886.731229782361;4887.682300650446;4810.446798618169;4824.517548245182;4838.709677419366;4889.193283108283;4899.975500122477;5155.587552995751;5237.659552129099;5360.249565060894;5362.91955620666;5411.702356370398;5653.519450846683;5728.68492232927;5730.312362516524;5731.942680573225;5735.770569177228;5714.114312281603;5725.599208055438;5764.625299355528;5766.452187042224;5773.480386765212;5157.174852023658;5202.479752024843;5357.919631205535;5365.704886231256;5369.301990741218;5741.569382296345;5759.280089988752;5761.740721667535;5783.334916484658;5784.82645520635;5534.446555344433;5564.10974244119;5572.164175373645;5576.749046292926;5670.319561652628;5658.377578466366;5663;5710.600257981901;5714.542836573148;5718.228039214736;5605.579581531401;5647.491725744702;5655.095184770417;5659.915101273484;5669.971650141723;5497.890042199134;5615.185798059259;5640.887182256414;5641.435856414408;5736.885262294731;4378.868633940987;4379.1241751649795;4383.342498625232;4385.605295523418;4422.933655995163;3879.573246942834;3883.37865941448;3891.747036442622;3927.430522574268;3930.508686414198;5080.517350851663;5172.353455818023;5242.633015688942;5307.840764777063;5315.255864179018;5691.117876729114;5693.914591281051;5695.487406133468;5695.7436915338085;5708.115242137475;5329.280547126166;5339.626226164209;5341.252224688546;5341.332333458317;5384.730763461889;4746.976265118721;4834.057358815067;4850.781714822841;4876.390451193601;4881.048195601824;5890.764369425175;5894.086416605433;5899.616524925866;5904.439078287556;5949.464548190684;5688.687122208153;5700.230468886647;5701.543876489788;5703.001974654336;5706.3152421709665;5738.540916726735;5849.64902105875;5888.705564721661;5897.233359663216;5900.144479050427;5588.580856435702;5649.322081350264;5650.604457687922;5651.745671444713;5694.943050569607;5688.175214593778;5740.425957404226;5750.30996280449;5752.194692742935;5754.827355179351;5409.78360865561;5528.364238112668;5545.861353466195;5581.5255703265675;5596.3284405871555;5618.52242559387;5623.297087864017;5623.465770751772;5627.071533196977;5666.376698563237;5502.422245664147;5516.724163791875;5517.2275881377445;5519.227308176939;5519.503244707996;5437.510624043855;5471.534919531884;5503.229547863382;5545.1682247663175;5679.801206957736;5411.431799661136;5441.891162176655;5447.046766815871;5448.264484294569;5479.123340265538 20:38:10 INFO - PROCESS | 17829 | |1;ext.html;591.8431615621861;594.4709208804164;604.3352312456299;617.4813156948163;635.9936400635994;43317.56682433175;44960.3255951161;45072.09855802886;45104.774476127655;48080.51919480813;45615.31577026339;46089.308660370036;46096.53903460965;46148.53851461485;46164.30753538699;9048.411853229536;9219.631214751402;9221.585028673726;9228.953855230715;9230;9125.49809760463;9219.953900230523;9220.400673956205;9223.492707901063;9223.53882305882;9217.539123043854;9239.445633261992;9241.07589241074;9251.814963700723;9254.6298148074;9169.862452063224;9197.448153110834;9210.263178945668;9212.355135140542;9219.815603687923;9128.908710912872;9180.8622870657;9190.632374705005;9199.586018629177;9209.263258939269;43037.35443968343;43394.34908476375;43488.56511434908;43557.782211089056;43613;3664.193877346979;3676.522052133232;3697.4268988306853;3751;4214.894627634303;32380.514292285636;32596.83701581477;33256.16859578506;33350.666493335;33915.15212119692;4334.696571240014;4393.604575588212;4490.797914093873;4613.423322084739;4650.302454631798;361333.1933340343;373662;373919;376330;377423;56976;57233.71383143058;57554;57646.423535764945;57667.13499297514;59971.100433493535;60057.699711502035;60326;60338.69830650907;60378.396216037276;15189.9240503799;15444.45944391941;15461.922690386476;15465.536033919001;15482.5355239343;11877.703057423634;12015.819762703566;12024.87975120255;12030.218035827644;12031.458584363725;15013.474528391454;15935.043897366195;16025;16112.67774644524;16248.75626865598;6301.243850737941;6504.674766261668;6593.340665933464;6625.238097618835;6633.535652504278;998.32612986234;1072.7961687279392;1117.6591139702307;1146.8107762219308;1149.3333866357493;32268.677313227035;32290.35419291601;32360.676393236237;32747.67252327446;33176.84350517209;892.6652505310509;1061.824798908187;1087.7833183357152;1092.470151976291;1147.518042422168;16576.17119144038;16767.664646707;16774.24515896763;16846.157692115346;16904.15479226034;602385;605863;608156;611271;611998;57884.71057644685;58276.41723582795;58362;58453.707731461924;58475.41524584785;1232.8643849176583;1322.5966080345586;1322.927239001864;1360.510216322143;1363.5977386670957;32704;34511.4823277656;34522.13694657654;34560.48159277663;34562.654373455945;49227;49703.75148124236;49761.50238497713;49826;49834.75082624564;386180;388396;389156;390499;391367;27928.58107128354;27957.042683987675;28720.28199294951;29764;40586.59413405828;47764;47843.5215647853;47927;48148.75925620349;48415.5158448411;39579;40487;40862;41186.38220426756;42362.788186058875;40253.16961964583;40730;41201.38197927093;41616;41640.58359416367;39732.80133599429;39774.60225397709;39800.60199398085;40091.79954100211;40141.79929100336;33968.32063358768;36462.4530632046;36509.634903651684;36587.81706091452;39982.800085999384;28226.576601351408;28506;28604.713952860206;28653;28931 20:38:10 INFO - PROCESS | 17829 | |2;jquery.html;375.34876988425094;392.17642949805395;400.8176279792694;407.64331210191085;424.09455811841707;14676.3395647196;18569.257229710813;19633.214671413163;19908.104135313908;19933.60132797345;12749.745005099892;12902.483900643963;12925.547605833797;13035.217886926768;13039.80440293394;4068.735532190413;5313.654612450197;5448.972755136218;5457.99027179971;5459.935312614042;5741.081426971686;5970.671613061301;6051.062085376773;6095.786647467339;6107.786227482039;5991.5206783457215;6043;6092.147099406065;6092.147099406086;6102.176206212172;5943.227380440515;6071.1803906472505;6076;6076.726547305382;6083.117947897552;5852.941470585282;5941.10883367494;5975.984082705951;5990.97004514979;5991.760329586811;19862.80137198624;23502;23539;24313.392165195834;24498.02007919681;2316.5251123519806;2342.145117032271;2403.6995375578053;2438.500107477963;2447.6206188040883;10265.230107741949;10479.895201047968;10559.940811541752;10865.45672716361;10973.50619222137;1833.367488216563;1881.5230044415068;1933.4103098554936;1937.651222779899;2010.2863483463452;84061.15938840594;84764.57617711934;84873.57563212207;85881.57059214727;86370;10852.837207441895;10907.727306817234;11253.774924501464;11313.773724525463;11564.363959982282;15885.841141588668;15904.920475397548;15906.284217210254;15940.123293218985;15963.44127955516;7730.613469326511;8038.799030024179;8088.555129467818;8248.54632995179;8282.337413007066;7547.396208303323;7628.122765881883;7754.302112809874;7792.805179870548;7799.220077992155;4472.373867658531;4694.380438748626;4698.003348576841;4738.64460165489;4947.183714687037;1990.2536548794203;1996.920123195085;1997.500624843789;2045.8158765711157;2063.783302753189;921.9953900230456;987.4272921705393;1002.183220675162;1007.9193664506822;1056.8520407143005;19963.800361996484;20313;20360.28738994128;20496.74535801061;20714.757114573174;970.7087873638021;985.5515740338129;1012.2256473797551;1040.6773900090996;1046.9581216751244;10630.893691062991;10844.511996960156;10894.18293627981;11317.320960742381;11401.543938242377;497569;500158;509813;517469;520652;85172.1173836562;86602;86992.56503717441;88867.55566222128;89888.5505572468;958.3770549143113;978.814025335184;995.586831464934;996.3225006995312;996.5565323431149;17113.91443042777;17593;17881.552961176076;18051.909740451214;18399.72400413968;42175.78912105542;42377.57622423736;42750.144997100506;43398.56601433945;43428.348574770775;54992.72503637616;56036.719816400655;57467.425325746204;57566.424335756106;62784.37215627968;8181.754547363588;8437.11410301934;8659.87010194835;8667.826643467222;8986.775330616525;12756.298403587893;12933.224006559636;13505.797413038616;13781.448742050607;13891.305434728021;11838.822417663914;12080.335581542748;12097.274163550215;12185.51257949672;12197.878021219674;11647.12646551529;11654.825177622173;11827.290362578273;12040.75918481643;12509.687257818627;11388.658340249805;12003.939980300043;12331;12338.938305308417;12767.80848287295;8522.403431759965;8529.402941794264;8600.569971501274;8649.351298652751;9210.171084602418;9200.493972831558;11742;12133.272003679807;12204.75590488203;12372.008119660193 20:38:10 INFO - PROCESS | 17829 | |3;mootools.html;1270.4283072617313;1418.496433766013;1494.7533656946605;1623.4886010906564;1799.8470130038938;8597.355198360125;8965.955170224148;9088.909110908897;9336.626534938594;9341.346105772598;9136.771580710469;9244.075592440753;9260.212881905047;9261.351705380626;9261.814763704722;2430.283066495388;2458.520588485246;2458.791002764767;2460.889259983296;2462.3967128053564;2376.0182405396954;2460.1020627471025;2474.096954611563;2479.2810085075307;2479.3553676044266;2433.0997530913587;2459.1638842793445;2477.665515155449;2478.5538603051446;2488.0794106180647;2351.1300818697105;2355.128602417108;2355.9411014724596;2365.8698771567556;2389.2712722619594;2381.4760752634393;2412.5657381671294;2421.4914867877765;2422.079609748302;2423.575874222022;8897.555122243863;9208.953955230181;9262.517997120429;9301.72094837156;9343.71968840936;5431.972840135813;5639.041362968305;5640.8871822563315;5647.632903861236;5654.6324488908085;3356.177736454584;3385.9661403386144;3436;3441.397755392821;3447.3277710846396;1111.5887121765;1127.8646562412564;1150.097173718627;1183.21316324644;1187.3944288412886;12952.028597855198;13099.738005239937;13124.146930449395;13141.342932853415;13158.802617960739;4557.886052848706;4694.084653492604;4815.422149342101;4846.733429661403;4855;10191.9490402549;10204.13264872494;10215.131713804261;10217.284790064625;10218;5281.9207711884355;5294.311739473844;5310.575153987672;5318.654287471302;5320.281761962163;4043.2317859606583;4349.630281426051;4491.887702807456;4935.259711043301;4942.406911170682;4020.2964481216254;4046.4941882264716;4155.833766649361;4160.479940007499;4166.062635906957;1192.7793358228755;1216.3240870085847;1227.551943540619;1228.6007047709352;1243.7325974915436;803.2289002557493;837.4556538250064;853.3386625365267;921.9308551858503;929.9023602521773;5801.6519008859605;5898.203742494794;5970;5989;6050.292683657138;946.8070231508349;982.4498280962683;993.1062044160313;1002.5438425516372;1027.2963020331097;4036.1120553478186;4163.417121602978;4176.83292668296;4184.916301673949;4212.873613791591;11082.833757493645;11654.242474239147;11656.41717914101;11656.766864662659;11667.941660291644;11574.363410012362;11602.361870097226;11616.070714343;11622.94188529052;11655.41722913851;8393.580320983927;8543.743687689379;8661.826763464695;8705.260052895575;8709.869351959853;5825.184474173534;5901.586888917906;5970.0746384310505;5971.193888824953;6094.39056094387;10489.108425783894;10514.369137851754;10607.257491975488;10623.309484883457;10677.733056673334;9413.435193888388;10755.623553175601;11120.165172746407;11128.666140015812;11140;7756.263155000266;7967.601619919097;8048.235417635316;8221.383396245425;8221.671133154847;8794.560271986247;8807.295416366547;8867.73396798097;8885.866711999195;9005.05446928063;7987.680492780456;7989.161138080418;8076.434649574473;8120.431569790058;8369.414141010071;7691.615419229128;7808.336291415293;7844.686212551663;7932.325752311118;7937.682492700227;6987.650617469208;6997.335253150943;7016.859662806817;7044.225135235222;7044.36600705939;5218.337016767446;5312.203169524448;5361.4370491099435;5440.755166017618;5444.101723215784;5247.475252474722;5333.599980001593;5404.405515393382;5412.079946409041;5418.945810541844 20:38:10 INFO - PROCESS | 17829 | |4;prototype.html;332.8232025318336;338.8915547024952;346.9410200265955;348.09321716927406;350.6423448082954;5241.764120614572;5252.448492908247;5266.5786737061035;5310.62825602208;5351.331083614553;5133.9229911551265;5179.974100129503;5186.766595503202;5198.166998985553;5215.426303106655;4129.483814523184;4155.189738001091;4164.562720914306;4169.207850508394;4173.582641735832;3736.9626303737023;3904.629060239287;4112.321466957948;4120.217158739845;4123.567025462313;4055.776932268724;4059.7617726593376;4062.837486500536;4068.3083875741195;4093.9590604093873;4088.6524645405175;4102.138550904314;4109.21924834282;4136.937945930814;4141.585841415865;3457.6542345765224;3561.982190089059;3618.5295911531593;3649.160693040589;3665.120371110941;5053.949460505385;5063.341765570489;5066.670666406709;5070.29015937769;5115.439790863785;4653.976730116362;4682.508336624674;4683.344331793552;4685.133250348662;4709.128811169944;5293.470652934714;5362.249285100089;5365.490278423583;5385.21914322425;5421.891562168735;3979.6020397959974;4003.97998010011;4006.9198616027516;4033.878983630496;4055.5741647127215;5433.592480563934;5620.775168993236;5716.256886604757;5729.541636669098;5731.971340143315;3848.9615103849164;4109.527404348479;4119.670426365884;4123.9381409278885;4138.337865941435;4195.286801243796;4201.264778663722;4206.957930420718;4212.462451205288;4213.410122582841;4674.807923979363;4693.413323334583;4695.413073365829;4754.524547545287;4754.857354279377;5188.599078248852;5464.726763661801;5505.733681253334;5509.283793106871;5525.917111243334;1393.0944885824294;1410.132768347459;1411.5765270418833;1431.5132854829408;1434.168182454174;872.8516152254132;909.8043920557112;914.0356923445828;931.7763736703142;933.8739270198437;4661.627069834405;4664.230401983635;4679.976600117046;4684.798144871905;4694.577488026094;4949.446509211534;4956.8760780980765;4964.875878103004;4976.133949768837;4996.250562415594;4408.889777755582;4665.6734028617675;4666.743329116931;4693.8316636271065;4707.388039554836;2611.5821468564936;2641.749033841782;2646.8486208499367;2648.973510264911;2658.455016721606;5094.624451398102;5129.9740051989;5135.79308862417;5155.175171972542;5164.664296820694;4812.494688057774;5011.248312753116;5026.220935754964;5072.54347108762;5079.492050794965;5025.874353141201;5053.736565858535;5074.985002999415;5095.464976177448;5117.573299096181;4932.556069953722;4941.777620007037;4951.77717002743;4990.351254336913;4998.2002879539095;4700.952990470051;4900.754962251945;4902.656814022984;4919.409670839522;4937.456879743154;5053.469385714447;5076.466970967996;5093.770780314969;5121.795128194831;5128.307678463509;3683.9079023024638;3696.3900956341904;3700.500432441586;3716.6097559755835;3727.1986522897705;4709.764511774329;4970.801167953241;4980.726060066731;5033.169527028;5051.282563928282;4803.807847686054;4842.854714358575;4848.539388758062;4869.366982292279;4885.853424397274;4841.4674385816825;4845.563899249085;4856.838706775451;4858.95141048585;4877.244027175793;4501.892807332059;4717.127331443694;4790.664653474223;4791.969726508817;4861.274247642036;4852;4891.217405215149;4923.975380123076;4938.691246819524;4941.530554597308;4776.283557466408;4809.711417314972;4809.831655892027;4863.610911127172;4876.390451193601 20:38:10 INFO - PROCESS | 17829 | |5;yui.html;749.7338444852078;756.973505927293;790.9406794490415;848.6817443458705;859.1751918158567;14011.859881401182;14736.852631473683;14777;14785.778213326796;14810.629734256649;13160.144590601603;13227.537036203736;13235.669108272297;13241.668958276048;13242.867571324308;654.4371840217409;781.0666253826679;801.0427539090789;813.7111325479458;821.6877586517115;809.9838003239931;815.9388045896552;821.8561751693429;822.0341099208437;823.3495538524559;875.3566128895256;876.0932434929849;876.2551830943711;877.0089798527687;877.3069275272559;690.5166383531523;829.5603330234985;855.1918437076964;864.844328020956;869.9782505437352;628.933961933995;629.5655997361806;632.4497687012329;632.5319263744842;632.667849379075;12082.456289466994;12200.084993625514;12235.877641223651;12248.693782655415;12298.139130260884;13918.37367318463;14233.146011239358;14395.928020359936;14427.495037673736;14781.113133212042;12775.61673149807;12820;12830.230186188859;12968.740625187538;13168.209907405586;4321.315874475104;4403.537628548988;4418.337249412614;4485.977570112162;4496.910061798746;75736.62131689361;75765.24234757636;75890;81848.18151818465;82284.17715822825;11515.193936424537;11553.13351498641;11730.354830484235;11857.64427067172;12211.145219834527;21478.677819832716;21500.13999440036;21581.460463488223;21585.784142158376;21650.891745541172;8275.255227029596;8342.791430214293;8378.287845533197;8418.957905210435;8802.427842190236;4454.331850222427;4530.932036019462;4546.772661366985;4714.66997310185;4975.601951843843;3446.1556918555116;3576.946345804815;3581.1405262737276;3586.7489275750445;3588.2464682416985;577.3274135632025;588.9440503152193;608.850831546274;617.274702224893;617.7776000639766;573.7762272713645;599.5113982104571;616.6762449713847;649.8098539658755;678.5318130489946;9590.66432674853;9676.080772326617;9694;9842;9947.850782238273;587.9853003674857;666.3503084492581;670.4435318685479;681.1281559603715;727.5125665803924;4465.776711164429;4532.388127602798;4558.270676691714;4561.840335588238;4759.547842954914;72944;98523.01476985139;123881.38059309826;124274;124783.376083119;62494;85042.57478712568;111713;112347;113947;91365;92506.53746731223;95108.52445737727;96837;97410;8805.603747831236;8887.688930887389;8995.147472891935;9075.364724469224;9117.680881169128;54487.18269225885;54784.452155477935;55425;56479.71760141173;56627;82310.58844705978;82607.5869620648;84413;85247.57376213079;87200;11026.889731102587;11334.659960201207;11492.982979993894;11802.409879506162;12311.19977201479;14006.789898151332;15056.322465489298;15596.376144954529;15597.610059748597;15811.209439528207;14306.427742890584;14832.332545035284;14943;15276.694466110837;15353.309101090254;14336.713265734836;14400.207988560729;14603.853961460674;15069.623259418602;15185.088894666356;14390.424383024561;14478.131312121306;14842.109473431628;14910.179940102964;15291.082535047934;11350.262232954832;11984.666823263564;12036.939815300868;12235.602015792692;12289.201201921847;10573.9471302643;11269.774604508028;12061.939690301844;12369.752604948031;12510.249385036926 20:38:10 INFO - PROCESS | 17829 | __end_tp_report 20:38:10 INFO - PROCESS | 17829 | __start_cc_report 20:38:10 INFO - PROCESS | 17829 | _x_x_mozilla_cycle_collect,1216 20:38:10 INFO - PROCESS | 17829 | __end_cc_report 20:38:10 INFO - PROCESS | 17829 | __startTimestamp1470627489998__endTimestamp 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | ------- Summary: start ------- 20:38:10 INFO - PROCESS | 17829 | Number of tests: 6 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#0] dojo.html Cycles:165 Average:5276.19 Median:5479.12 stddev:599.13 (10.9%) stddev-sans-first:574.55 20:38:10 INFO - PROCESS | 17829 | Values: 3033.1 3046.9 3075.2 3087.7 3091.6 5113.4 5167.7 5259.7 5280.9 5305.7 5280.3 5337.5 5339.6 5387.9 5415.6 4731.2 4753.4 4821.7 4822.4 4951.9 4887.0 4902.6 4915.9 4933.0 4933.7 4711.9 4751.8 4754.8 4773.5 4865.9 4798.7 4800.1 4827.6 4886.7 4887.7 4810.4 4824.5 4838.7 4889.2 4900.0 5155.6 5237.7 5360.2 5362.9 5411.7 5653.5 5728.7 5730.3 5731.9 5735.8 5714.1 5725.6 5764.6 5766.5 5773.5 5157.2 5202.5 5357.9 5365.7 5369.3 5741.6 5759.3 5761.7 5783.3 5784.8 5534.4 5564.1 5572.2 5576.7 5670.3 5658.4 5663.0 5710.6 5714.5 5718.2 5605.6 5647.5 5655.1 5659.9 5670.0 5497.9 5615.2 5640.9 5641.4 5736.9 4378.9 4379.1 4383.3 4385.6 4422.9 3879.6 3883.4 3891.7 3927.4 3930.5 5080.5 5172.4 5242.6 5307.8 5315.3 5691.1 5693.9 5695.5 5695.7 5708.1 5329.3 5339.6 5341.3 5341.3 5384.7 4747.0 4834.1 4850.8 4876.4 4881.0 5890.8 5894.1 5899.6 5904.4 5949.5 5688.7 5700.2 5701.5 5703.0 5706.3 5738.5 5849.6 5888.7 5897.2 5900.1 5588.6 5649.3 5650.6 5651.7 5694.9 5688.2 5740.4 5750.3 5752.2 5754.8 5409.8 5528.4 5545.9 5581.5 5596.3 5618.5 5623.3 5623.5 5627.1 5666.4 5502.4 5516.7 5517.2 5519.2 5519.5 5437.5 5471.5 5503.2 5545.2 5679.8 5411.4 5441.9 5447.0 5448.3 5479.1 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#1] ext.html Cycles:180 Average:61692.53 Median:22927.74 stddev:124713.88 (543.9%) stddev-sans-first:124979.36 20:38:10 INFO - PROCESS | 17829 | Values: 591.8 594.5 604.3 617.5 636.0 43317.6 44960.3 45072.1 45104.8 48080.5 45615.3 46089.3 46096.5 46148.5 46164.3 9048.4 9219.6 9221.6 9229.0 9230.0 9125.5 9220.0 9220.4 9223.5 9223.5 9217.5 9239.4 9241.1 9251.8 9254.6 9169.9 9197.4 9210.3 9212.4 9219.8 9128.9 9180.9 9190.6 9199.6 9209.3 43037.4 43394.3 43488.6 43557.8 43613.0 3664.2 3676.5 3697.4 3751.0 4214.9 32380.5 32596.8 33256.2 33350.7 33915.2 4334.7 4393.6 4490.8 4613.4 4650.3 361333.2 373662.0 373919.0 376330.0 377423.0 56976.0 57233.7 57554.0 57646.4 57667.1 59971.1 60057.7 60326.0 60338.7 60378.4 15189.9 15444.5 15461.9 15465.5 15482.5 11877.7 12015.8 12024.9 12030.2 12031.5 15013.5 15935.0 16025.0 16112.7 16248.8 6301.2 6504.7 6593.3 6625.2 6633.5 998.3 1072.8 1117.7 1146.8 1149.3 32268.7 32290.4 32360.7 32747.7 33176.8 892.7 1061.8 1087.8 1092.5 1147.5 16576.2 16767.7 16774.2 16846.2 16904.2 602385.0 605863.0 608156.0 611271.0 611998.0 57884.7 58276.4 58362.0 58453.7 58475.4 1232.9 1322.6 1322.9 1360.5 1363.6 32704.0 34511.5 34522.1 34560.5 34562.7 49227.0 49703.8 49761.5 49826.0 49834.8 386180.0 388396.0 389156.0 390499.0 391367.0 27928.6 27957.0 28720.3 29764.0 40586.6 47764.0 47843.5 47927.0 48148.8 48415.5 39579.0 40487.0 40862.0 41186.4 42362.8 40253.2 40730.0 41201.4 41616.0 41640.6 39732.8 39774.6 39800.6 40091.8 40141.8 33968.3 36462.5 36509.6 36587.8 39982.8 28226.6 28506.0 28604.7 28653.0 28931.0 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#2] jquery.html Cycles:180 Average:29493.27 Median:383.76 stddev:83851.86 (21849.9%) stddev-sans-first:84058.59 20:38:10 INFO - PROCESS | 17829 | Values: 375.3 392.2 400.8 407.6 424.1 14676.3 18569.3 19633.2 19908.1 19933.6 12749.7 12902.5 12925.5 13035.2 13039.8 4068.7 5313.7 5449.0 5458.0 5459.9 5741.1 5970.7 6051.1 6095.8 6107.8 5991.5 6043.0 6092.1 6092.1 6102.2 5943.2 6071.2 6076.0 6076.7 6083.1 5852.9 5941.1 5976.0 5991.0 5991.8 19862.8 23502.0 23539.0 24313.4 24498.0 2316.5 2342.1 2403.7 2438.5 2447.6 10265.2 10479.9 10559.9 10865.5 10973.5 1833.4 1881.5 1933.4 1937.7 2010.3 84061.2 84764.6 84873.6 85881.6 86370.0 10852.8 10907.7 11253.8 11313.8 11564.4 15885.8 15904.9 15906.3 15940.1 15963.4 7730.6 8038.8 8088.6 8248.5 8282.3 7547.4 7628.1 7754.3 7792.8 7799.2 4472.4 4694.4 4698.0 4738.6 4947.2 1990.3 1996.9 1997.5 2045.8 2063.8 922.0 987.4 1002.2 1007.9 1056.9 19963.8 20313.0 20360.3 20496.7 20714.8 970.7 985.6 1012.2 1040.7 1047.0 10630.9 10844.5 10894.2 11317.3 11401.5 497569.0 500158.0 509813.0 517469.0 520652.0 85172.1 86602.0 86992.6 88867.6 89888.6 958.4 978.8 995.6 996.3 996.6 17113.9 17593.0 17881.6 18051.9 18399.7 42175.8 42377.6 42750.1 43398.6 43428.3 54992.7 56036.7 57467.4 57566.4 62784.4 8181.8 8437.1 8659.9 8667.8 8986.8 12756.3 12933.2 13505.8 13781.4 13891.3 11838.8 12080.3 12097.3 12185.5 12197.9 11647.1 11654.8 11827.3 12040.8 12509.7 11388.7 12003.9 12331.0 12338.9 12767.8 8522.4 8529.4 8600.6 8649.4 9210.2 9200.5 11742.0 12133.3 12204.8 12372.0 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#3] mootools.html Cycles:180 Average:6004.36 Median:4754.75 stddev:3477.47 (73.1%) stddev-sans-first:3469.02 20:38:10 INFO - PROCESS | 17829 | Values: 1270.4 1418.5 1494.8 1623.5 1799.8 8597.4 8966.0 9088.9 9336.6 9341.3 9136.8 9244.1 9260.2 9261.4 9261.8 2430.3 2458.5 2458.8 2460.9 2462.4 2376.0 2460.1 2474.1 2479.3 2479.4 2433.1 2459.2 2477.7 2478.6 2488.1 2351.1 2355.1 2355.9 2365.9 2389.3 2381.5 2412.6 2421.5 2422.1 2423.6 8897.6 9209.0 9262.5 9301.7 9343.7 5432.0 5639.0 5640.9 5647.6 5654.6 3356.2 3386.0 3436.0 3441.4 3447.3 1111.6 1127.9 1150.1 1183.2 1187.4 12952.0 13099.7 13124.1 13141.3 13158.8 4557.9 4694.1 4815.4 4846.7 4855.0 10191.9 10204.1 10215.1 10217.3 10218.0 5281.9 5294.3 5310.6 5318.7 5320.3 4043.2 4349.6 4491.9 4935.3 4942.4 4020.3 4046.5 4155.8 4160.5 4166.1 1192.8 1216.3 1227.6 1228.6 1243.7 803.2 837.5 853.3 921.9 929.9 5801.7 5898.2 5970.0 5989.0 6050.3 946.8 982.4 993.1 1002.5 1027.3 4036.1 4163.4 4176.8 4184.9 4212.9 11082.8 11654.2 11656.4 11656.8 11667.9 11574.4 11602.4 11616.1 11622.9 11655.4 8393.6 8543.7 8661.8 8705.3 8709.9 5825.2 5901.6 5970.1 5971.2 6094.4 10489.1 10514.4 10607.3 10623.3 10677.7 9413.4 10755.6 11120.2 11128.7 11140.0 7756.3 7967.6 8048.2 8221.4 8221.7 8794.6 8807.3 8867.7 8885.9 9005.1 7987.7 7989.2 8076.4 8120.4 8369.4 7691.6 7808.3 7844.7 7932.3 7937.7 6987.7 6997.3 7016.9 7044.2 7044.4 5218.3 5312.2 5361.4 5440.8 5444.1 5247.5 5333.6 5404.4 5412.1 5418.9 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#4] prototype.html Cycles:180 Average:4338.03 Median:4826.98 stddev:1207.00 (25.0%) stddev-sans-first:1172.36 20:38:10 INFO - PROCESS | 17829 | Values: 332.8 338.9 346.9 348.1 350.6 5241.8 5252.4 5266.6 5310.6 5351.3 5133.9 5180.0 5186.8 5198.2 5215.4 4129.5 4155.2 4164.6 4169.2 4173.6 3737.0 3904.6 4112.3 4120.2 4123.6 4055.8 4059.8 4062.8 4068.3 4094.0 4088.7 4102.1 4109.2 4136.9 4141.6 3457.7 3562.0 3618.5 3649.2 3665.1 5053.9 5063.3 5066.7 5070.3 5115.4 4654.0 4682.5 4683.3 4685.1 4709.1 5293.5 5362.2 5365.5 5385.2 5421.9 3979.6 4004.0 4006.9 4033.9 4055.6 5433.6 5620.8 5716.3 5729.5 5732.0 3849.0 4109.5 4119.7 4123.9 4138.3 4195.3 4201.3 4207.0 4212.5 4213.4 4674.8 4693.4 4695.4 4754.5 4754.9 5188.6 5464.7 5505.7 5509.3 5525.9 1393.1 1410.1 1411.6 1431.5 1434.2 872.9 909.8 914.0 931.8 933.9 4661.6 4664.2 4680.0 4684.8 4694.6 4949.4 4956.9 4964.9 4976.1 4996.3 4408.9 4665.7 4666.7 4693.8 4707.4 2611.6 2641.7 2646.8 2649.0 2658.5 5094.6 5130.0 5135.8 5155.2 5164.7 4812.5 5011.2 5026.2 5072.5 5079.5 5025.9 5053.7 5075.0 5095.5 5117.6 4932.6 4941.8 4951.8 4990.4 4998.2 4701.0 4900.8 4902.7 4919.4 4937.5 5053.5 5076.5 5093.8 5121.8 5128.3 3683.9 3696.4 3700.5 3716.6 3727.2 4709.8 4970.8 4980.7 5033.2 5051.3 4803.8 4842.9 4848.5 4869.4 4885.9 4841.5 4845.6 4856.8 4859.0 4877.2 4501.9 4717.1 4790.7 4792.0 4861.3 4852.0 4891.2 4924.0 4938.7 4941.5 4776.3 4809.7 4809.8 4863.6 4876.4 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - PROCESS | 17829 | [#5] yui.html Cycles:180 Average:21263.53 Median:4552.52 stddev:30955.67 (680.0%) stddev-sans-first:31004.19 20:38:10 INFO - PROCESS | 17829 | Values: 749.7 757.0 790.9 848.7 859.2 14011.9 14736.9 14777.0 14785.8 14810.6 13160.1 13227.5 13235.7 13241.7 13242.9 654.4 781.1 801.0 813.7 821.7 810.0 815.9 821.9 822.0 823.3 875.4 876.1 876.3 877.0 877.3 690.5 829.6 855.2 864.8 870.0 628.9 629.6 632.4 632.5 632.7 12082.5 12200.1 12235.9 12248.7 12298.1 13918.4 14233.1 14395.9 14427.5 14781.1 12775.6 12820.0 12830.2 12968.7 13168.2 4321.3 4403.5 4418.3 4486.0 4496.9 75736.6 75765.2 75890.0 81848.2 82284.2 11515.2 11553.1 11730.4 11857.6 12211.1 21478.7 21500.1 21581.5 21585.8 21650.9 8275.3 8342.8 8378.3 8419.0 8802.4 4454.3 4530.9 4546.8 4714.7 4975.6 3446.2 3576.9 3581.1 3586.7 3588.2 577.3 588.9 608.9 617.3 617.8 573.8 599.5 616.7 649.8 678.5 9590.7 9676.1 9694.0 9842.0 9947.9 588.0 666.4 670.4 681.1 727.5 4465.8 4532.4 4558.3 4561.8 4759.5 72944.0 98523.0 123881.4 124274.0 124783.4 62494.0 85042.6 111713.0 112347.0 113947.0 91365.0 92506.5 95108.5 96837.0 97410.0 8805.6 8887.7 8995.1 9075.4 9117.7 54487.2 54784.5 55425.0 56479.7 56627.0 82310.6 82607.6 84413.0 85247.6 87200.0 11026.9 11334.7 11493.0 11802.4 12311.2 14006.8 15056.3 15596.4 15597.6 15811.2 14306.4 14832.3 14943.0 15276.7 15353.3 14336.7 14400.2 14603.9 15069.6 15185.1 14390.4 14478.1 14842.1 14910.2 15291.1 11350.3 11984.7 12036.9 12235.6 12289.2 10573.9 11269.8 12061.9 12369.8 12510.2 20:38:10 INFO - PROCESS | 17829 | -------- Summary: end -------- 20:38:10 INFO - PROCESS | 17829 | 20:38:10 INFO - TEST-INFO | 17829: exit 0 20:38:10 INFO - TEST-OK | dromaeo_css | took 1114937ms 20:38:10 INFO - TEST-START | kraken 20:38:10 INFO - operating with platform_type : linux_ 20:38:10 INFO - Initialising browser for kraken test... 20:38:10 INFO - TEST-INFO | started process 18020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp37_Cg/profile http://localhost:47429/getInfo.html) 20:38:14 INFO - PROCESS | 18020 | __metrics Screen width/height:1600/1200 20:38:14 INFO - PROCESS | 18020 | colorDepth:24 20:38:14 INFO - PROCESS | 18020 | Browser inner width/height: 1024/697 20:38:14 INFO - PROCESS | 18020 | __metrics 20:38:15 INFO - PROCESS | 18020 | 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" 20:38:15 INFO - PROCESS | 18020 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:38:15 INFO - PROCESS | 18020 | console.error: PushService: 20:38:15 INFO - PROCESS | 18020 | stateChangeProcessEnqueue: Error transitioning state 20:38:15 INFO - PROCESS | 18020 | UnknownError 20:38:16 INFO - TEST-INFO | 18020: exit 0 20:38:16 INFO - Browser initialized. 20:38:16 INFO - Running cycle 1/1 for kraken test... 20:38:16 INFO - TEST-INFO | started process 18103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp37_Cg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:38:28 INFO - PROCESS | 18103 | RSS: Main: 156643328 20:38:28 INFO - PROCESS | 18103 | 20:38:30 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47429/tests/kraken/driver.html?testName=audio-beat-detection) 20:38:31 INFO - PROCESS | 18103 | RSS: Main: 213045248 20:38:31 INFO - PROCESS | 18103 | 20:38:34 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47429/tests/kraken/driver.html?testName=audio-dft) 20:38:34 INFO - PROCESS | 18103 | RSS: Main: 193077248 20:38:34 INFO - PROCESS | 18103 | 20:38:37 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47429/tests/kraken/driver.html?testName=audio-fft) 20:38:38 INFO - PROCESS | 18103 | RSS: Main: 268713984 20:38:38 INFO - PROCESS | 18103 | 20:38:40 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47429/tests/kraken/driver.html?testName=audio-oscillator) 20:38:41 INFO - PROCESS | 18103 | RSS: Main: 179142656 20:38:41 INFO - PROCESS | 18103 | 20:38:43 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47429/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:38:43 INFO - PROCESS | 18103 | RSS: Main: 184012800 20:38:43 INFO - PROCESS | 18103 | 20:38:46 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47429/tests/kraken/driver.html?testName=imaging-darkroom) 20:38:47 INFO - PROCESS | 18103 | RSS: Main: 220434432 20:38:47 INFO - PROCESS | 18103 | 20:38:50 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47429/tests/kraken/driver.html?testName=imaging-desaturate) 20:38:51 INFO - PROCESS | 18103 | RSS: Main: 220323840 20:38:51 INFO - PROCESS | 18103 | 20:38:54 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47429/tests/kraken/driver.html?testName=json-parse-financial) 20:38:54 INFO - PROCESS | 18103 | RSS: Main: 219607040 20:38:54 INFO - PROCESS | 18103 | 20:38:56 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47429/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:38:56 INFO - PROCESS | 18103 | RSS: Main: 183808000 20:38:56 INFO - PROCESS | 18103 | 20:38:58 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:38:59 INFO - PROCESS | 18103 | RSS: Main: 191102976 20:38:59 INFO - PROCESS | 18103 | 20:39:01 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:01 INFO - PROCESS | 18103 | RSS: Main: 194641920 20:39:01 INFO - PROCESS | 18103 | 20:39:04 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:05 INFO - PROCESS | 18103 | RSS: Main: 189571072 20:39:05 INFO - PROCESS | 18103 | 20:39:07 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:39:08 INFO - PROCESS | 18103 | RSS: Main: 192262144 20:39:08 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:47429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47429/tests/kraken/driver.html?testName=ai-astar) 20:39:10 INFO - PROCESS | 18103 | RSS: Main: 242683904 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | __start_tp_report 20:39:10 INFO - PROCESS | 18103 | _x_x_mozilla_page_load 20:39:10 INFO - PROCESS | 18103 | _x_x_mozilla_page_load_details 20:39:10 INFO - PROCESS | 18103 | |i|pagename|runs| 20:39:10 INFO - PROCESS | 18103 | |0;ai-astar;103;110;112;110;111;112;112;109;111;110 20:39:10 INFO - PROCESS | 18103 | |1;audio-beat-detection;149;119;118;175;118;123;148;118;152;116 20:39:10 INFO - PROCESS | 18103 | |2;audio-dft;161;159;160;161;160;162;159;160;161;160 20:39:10 INFO - PROCESS | 18103 | |3;audio-fft;76;75;74;119;75;75;75;76;120;74 20:39:10 INFO - PROCESS | 18103 | |4;audio-oscillator;84;84;131;85;86;85;120;84;83;133 20:39:10 INFO - PROCESS | 18103 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 20:39:10 INFO - PROCESS | 18103 | |6;imaging-darkroom;145;146;145;146;145;146;146;146;145;145 20:39:10 INFO - PROCESS | 18103 | |7;imaging-desaturate;96;95;95;96;95;95;95;95;96;94 20:39:10 INFO - PROCESS | 18103 | |8;json-parse-financial;50;51;50;50;50;52;51;49;50;50 20:39:10 INFO - PROCESS | 18103 | |9;json-stringify-tinderbox;62;63;62;63;63;64;63;63;63;63 20:39:10 INFO - PROCESS | 18103 | |10;stanford-crypto-aes;75;75;75;75;75;76;74;75;75;77 20:39:10 INFO - PROCESS | 18103 | |11;stanford-crypto-ccm;133;120;121;135;119;122;120;125;137;127 20:39:10 INFO - PROCESS | 18103 | |12;stanford-crypto-pbkdf2;161;158;157;160;159;161;158;158;161;158 20:39:10 INFO - PROCESS | 18103 | |13;stanford-crypto-sha256-iterative;68;63;64;63;65;64;62;62;64;62 20:39:10 INFO - PROCESS | 18103 | __end_tp_report 20:39:10 INFO - PROCESS | 18103 | __start_cc_report 20:39:10 INFO - PROCESS | 18103 | _x_x_mozilla_cycle_collect,1649 20:39:10 INFO - PROCESS | 18103 | __end_cc_report 20:39:10 INFO - PROCESS | 18103 | __startTimestamp1470627550266__endTimestamp 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | ------- Summary: start ------- 20:39:10 INFO - PROCESS | 18103 | Number of tests: 14 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:1.09 20:39:10 INFO - PROCESS | 18103 | Values: 103.0 110.0 112.0 110.0 111.0 112.0 112.0 109.0 111.0 110.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:135.50 stddev:20.72 (15.3%) stddev-sans-first:21.21 20:39:10 INFO - PROCESS | 18103 | Values: 149.0 119.0 118.0 175.0 118.0 123.0 148.0 118.0 152.0 116.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 20:39:10 INFO - PROCESS | 18103 | Values: 161.0 159.0 160.0 161.0 160.0 162.0 159.0 160.0 161.0 160.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:18.78 (25.0%) stddev-sans-first:19.70 20:39:10 INFO - PROCESS | 18103 | Values: 76.0 75.0 74.0 119.0 75.0 75.0 75.0 76.0 120.0 74.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:84.00 stddev:21.32 (25.4%) stddev-sans-first:22.05 20:39:10 INFO - PROCESS | 18103 | Values: 84.0 84.0 131.0 85.0 86.0 85.0 120.0 84.0 83.0 133.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:39:10 INFO - PROCESS | 18103 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:39:10 INFO - PROCESS | 18103 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 20:39:10 INFO - PROCESS | 18103 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 94.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 20:39:10 INFO - PROCESS | 18103 | Values: 50.0 51.0 50.0 50.0 50.0 52.0 51.0 49.0 50.0 50.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 20:39:10 INFO - PROCESS | 18103 | Values: 62.0 63.0 62.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 20:39:10 INFO - PROCESS | 18103 | Values: 75.0 75.0 75.0 75.0 75.0 76.0 74.0 75.0 75.0 77.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.00 stddev:6.79 (5.4%) stddev-sans-first:6.70 20:39:10 INFO - PROCESS | 18103 | Values: 133.0 120.0 121.0 135.0 119.0 122.0 120.0 125.0 137.0 127.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:1.52 (1.0%) stddev-sans-first:1.45 20:39:10 INFO - PROCESS | 18103 | Values: 161.0 158.0 157.0 160.0 159.0 161.0 158.0 158.0 161.0 158.0 20:39:10 INFO - PROCESS | 18103 | 20:39:10 INFO - PROCESS | 18103 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.09 20:39:10 INFO - PROCESS | 18103 | Values: 68.0 63.0 64.0 63.0 65.0 64.0 62.0 62.0 64.0 62.0 20:39:10 INFO - PROCESS | 18103 | -------- Summary: end -------- 20:39:10 INFO - PROCESS | 18103 | 20:39:11 INFO - TEST-INFO | 18103: exit 0 20:39:11 INFO - TEST-OK | kraken | took 60513ms 20:39:11 INFO - SUITE-END | took 1175s 20:39:11 INFO - Completed test suite (00:19:35) 20:39:11 INFO - javascript benchmark 20:39:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3033.090072978106, 3046.862891169897, 3075.2158199659084, 3087.7221050105495, 3091.5980922480076, 5113.360829896263, 5167.715775632339, 5259.710715910624, 5280.86797830054, 5305.681659100452, 5280.287161233232, 5337.546308563767, 5339.5728341732665, 5387.946120538793, 5415.620906536544, 4731.243001119821, 4753.3582966299455, 4821.662483626147, 4822.421309442854, 4951.8514444566545, 4887.047025829965, 4902.558769710726, 4915.8525244242555, 4932.950670493285, 4933.654644174909, 4711.882202944937, 4751.7624118794265, 4754.78603462845, 4773.474917759044, 4865.854024379274, 4798.664093513456, 4800.135975524404, 4827.637927155477, 4886.731229782361, 4887.682300650446, 4810.446798618169, 4824.517548245182, 4838.709677419366, 4889.193283108283, 4899.975500122477, 5155.587552995751, 5237.659552129099, 5360.249565060894, 5362.91955620666, 5411.702356370398, 5653.519450846683, 5728.68492232927, 5730.312362516524, 5731.942680573225, 5735.770569177228, 5714.114312281603, 5725.599208055438, 5764.625299355528, 5766.452187042224, 5773.480386765212, 5157.174852023658, 5202.479752024843, 5357.919631205535, 5365.704886231256, 5369.301990741218, 5741.569382296345, 5759.280089988752, 5761.740721667535, 5783.334916484658, 5784.82645520635, 5534.446555344433, 5564.10974244119, 5572.164175373645, 5576.749046292926, 5670.319561652628, 5658.377578466366, 5663.0, 5710.600257981901, 5714.542836573148, 5718.228039214736, 5605.579581531401, 5647.491725744702, 5655.095184770417, 5659.915101273484, 5669.971650141723, 5497.890042199134, 5615.185798059259, 5640.887182256414, 5641.435856414408, 5736.885262294731, 4378.868633940987, 4379.1241751649795, 4383.342498625232, 4385.605295523418, 4422.933655995163, 3879.573246942834, 3883.37865941448, 3891.747036442622, 3927.430522574268, 3930.508686414198, 5080.517350851663, 5172.353455818023, 5242.633015688942, 5307.840764777063, 5315.255864179018, 5691.117876729114, 5693.914591281051, 5695.487406133468, 5695.7436915338085, 5708.115242137475, 5329.280547126166, 5339.626226164209, 5341.252224688546, 5341.332333458317, 5384.730763461889, 4746.976265118721, 4834.057358815067, 4850.781714822841, 4876.390451193601, 4881.048195601824, 5890.764369425175, 5894.086416605433, 5899.616524925866, 5904.439078287556, 5949.464548190684, 5688.687122208153, 5700.230468886647, 5701.543876489788, 5703.001974654336, 5706.3152421709665, 5738.540916726735, 5849.64902105875, 5888.705564721661, 5897.233359663216, 5900.144479050427, 5588.580856435702, 5649.322081350264, 5650.604457687922, 5651.745671444713, 5694.943050569607, 5688.175214593778, 5740.425957404226, 5750.30996280449, 5752.194692742935, 5754.827355179351, 5409.78360865561, 5528.364238112668, 5545.861353466195, 5581.5255703265675, 5596.3284405871555, 5618.52242559387, 5623.297087864017, 5623.465770751772, 5627.071533196977, 5666.376698563237, 5502.422245664147, 5516.724163791875, 5517.2275881377445, 5519.227308176939, 5519.503244707996, 5437.510624043855, 5471.534919531884, 5503.229547863382, 5545.1682247663175, 5679.801206957736, 5411.431799661136, 5441.891162176655, 5447.046766815871, 5448.264484294569, 5479.123340265538], "value": 5235.780468482491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8431615621861, 594.4709208804164, 604.3352312456299, 617.4813156948163, 635.9936400635994, 43317.56682433175, 44960.3255951161, 45072.09855802886, 45104.774476127655, 48080.51919480813, 45615.31577026339, 46089.308660370036, 46096.53903460965, 46148.53851461485, 46164.30753538699, 9048.411853229536, 9219.631214751402, 9221.585028673726, 9228.953855230715, 9230.0, 9125.49809760463, 9219.953900230523, 9220.400673956205, 9223.492707901063, 9223.53882305882, 9217.539123043854, 9239.445633261992, 9241.07589241074, 9251.814963700723, 9254.6298148074, 9169.862452063224, 9197.448153110834, 9210.263178945668, 9212.355135140542, 9219.815603687923, 9128.908710912872, 9180.8622870657, 9190.632374705005, 9199.586018629177, 9209.263258939269, 43037.35443968343, 43394.34908476375, 43488.56511434908, 43557.782211089056, 43613.0, 3664.193877346979, 3676.522052133232, 3697.4268988306853, 3751.0, 4214.894627634303, 32380.514292285636, 32596.83701581477, 33256.16859578506, 33350.666493335, 33915.15212119692, 4334.696571240014, 4393.604575588212, 4490.797914093873, 4613.423322084739, 4650.302454631798, 361333.1933340343, 373662.0, 373919.0, 376330.0, 377423.0, 56976.0, 57233.71383143058, 57554.0, 57646.423535764945, 57667.13499297514, 59971.100433493535, 60057.699711502035, 60326.0, 60338.69830650907, 60378.396216037276, 15189.9240503799, 15444.45944391941, 15461.922690386476, 15465.536033919001, 15482.5355239343, 11877.703057423634, 12015.819762703566, 12024.87975120255, 12030.218035827644, 12031.458584363725, 15013.474528391454, 15935.043897366195, 16025.0, 16112.67774644524, 16248.75626865598, 6301.243850737941, 6504.674766261668, 6593.340665933464, 6625.238097618835, 6633.535652504278, 998.32612986234, 1072.7961687279392, 1117.6591139702307, 1146.8107762219308, 1149.3333866357493, 32268.677313227035, 32290.35419291601, 32360.676393236237, 32747.67252327446, 33176.84350517209, 892.6652505310509, 1061.824798908187, 1087.7833183357152, 1092.470151976291, 1147.518042422168, 16576.17119144038, 16767.664646707, 16774.24515896763, 16846.157692115346, 16904.15479226034, 602385.0, 605863.0, 608156.0, 611271.0, 611998.0, 57884.71057644685, 58276.41723582795, 58362.0, 58453.707731461924, 58475.41524584785, 1232.8643849176583, 1322.5966080345586, 1322.927239001864, 1360.510216322143, 1363.5977386670957, 32704.0, 34511.4823277656, 34522.13694657654, 34560.48159277663, 34562.654373455945, 49227.0, 49703.75148124236, 49761.50238497713, 49826.0, 49834.75082624564, 386180.0, 388396.0, 389156.0, 390499.0, 391367.0, 27928.58107128354, 27957.042683987675, 28720.28199294951, 29764.0, 40586.59413405828, 47764.0, 47843.5215647853, 47927.0, 48148.75925620349, 48415.5158448411, 39579.0, 40487.0, 40862.0, 41186.38220426756, 42362.788186058875, 40253.16961964583, 40730.0, 41201.38197927093, 41616.0, 41640.58359416367, 39732.80133599429, 39774.60225397709, 39800.60199398085, 40091.79954100211, 40141.79929100336, 33968.32063358768, 36462.4530632046, 36509.634903651684, 36587.81706091452, 39982.800085999384, 28226.576601351408, 28506.0, 28604.713952860206, 28653.0, 28931.0], "value": 20234.323389049438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.34876988425094, 392.17642949805395, 400.8176279792694, 407.64331210191085, 424.09455811841707, 14676.3395647196, 18569.257229710813, 19633.214671413163, 19908.104135313908, 19933.60132797345, 12749.745005099892, 12902.483900643963, 12925.547605833797, 13035.217886926768, 13039.80440293394, 4068.735532190413, 5313.654612450197, 5448.972755136218, 5457.99027179971, 5459.935312614042, 5741.081426971686, 5970.671613061301, 6051.062085376773, 6095.786647467339, 6107.786227482039, 5991.5206783457215, 6043.0, 6092.147099406065, 6092.147099406086, 6102.176206212172, 5943.227380440515, 6071.1803906472505, 6076.0, 6076.726547305382, 6083.117947897552, 5852.941470585282, 5941.10883367494, 5975.984082705951, 5990.97004514979, 5991.760329586811, 19862.80137198624, 23502.0, 23539.0, 24313.392165195834, 24498.02007919681, 2316.5251123519806, 2342.145117032271, 2403.6995375578053, 2438.500107477963, 2447.6206188040883, 10265.230107741949, 10479.895201047968, 10559.940811541752, 10865.45672716361, 10973.50619222137, 1833.367488216563, 1881.5230044415068, 1933.4103098554936, 1937.651222779899, 2010.2863483463452, 84061.15938840594, 84764.57617711934, 84873.57563212207, 85881.57059214727, 86370.0, 10852.837207441895, 10907.727306817234, 11253.774924501464, 11313.773724525463, 11564.363959982282, 15885.841141588668, 15904.920475397548, 15906.284217210254, 15940.123293218985, 15963.44127955516, 7730.613469326511, 8038.799030024179, 8088.555129467818, 8248.54632995179, 8282.337413007066, 7547.396208303323, 7628.122765881883, 7754.302112809874, 7792.805179870548, 7799.220077992155, 4472.373867658531, 4694.380438748626, 4698.003348576841, 4738.64460165489, 4947.183714687037, 1990.2536548794203, 1996.920123195085, 1997.500624843789, 2045.8158765711157, 2063.783302753189, 921.9953900230456, 987.4272921705393, 1002.183220675162, 1007.9193664506822, 1056.8520407143005, 19963.800361996484, 20313.0, 20360.28738994128, 20496.74535801061, 20714.757114573174, 970.7087873638021, 985.5515740338129, 1012.2256473797551, 1040.6773900090996, 1046.9581216751244, 10630.893691062991, 10844.511996960156, 10894.18293627981, 11317.320960742381, 11401.543938242377, 497569.0, 500158.0, 509813.0, 517469.0, 520652.0, 85172.1173836562, 86602.0, 86992.56503717441, 88867.55566222128, 89888.5505572468, 958.3770549143113, 978.814025335184, 995.586831464934, 996.3225006995312, 996.5565323431149, 17113.91443042777, 17593.0, 17881.552961176076, 18051.909740451214, 18399.72400413968, 42175.78912105542, 42377.57622423736, 42750.144997100506, 43398.56601433945, 43428.348574770775, 54992.72503637616, 56036.719816400655, 57467.425325746204, 57566.424335756106, 62784.37215627968, 8181.754547363588, 8437.11410301934, 8659.87010194835, 8667.826643467222, 8986.775330616525, 12756.298403587893, 12933.224006559636, 13505.797413038616, 13781.448742050607, 13891.305434728021, 11838.822417663914, 12080.335581542748, 12097.274163550215, 12185.51257949672, 12197.878021219674, 11647.12646551529, 11654.825177622173, 11827.290362578273, 12040.75918481643, 12509.687257818627, 11388.658340249805, 12003.939980300043, 12331.0, 12338.938305308417, 12767.80848287295, 8522.403431759965, 8529.402941794264, 8600.569971501274, 8649.351298652751, 9210.171084602418, 9200.493972831558, 11742.0, 12133.272003679807, 12204.75590488203, 12372.008119660193], "value": 9239.92413395972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.4283072617313, 1418.496433766013, 1494.7533656946605, 1623.4886010906564, 1799.8470130038938, 8597.355198360125, 8965.955170224148, 9088.909110908897, 9336.626534938594, 9341.346105772598, 9136.771580710469, 9244.075592440753, 9260.212881905047, 9261.351705380626, 9261.814763704722, 2430.283066495388, 2458.520588485246, 2458.791002764767, 2460.889259983296, 2462.3967128053564, 2376.0182405396954, 2460.1020627471025, 2474.096954611563, 2479.2810085075307, 2479.3553676044266, 2433.0997530913587, 2459.1638842793445, 2477.665515155449, 2478.5538603051446, 2488.0794106180647, 2351.1300818697105, 2355.128602417108, 2355.9411014724596, 2365.8698771567556, 2389.2712722619594, 2381.4760752634393, 2412.5657381671294, 2421.4914867877765, 2422.079609748302, 2423.575874222022, 8897.555122243863, 9208.953955230181, 9262.517997120429, 9301.72094837156, 9343.71968840936, 5431.972840135813, 5639.041362968305, 5640.8871822563315, 5647.632903861236, 5654.6324488908085, 3356.177736454584, 3385.9661403386144, 3436.0, 3441.397755392821, 3447.3277710846396, 1111.5887121765, 1127.8646562412564, 1150.097173718627, 1183.21316324644, 1187.3944288412886, 12952.028597855198, 13099.738005239937, 13124.146930449395, 13141.342932853415, 13158.802617960739, 4557.886052848706, 4694.084653492604, 4815.422149342101, 4846.733429661403, 4855.0, 10191.9490402549, 10204.13264872494, 10215.131713804261, 10217.284790064625, 10218.0, 5281.9207711884355, 5294.311739473844, 5310.575153987672, 5318.654287471302, 5320.281761962163, 4043.2317859606583, 4349.630281426051, 4491.887702807456, 4935.259711043301, 4942.406911170682, 4020.2964481216254, 4046.4941882264716, 4155.833766649361, 4160.479940007499, 4166.062635906957, 1192.7793358228755, 1216.3240870085847, 1227.551943540619, 1228.6007047709352, 1243.7325974915436, 803.2289002557493, 837.4556538250064, 853.3386625365267, 921.9308551858503, 929.9023602521773, 5801.6519008859605, 5898.203742494794, 5970.0, 5989.0, 6050.292683657138, 946.8070231508349, 982.4498280962683, 993.1062044160313, 1002.5438425516372, 1027.2963020331097, 4036.1120553478186, 4163.417121602978, 4176.83292668296, 4184.916301673949, 4212.873613791591, 11082.833757493645, 11654.242474239147, 11656.41717914101, 11656.766864662659, 11667.941660291644, 11574.363410012362, 11602.361870097226, 11616.070714343, 11622.94188529052, 11655.41722913851, 8393.580320983927, 8543.743687689379, 8661.826763464695, 8705.260052895575, 8709.869351959853, 5825.184474173534, 5901.586888917906, 5970.0746384310505, 5971.193888824953, 6094.39056094387, 10489.108425783894, 10514.369137851754, 10607.257491975488, 10623.309484883457, 10677.733056673334, 9413.435193888388, 10755.623553175601, 11120.165172746407, 11128.666140015812, 11140.0, 7756.263155000266, 7967.601619919097, 8048.235417635316, 8221.383396245425, 8221.671133154847, 8794.560271986247, 8807.295416366547, 8867.73396798097, 8885.866711999195, 9005.05446928063, 7987.680492780456, 7989.161138080418, 8076.434649574473, 8120.431569790058, 8369.414141010071, 7691.615419229128, 7808.336291415293, 7844.686212551663, 7932.325752311118, 7937.682492700227, 6987.650617469208, 6997.335253150943, 7016.859662806817, 7044.225135235222, 7044.36600705939, 5218.337016767446, 5312.203169524448, 5361.4370491099435, 5440.755166017618, 5444.101723215784, 5247.475252474722, 5333.599980001593, 5404.405515393382, 5412.079946409041, 5418.945810541844], "value": 4764.285359152547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8232025318336, 338.8915547024952, 346.9410200265955, 348.09321716927406, 350.6423448082954, 5241.764120614572, 5252.448492908247, 5266.5786737061035, 5310.62825602208, 5351.331083614553, 5133.9229911551265, 5179.974100129503, 5186.766595503202, 5198.166998985553, 5215.426303106655, 4129.483814523184, 4155.189738001091, 4164.562720914306, 4169.207850508394, 4173.582641735832, 3736.9626303737023, 3904.629060239287, 4112.321466957948, 4120.217158739845, 4123.567025462313, 4055.776932268724, 4059.7617726593376, 4062.837486500536, 4068.3083875741195, 4093.9590604093873, 4088.6524645405175, 4102.138550904314, 4109.21924834282, 4136.937945930814, 4141.585841415865, 3457.6542345765224, 3561.982190089059, 3618.5295911531593, 3649.160693040589, 3665.120371110941, 5053.949460505385, 5063.341765570489, 5066.670666406709, 5070.29015937769, 5115.439790863785, 4653.976730116362, 4682.508336624674, 4683.344331793552, 4685.133250348662, 4709.128811169944, 5293.470652934714, 5362.249285100089, 5365.490278423583, 5385.21914322425, 5421.891562168735, 3979.6020397959974, 4003.97998010011, 4006.9198616027516, 4033.878983630496, 4055.5741647127215, 5433.592480563934, 5620.775168993236, 5716.256886604757, 5729.541636669098, 5731.971340143315, 3848.9615103849164, 4109.527404348479, 4119.670426365884, 4123.9381409278885, 4138.337865941435, 4195.286801243796, 4201.264778663722, 4206.957930420718, 4212.462451205288, 4213.410122582841, 4674.807923979363, 4693.413323334583, 4695.413073365829, 4754.524547545287, 4754.857354279377, 5188.599078248852, 5464.726763661801, 5505.733681253334, 5509.283793106871, 5525.917111243334, 1393.0944885824294, 1410.132768347459, 1411.5765270418833, 1431.5132854829408, 1434.168182454174, 872.8516152254132, 909.8043920557112, 914.0356923445828, 931.7763736703142, 933.8739270198437, 4661.627069834405, 4664.230401983635, 4679.976600117046, 4684.798144871905, 4694.577488026094, 4949.446509211534, 4956.8760780980765, 4964.875878103004, 4976.133949768837, 4996.250562415594, 4408.889777755582, 4665.6734028617675, 4666.743329116931, 4693.8316636271065, 4707.388039554836, 2611.5821468564936, 2641.749033841782, 2646.8486208499367, 2648.973510264911, 2658.455016721606, 5094.624451398102, 5129.9740051989, 5135.79308862417, 5155.175171972542, 5164.664296820694, 4812.494688057774, 5011.248312753116, 5026.220935754964, 5072.54347108762, 5079.492050794965, 5025.874353141201, 5053.736565858535, 5074.985002999415, 5095.464976177448, 5117.573299096181, 4932.556069953722, 4941.777620007037, 4951.77717002743, 4990.351254336913, 4998.2002879539095, 4700.952990470051, 4900.754962251945, 4902.656814022984, 4919.409670839522, 4937.456879743154, 5053.469385714447, 5076.466970967996, 5093.770780314969, 5121.795128194831, 5128.307678463509, 3683.9079023024638, 3696.3900956341904, 3700.500432441586, 3716.6097559755835, 3727.1986522897705, 4709.764511774329, 4970.801167953241, 4980.726060066731, 5033.169527028, 5051.282563928282, 4803.807847686054, 4842.854714358575, 4848.539388758062, 4869.366982292279, 4885.853424397274, 4841.4674385816825, 4845.563899249085, 4856.838706775451, 4858.95141048585, 4877.244027175793, 4501.892807332059, 4717.127331443694, 4790.664653474223, 4791.969726508817, 4861.274247642036, 4852.0, 4891.217405215149, 4923.975380123076, 4938.691246819524, 4941.530554597308, 4776.283557466408, 4809.711417314972, 4809.831655892027, 4863.610911127172, 4876.390451193601], "value": 3964.1542971375366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.7338444852078, 756.973505927293, 790.9406794490415, 848.6817443458705, 859.1751918158567, 14011.859881401182, 14736.852631473683, 14777.0, 14785.778213326796, 14810.629734256649, 13160.144590601603, 13227.537036203736, 13235.669108272297, 13241.668958276048, 13242.867571324308, 654.4371840217409, 781.0666253826679, 801.0427539090789, 813.7111325479458, 821.6877586517115, 809.9838003239931, 815.9388045896552, 821.8561751693429, 822.0341099208437, 823.3495538524559, 875.3566128895256, 876.0932434929849, 876.2551830943711, 877.0089798527687, 877.3069275272559, 690.5166383531523, 829.5603330234985, 855.1918437076964, 864.844328020956, 869.9782505437352, 628.933961933995, 629.5655997361806, 632.4497687012329, 632.5319263744842, 632.667849379075, 12082.456289466994, 12200.084993625514, 12235.877641223651, 12248.693782655415, 12298.139130260884, 13918.37367318463, 14233.146011239358, 14395.928020359936, 14427.495037673736, 14781.113133212042, 12775.61673149807, 12820.0, 12830.230186188859, 12968.740625187538, 13168.209907405586, 4321.315874475104, 4403.537628548988, 4418.337249412614, 4485.977570112162, 4496.910061798746, 75736.62131689361, 75765.24234757636, 75890.0, 81848.18151818465, 82284.17715822825, 11515.193936424537, 11553.13351498641, 11730.354830484235, 11857.64427067172, 12211.145219834527, 21478.677819832716, 21500.13999440036, 21581.460463488223, 21585.784142158376, 21650.891745541172, 8275.255227029596, 8342.791430214293, 8378.287845533197, 8418.957905210435, 8802.427842190236, 4454.331850222427, 4530.932036019462, 4546.772661366985, 4714.66997310185, 4975.601951843843, 3446.1556918555116, 3576.946345804815, 3581.1405262737276, 3586.7489275750445, 3588.2464682416985, 577.3274135632025, 588.9440503152193, 608.850831546274, 617.274702224893, 617.7776000639766, 573.7762272713645, 599.5113982104571, 616.6762449713847, 649.8098539658755, 678.5318130489946, 9590.66432674853, 9676.080772326617, 9694.0, 9842.0, 9947.850782238273, 587.9853003674857, 666.3503084492581, 670.4435318685479, 681.1281559603715, 727.5125665803924, 4465.776711164429, 4532.388127602798, 4558.270676691714, 4561.840335588238, 4759.547842954914, 72944.0, 98523.01476985139, 123881.38059309826, 124274.0, 124783.376083119, 62494.0, 85042.57478712568, 111713.0, 112347.0, 113947.0, 91365.0, 92506.53746731223, 95108.52445737727, 96837.0, 97410.0, 8805.603747831236, 8887.688930887389, 8995.147472891935, 9075.364724469224, 9117.680881169128, 54487.18269225885, 54784.452155477935, 55425.0, 56479.71760141173, 56627.0, 82310.58844705978, 82607.5869620648, 84413.0, 85247.57376213079, 87200.0, 11026.889731102587, 11334.659960201207, 11492.982979993894, 11802.409879506162, 12311.19977201479, 14006.789898151332, 15056.322465489298, 15596.376144954529, 15597.610059748597, 15811.209439528207, 14306.427742890584, 14832.332545035284, 14943.0, 15276.694466110837, 15353.309101090254, 14336.713265734836, 14400.207988560729, 14603.853961460674, 15069.623259418602, 15185.088894666356, 14390.424383024561, 14478.131312121306, 14842.109473431628, 14910.179940102964, 15291.082535047934, 11350.262232954832, 11984.666823263564, 12036.939815300868, 12235.602015792692, 12289.201201921847, 10573.9471302643, 11269.774604508028, 12061.939690301844, 12369.752604948031, 12510.249385036926], "value": 7584.374232174249, "unit": "score"}], "name": "dromaeo_css", "value": 7207.905344696908, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 110.0, 111.0, 112.0, 112.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 118.0, 175.0, 118.0, 123.0, 148.0, 118.0, 152.0, 116.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 160.0, 162.0, 159.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 119.0, 75.0, 75.0, 75.0, 76.0, 120.0, 74.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 131.0, 85.0, 86.0, 85.0, 120.0, 84.0, 83.0, 133.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 50.0, 52.0, 51.0, 49.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 75.0, 76.0, 74.0, 75.0, 75.0, 77.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 120.0, 121.0, 135.0, 119.0, 122.0, 120.0, 125.0, 137.0, 127.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 160.0, 159.0, 161.0, 158.0, 158.0, 161.0, 158.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 64.0, 63.0, 65.0, 64.0, 62.0, 62.0, 64.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1479.9, "alertThreshold": 2.0}]} 20:39:11 INFO - Return code: 0 20:39:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:39:11 INFO - # TBPL SUCCESS # 20:39:11 INFO - Running post-action listener: _resource_record_post_action 20:39:11 INFO - [mozharness: 2016-08-08 03:39:11.587956Z] Finished run-tests step (success) 20:39:11 INFO - Running post-run listener: _resource_record_post_run 20:39:11 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 241664; Write bytes: 549838848; Read time: 388; Write time: 444432 20:39:11 INFO - TinderboxPrint: CPU usage
13.1% 20:39:11 INFO - TinderboxPrint: I/O read bytes / time
241,664 / 388 20:39:11 INFO - TinderboxPrint: I/O write bytes / time
549,838,848 / 444,432 20:39:11 INFO - TinderboxPrint: CPU idle
8,272.3 (86.9%) 20:39:11 INFO - TinderboxPrint: CPU user
1,204.4 (12.6%) 20:39:11 INFO - TinderboxPrint: Swap in / out
0 / 0 20:39:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 254287872; Read time: 116; Write time: 213908 20:39:11 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 233472; Write bytes: 294699008; Read time: 256; Write time: 230500 20:39:12 INFO - Running post-run listener: _upload_blobber_files 20:39:12 INFO - Blob upload gear active. 20:39:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:39:12 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 20:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:39:12 INFO - (blobuploader) - INFO - Open directory for files ... 20:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:13 INFO - (blobuploader) - INFO - Done attempting. 20:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:14 INFO - (blobuploader) - INFO - Done attempting. 20:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:19 INFO - (blobuploader) - INFO - Done attempting. 20:39:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:39:19 INFO - Return code: 0 20:39:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:39:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:39:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e48293fddd77beb3dc0f0f59b61288d5066ac72ef4d846740b872f90fe03a473220852927ce94b8cf4c68249725538da102936253a649676782970b00927150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4356dcf5ba22f772fcb2da96816719fa4bd830959e226e2f91a1cb70465288f9b5ac588207ca587dfda7e6f4d06b3499660fc7999303a2708c7d80d006c918", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2e235ce5af295d9dd96215ab8aedf2e4dc9760d2520838b029c923729b0fbe3404226cd0aa9bcc1322941276cd2f61169b0d7e2e0d9663e0a63c7a5a8d8c120"} 20:39:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:39:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:39:19 INFO - Contents: 20:39:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e48293fddd77beb3dc0f0f59b61288d5066ac72ef4d846740b872f90fe03a473220852927ce94b8cf4c68249725538da102936253a649676782970b00927150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4356dcf5ba22f772fcb2da96816719fa4bd830959e226e2f91a1cb70465288f9b5ac588207ca587dfda7e6f4d06b3499660fc7999303a2708c7d80d006c918", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2e235ce5af295d9dd96215ab8aedf2e4dc9760d2520838b029c923729b0fbe3404226cd0aa9bcc1322941276cd2f61169b0d7e2e0d9663e0a63c7a5a8d8c120"} 20:39:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:39:19 INFO - Copying logs to upload dir... 20:39:19 INFO - mkdir: /builds/slave/test/build/upload/logs 20:39:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.678946 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-07 20:39:18.951253) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 20:39:18.954520) ========= 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=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e48293fddd77beb3dc0f0f59b61288d5066ac72ef4d846740b872f90fe03a473220852927ce94b8cf4c68249725538da102936253a649676782970b00927150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4356dcf5ba22f772fcb2da96816719fa4bd830959e226e2f91a1cb70465288f9b5ac588207ca587dfda7e6f4d06b3499660fc7999303a2708c7d80d006c918", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2e235ce5af295d9dd96215ab8aedf2e4dc9760d2520838b029c923729b0fbe3404226cd0aa9bcc1322941276cd2f61169b0d7e2e0d9663e0a63c7a5a8d8c120"} build_url:https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Sg42jnfvSlm_XO5iCTVxLg/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/sha512/9e48293fddd77beb3dc0f0f59b61288d5066ac72ef4d846740b872f90fe03a473220852927ce94b8cf4c68249725538da102936253a649676782970b00927150", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4356dcf5ba22f772fcb2da96816719fa4bd830959e226e2f91a1cb70465288f9b5ac588207ca587dfda7e6f4d06b3499660fc7999303a2708c7d80d006c918", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2e235ce5af295d9dd96215ab8aedf2e4dc9760d2520838b029c923729b0fbe3404226cd0aa9bcc1322941276cd2f61169b0d7e2e0d9663e0a63c7a5a8d8c120"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 20:39:18.982157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:39:18.982475) ========= 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=41bf3e9aed84707956354da8000001c5-1470624516.751568-1650545693 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 20:39:19.062861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 20:39:19.063303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 20:39:19.063631) ========= ========= Total master_lag: 0.16 =========