builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1453896308.57 results: success (0) buildid: 20160127013049 builduid: 12eaf0db1bbe49aab64169ddadeaad08 revision: 0049e7998c1a820f4a987b851f147803ee3f4ced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.574117) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.574581) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.574865) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006292 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.598175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.598493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.611806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.612184) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.661348) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.661655) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.662024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.662296) ========= 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-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 04:05:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.3M=0s 2016-01-27 04:05:08 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.773152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.773642) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.106184 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:08.892062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-27 04:05:08.892432) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0049e7998c1a820f4a987b851f147803ee3f4ced --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0049e7998c1a820f4a987b851f147803ee3f4ced --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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 04:05:08,951 truncating revision to first 12 chars 2016-01-27 04:05:08,951 Setting DEBUG logging. 2016-01-27 04:05:08,952 attempt 1/10 2016-01-27 04:05:08,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0049e7998c1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 04:05:10,157 unpacking tar archive at: mozilla-inbound-0049e7998c1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.502879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-27 04:05:10.408195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:10.408559) ========= echo 0049e7998c1a820f4a987b851f147803ee3f4ced in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0049e7998c1a820f4a987b851f147803ee3f4ced'] 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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0049e7998c1a820f4a987b851f147803ee3f4ced program finished with exit code 0 elapsedTime=0.004655 script_repo_revision: '0049e7998c1a820f4a987b851f147803ee3f4ced' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:10.461127) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:10.461445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 04:05:10.471050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-27 04:05:10.471329) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:10 INFO - MultiFileLogger online at 20160127 04:05:10 in /builds/slave/test-pgo 04:05:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:05:10 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:05:10 INFO - {'append_to_log': False, 04:05:10 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:05:10 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:05:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:05:10 INFO - 'branch': 'Mozilla-Inbound', 04:05:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:10 INFO - 'config_files': ('talos/linux_config.py',), 04:05:10 INFO - 'default_actions': ('clobber', 04:05:10 INFO - 'read-buildbot-config', 04:05:10 INFO - 'download-and-extract', 04:05:10 INFO - 'populate-webroot', 04:05:10 INFO - 'create-virtualenv', 04:05:10 INFO - 'install', 04:05:10 INFO - 'run-tests'), 04:05:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:10 INFO - 'download_minidump_stackwalk': True, 04:05:10 INFO - 'download_symbols': 'ondemand', 04:05:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:10 INFO - 'installer_path': 'installer.exe', 04:05:10 INFO - 'log_level': 'info', 04:05:10 INFO - 'log_name': 'talos', 04:05:10 INFO - 'log_to_console': True, 04:05:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:10 INFO - 'opt_config_files': (), 04:05:10 INFO - 'pip_index': False, 04:05:10 INFO - 'sps_profile': False, 04:05:10 INFO - 'sps_profile_interval': 0, 04:05:10 INFO - 'suite': 'dromaeojs-e10s', 04:05:10 INFO - 'system_bits': '32', 04:05:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:10 INFO - 'title': 'talos-linux64-ix-063', 04:05:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:10 INFO - 'use_talos_json': True, 04:05:10 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:05:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:10 INFO - 'work_dir': 'build'} 04:05:10 INFO - ##### 04:05:10 INFO - ##### Running clobber step. 04:05:10 INFO - ##### 04:05:10 INFO - Running pre-action listener: _resource_record_pre_action 04:05:10 INFO - Running main action method: clobber 04:05:10 INFO - rmtree: /builds/slave/test-pgo/build 04:05:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:05:15 INFO - Running post-action listener: _resource_record_post_action 04:05:15 INFO - ##### 04:05:15 INFO - ##### Running read-buildbot-config step. 04:05:15 INFO - ##### 04:05:15 INFO - Running pre-action listener: _resource_record_pre_action 04:05:15 INFO - Running main action method: read_buildbot_config 04:05:15 INFO - Using buildbot properties: 04:05:15 INFO - { 04:05:15 INFO - "project": "", 04:05:15 INFO - "product": "firefox", 04:05:15 INFO - "script_repo_revision": "production", 04:05:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:05:15 INFO - "repository": "", 04:05:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:05:15 INFO - "buildid": "20160127013049", 04:05:15 INFO - "pgo_build": "True", 04:05:15 INFO - "basedir": "/builds/slave/test-pgo", 04:05:15 INFO - "buildnumber": 648, 04:05:15 INFO - "slavename": "talos-linux64-ix-063", 04:05:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:05:15 INFO - "platform": "ubuntu64_hw", 04:05:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:05:15 INFO - "branch": "mozilla-inbound", 04:05:15 INFO - "repo_path": "integration/mozilla-inbound", 04:05:15 INFO - "revision": "0049e7998c1a820f4a987b851f147803ee3f4ced", 04:05:15 INFO - "stage_platform": "linux64-pgo", 04:05:15 INFO - "builduid": "12eaf0db1bbe49aab64169ddadeaad08", 04:05:15 INFO - "slavebuilddir": "test" 04:05:15 INFO - } 04:05:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:05:15 INFO - Running post-action listener: _resource_record_post_action 04:05:15 INFO - ##### 04:05:15 INFO - ##### Running download-and-extract step. 04:05:15 INFO - ##### 04:05:15 INFO - Running pre-action listener: _resource_record_pre_action 04:05:15 INFO - Running main action method: download_and_extract 04:05:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:15 INFO - https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/test_packages.json 04:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/test_packages.json 04:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:05:16 INFO - Downloaded 1448 bytes. 04:05:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:05:16 INFO - Using the following test package requirements: 04:05:16 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:05:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'jsshell-linux-x86_64.zip'], 04:05:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:16 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:16 INFO - https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:17 INFO - Downloaded 22505261 bytes. 04:05:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:05:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:05:18 INFO - Return code: 0 04:05:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:05:20 INFO - Downloaded 22505261 bytes. 04:05:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:05:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:05:21 INFO - Return code: 0 04:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:21 INFO - https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:05:22 INFO - Downloaded 10706572 bytes. 04:05:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:05:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:05:22 INFO - Return code: 0 04:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:22 INFO - https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:05:23 INFO - Downloaded 55979721 bytes. 04:05:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:05:23 INFO - mkdir: /builds/slave/test-pgo/properties 04:05:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:05:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:05:23 INFO - Contents: 04:05:23 INFO - build_url:https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:05:23 INFO - Running post-action listener: _resource_record_post_action 04:05:23 INFO - Running post-action listener: set_extra_try_arguments 04:05:23 INFO - ##### 04:05:23 INFO - ##### Running populate-webroot step. 04:05:23 INFO - ##### 04:05:23 INFO - Running pre-action listener: _resource_record_pre_action 04:05:23 INFO - Running main action method: populate_webroot 04:05:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:23 INFO - '--tppagecycles', 04:05:23 INFO - '7'], 04:05:23 INFO - 'tests': ['tsvgm']}}, 04:05:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:05:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'tests': ['damp', 'tps']}, 04:05:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['damp', 'tps']}, 04:05:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:23 INFO - 'other': {'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'other_l64': {'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:23 INFO - 'ts_paint', 04:05:23 INFO - 'tpaint', 04:05:23 INFO - 'sessionrestore', 04:05:23 INFO - 'sessionrestore_no_auto_restore']}, 04:05:23 INFO - 'svgr': {'tests': ['tsvgx', 04:05:23 INFO - 'tsvgr_opacity', 04:05:23 INFO - 'tart', 04:05:23 INFO - 'tscrollx', 04:05:23 INFO - 'cart']}, 04:05:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['tsvgx', 04:05:23 INFO - 'tsvgr_opacity', 04:05:23 INFO - 'tart', 04:05:23 INFO - 'tscrollx', 04:05:23 INFO - 'cart']}, 04:05:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'tests': ['tp5o']}, 04:05:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'talos_options': ['--e10s'], 04:05:23 INFO - 'tests': ['tp5o']}, 04:05:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'talos_options': ['--xperf_path', 04:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:23 INFO - 'tests': ['tp5n']}, 04:05:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:23 INFO - 'talos_options': ['--e10s', 04:05:23 INFO - '--xperf_path', 04:05:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:23 INFO - 'tests': ['tp5n']}}, 04:05:23 INFO - 'talos.zip': {'path': '', 04:05:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:23 INFO - Running post-action listener: _resource_record_post_action 04:05:23 INFO - ##### 04:05:23 INFO - ##### Running create-virtualenv step. 04:05:23 INFO - ##### 04:05:23 INFO - Running pre-action listener: _resource_record_pre_action 04:05:23 INFO - Running main action method: create_virtualenv 04:05:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:05:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:05:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:05:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:24 INFO - Using real prefix '/usr' 04:05:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:05:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:26 INFO - Installing pip.................done. 04:05:26 INFO - Return code: 0 04:05:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:26 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 04:05:26 INFO - Copy/paste: /builds/slave/test-pgo/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 04:05:26 INFO - Using env: {'DISPLAY': ':0', 04:05:26 INFO - 'HOME': '/home/cltbld', 04:05:26 INFO - 'LANG': 'en_US.UTF-8', 04:05:26 INFO - 'LANGUAGE': 'en_US:en', 04:05:26 INFO - 'LOGNAME': 'cltbld', 04:05:26 INFO - 'MAIL': '/var/mail/cltbld', 04:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:26 INFO - 'MOZ_NO_REMOTE': '1', 04:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:26 INFO - 'NO_EM_RESTART': '1', 04:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:26 INFO - 'SHELL': '/bin/bash', 04:05:26 INFO - 'SHLVL': '1', 04:05:26 INFO - 'TERM': 'linux', 04:05:26 INFO - 'TMOUT': '86400', 04:05:26 INFO - 'USER': 'cltbld', 04:05:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:26 INFO - '_': '/tools/buildbot/bin/python'} 04:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:26 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 04:05:26 INFO - Cleaning up... 04:05:26 INFO - Return code: 0 04:05:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:26 INFO - Running command: ['/builds/slave/test-pgo/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>=0.7.1'] in /builds/slave/test-pgo/build 04:05:26 INFO - Copy/paste: /builds/slave/test-pgo/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>=0.7.1 04:05:26 INFO - Using env: {'DISPLAY': ':0', 04:05:26 INFO - 'HOME': '/home/cltbld', 04:05:26 INFO - 'LANG': 'en_US.UTF-8', 04:05:26 INFO - 'LANGUAGE': 'en_US:en', 04:05:26 INFO - 'LOGNAME': 'cltbld', 04:05:26 INFO - 'MAIL': '/var/mail/cltbld', 04:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:26 INFO - 'MOZ_NO_REMOTE': '1', 04:05:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:26 INFO - 'NO_EM_RESTART': '1', 04:05:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:26 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:26 INFO - 'SHELL': '/bin/bash', 04:05:26 INFO - 'SHLVL': '1', 04:05:26 INFO - 'TERM': 'linux', 04:05:26 INFO - 'TMOUT': '86400', 04:05:26 INFO - 'USER': 'cltbld', 04:05:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:26 INFO - '_': '/tools/buildbot/bin/python'} 04:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:26 INFO - Downloading/unpacking psutil>=0.7.1 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:28 INFO - Installing collected packages: psutil 04:05:29 INFO - Running setup.py install for psutil 04:05:29 INFO - building 'psutil._psutil_linux' extension 04:05:29 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 04:05:29 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 04:05:30 INFO - building 'psutil._psutil_posix' extension 04:05:30 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 04:05:30 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 04:05:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:30 INFO - Successfully installed psutil 04:05:30 INFO - Cleaning up... 04:05:30 INFO - Return code: 0 04:05:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:30 INFO - Running command: ['/builds/slave/test-pgo/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.0.0'] in /builds/slave/test-pgo/build 04:05:30 INFO - Copy/paste: /builds/slave/test-pgo/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.0.0 04:05:30 INFO - Using env: {'DISPLAY': ':0', 04:05:30 INFO - 'HOME': '/home/cltbld', 04:05:30 INFO - 'LANG': 'en_US.UTF-8', 04:05:30 INFO - 'LANGUAGE': 'en_US:en', 04:05:30 INFO - 'LOGNAME': 'cltbld', 04:05:30 INFO - 'MAIL': '/var/mail/cltbld', 04:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:30 INFO - 'MOZ_NO_REMOTE': '1', 04:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:30 INFO - 'NO_EM_RESTART': '1', 04:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:30 INFO - 'SHELL': '/bin/bash', 04:05:30 INFO - 'SHLVL': '1', 04:05:30 INFO - 'TERM': 'linux', 04:05:30 INFO - 'TMOUT': '86400', 04:05:30 INFO - 'USER': 'cltbld', 04:05:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:30 INFO - '_': '/tools/buildbot/bin/python'} 04:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:30 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 04:05:30 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 04:05:30 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 04:05:30 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 04:05:30 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 04:05:30 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 04:05:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:05:32 INFO - Installing collected packages: mozsystemmonitor 04:05:32 INFO - Running setup.py install for mozsystemmonitor 04:05:32 INFO - Successfully installed mozsystemmonitor 04:05:32 INFO - Cleaning up... 04:05:32 INFO - Return code: 0 04:05:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:32 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 04:05:32 INFO - Copy/paste: /builds/slave/test-pgo/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 04:05:32 INFO - Using env: {'DISPLAY': ':0', 04:05:32 INFO - 'HOME': '/home/cltbld', 04:05:32 INFO - 'LANG': 'en_US.UTF-8', 04:05:32 INFO - 'LANGUAGE': 'en_US:en', 04:05:32 INFO - 'LOGNAME': 'cltbld', 04:05:32 INFO - 'MAIL': '/var/mail/cltbld', 04:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:32 INFO - 'MOZ_NO_REMOTE': '1', 04:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:32 INFO - 'NO_EM_RESTART': '1', 04:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:32 INFO - 'SHELL': '/bin/bash', 04:05:32 INFO - 'SHLVL': '1', 04:05:32 INFO - 'TERM': 'linux', 04:05:32 INFO - 'TMOUT': '86400', 04:05:32 INFO - 'USER': 'cltbld', 04:05:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:32 INFO - '_': '/tools/buildbot/bin/python'} 04:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:05:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:35 INFO - Downloading docopt-0.6.1.tar.gz 04:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:35 INFO - Running setup.py install for blobuploader 04:05:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:05:35 INFO - Running setup.py install for requests 04:05:35 INFO - Running setup.py install for docopt 04:05:35 INFO - Successfully installed blobuploader requests docopt 04:05:35 INFO - Cleaning up... 04:05:35 INFO - Return code: 0 04:05:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:05:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/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 04:05:35 INFO - Using env: {'DISPLAY': ':0', 04:05:35 INFO - 'HOME': '/home/cltbld', 04:05:35 INFO - 'LANG': 'en_US.UTF-8', 04:05:35 INFO - 'LANGUAGE': 'en_US:en', 04:05:35 INFO - 'LOGNAME': 'cltbld', 04:05:35 INFO - 'MAIL': '/var/mail/cltbld', 04:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:35 INFO - 'MOZ_NO_REMOTE': '1', 04:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:35 INFO - 'NO_EM_RESTART': '1', 04:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:35 INFO - 'SHELL': '/bin/bash', 04:05:35 INFO - 'SHLVL': '1', 04:05:35 INFO - 'TERM': 'linux', 04:05:35 INFO - 'TMOUT': '86400', 04:05:35 INFO - 'USER': 'cltbld', 04:05:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:35 INFO - '_': '/tools/buildbot/bin/python'} 04:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:36 INFO - Running setup.py (path:/tmp/pip-rPmtEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:36 INFO - Running setup.py (path:/tmp/pip-fJ0lH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:36 INFO - Running setup.py (path:/tmp/pip-bKRndx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:36 INFO - Running setup.py (path:/tmp/pip-U325uc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:36 INFO - Running setup.py (path:/tmp/pip-xZOWUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:36 INFO - Running setup.py (path:/tmp/pip-yG2lXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:36 INFO - Running setup.py (path:/tmp/pip-jB6srW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:36 INFO - Running setup.py (path:/tmp/pip-tpu3J8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:36 INFO - Running setup.py (path:/tmp/pip-Rkmp7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:36 INFO - Running setup.py (path:/tmp/pip-EkmwyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:36 INFO - Running setup.py (path:/tmp/pip-rhs9OV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:36 INFO - Running setup.py (path:/tmp/pip-FJ5zBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:36 INFO - Running setup.py (path:/tmp/pip-BbnM9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:36 INFO - Running setup.py (path:/tmp/pip-MWyMMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:37 INFO - Running setup.py (path:/tmp/pip-hioX7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:37 INFO - Running setup.py (path:/tmp/pip-pNOJfR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:37 INFO - Running setup.py (path:/tmp/pip-nJ98WW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:37 INFO - Running setup.py install for manifestparser 04:05:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:05:37 INFO - Running setup.py install for mozcrash 04:05:37 INFO - Running setup.py install for mozdebug 04:05:37 INFO - Running setup.py install for mozdevice 04:05:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:05:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:05:37 INFO - Running setup.py install for mozfile 04:05:37 INFO - Running setup.py install for mozhttpd 04:05:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:05:37 INFO - Running setup.py install for mozinfo 04:05:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:05:37 INFO - Running setup.py install for mozInstall 04:05:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Running setup.py install for mozleak 04:05:38 INFO - Running setup.py install for mozlog 04:05:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Running setup.py install for moznetwork 04:05:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Running setup.py install for mozprocess 04:05:38 INFO - Running setup.py install for mozprofile 04:05:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Running setup.py install for mozrunner 04:05:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:05:38 INFO - Running setup.py install for mozscreenshot 04:05:38 INFO - Running setup.py install for moztest 04:05:38 INFO - Running setup.py install for mozversion 04:05:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:05:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:39 INFO - Cleaning up... 04:05:39 INFO - Return code: 0 04:05:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/config 04:05:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 04:05:39 INFO - Using env: {'DISPLAY': ':0', 04:05:39 INFO - 'HOME': '/home/cltbld', 04:05:39 INFO - 'LANG': 'en_US.UTF-8', 04:05:39 INFO - 'LANGUAGE': 'en_US:en', 04:05:39 INFO - 'LOGNAME': 'cltbld', 04:05:39 INFO - 'MAIL': '/var/mail/cltbld', 04:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:39 INFO - 'MOZ_NO_REMOTE': '1', 04:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:39 INFO - 'NO_EM_RESTART': '1', 04:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:39 INFO - 'SHELL': '/bin/bash', 04:05:39 INFO - 'SHLVL': '1', 04:05:39 INFO - 'TERM': 'linux', 04:05:39 INFO - 'TMOUT': '86400', 04:05:39 INFO - 'USER': 'cltbld', 04:05:39 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:39 INFO - '_': '/tools/buildbot/bin/python'} 04:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:39 INFO - Running setup.py (path:/tmp/pip-SYlgkU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:39 INFO - Running setup.py (path:/tmp/pip-h1HbUn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:39 INFO - Running setup.py (path:/tmp/pip-LJY8DF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:39 INFO - Running setup.py (path:/tmp/pip-WPPiY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:39 INFO - Running setup.py (path:/tmp/pip-ej1kSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:39 INFO - Running setup.py (path:/tmp/pip-u_FIyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:39 INFO - Running setup.py (path:/tmp/pip-j1vfHv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:39 INFO - Running setup.py (path:/tmp/pip-ryUcGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:39 INFO - Running setup.py (path:/tmp/pip-uvwfvn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:39 INFO - Running setup.py (path:/tmp/pip-ljynaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:40 INFO - Running setup.py (path:/tmp/pip-fJlukG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:40 INFO - Running setup.py (path:/tmp/pip-p2fpQG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:40 INFO - Running setup.py (path:/tmp/pip-XuSOGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:40 INFO - Running setup.py (path:/tmp/pip-FowDya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:40 INFO - Running setup.py (path:/tmp/pip-3Or9IN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:40 INFO - Running setup.py (path:/tmp/pip-sRR7e9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:05:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:40 INFO - Running setup.py (path:/tmp/pip-2E9A_5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:05:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:40 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 04:05:40 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 04:05:40 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 04:05:40 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 04:05:40 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 04:05:40 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 04:05:42 INFO - Downloading blessings-1.6.tar.gz 04:05:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:42 INFO - Installing collected packages: blessings 04:05:42 INFO - Running setup.py install for blessings 04:05:42 INFO - Successfully installed blessings 04:05:42 INFO - Cleaning up... 04:05:42 INFO - Return code: 0 04:05:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:05:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:42 INFO - Reading from file tmpfile_stdout 04:05:42 INFO - Current package versions: 04:05:42 INFO - argparse == 1.2.1 04:05:42 INFO - blessings == 1.6 04:05:42 INFO - blobuploader == 1.2.4 04:05:42 INFO - docopt == 0.6.1 04:05:42 INFO - manifestparser == 1.1 04:05:42 INFO - mozInstall == 1.12 04:05:42 INFO - mozcrash == 0.16 04:05:42 INFO - mozdebug == 0.1 04:05:42 INFO - mozdevice == 0.48 04:05:42 INFO - mozfile == 1.2 04:05:42 INFO - mozhttpd == 0.7 04:05:42 INFO - mozinfo == 0.9 04:05:42 INFO - mozleak == 0.1 04:05:42 INFO - mozlog == 3.1 04:05:42 INFO - moznetwork == 0.27 04:05:42 INFO - mozprocess == 0.22 04:05:42 INFO - mozprofile == 0.28 04:05:42 INFO - mozrunner == 6.11 04:05:42 INFO - mozscreenshot == 0.1 04:05:42 INFO - mozsystemmonitor == 0.0 04:05:42 INFO - moztest == 0.7 04:05:42 INFO - mozversion == 1.4 04:05:42 INFO - psutil == 3.1.1 04:05:42 INFO - requests == 1.2.3 04:05:42 INFO - wsgiref == 0.1.2 04:05:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/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-pgo/build/tests/talos 04:05:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/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 04:05:42 INFO - Using env: {'DISPLAY': ':0', 04:05:42 INFO - 'HOME': '/home/cltbld', 04:05:42 INFO - 'LANG': 'en_US.UTF-8', 04:05:42 INFO - 'LANGUAGE': 'en_US:en', 04:05:42 INFO - 'LOGNAME': 'cltbld', 04:05:42 INFO - 'MAIL': '/var/mail/cltbld', 04:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:42 INFO - 'MOZ_NO_REMOTE': '1', 04:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:42 INFO - 'NO_EM_RESTART': '1', 04:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:42 INFO - 'SHELL': '/bin/bash', 04:05:42 INFO - 'SHLVL': '1', 04:05:42 INFO - 'TERM': 'linux', 04:05:42 INFO - 'TMOUT': '86400', 04:05:42 INFO - 'USER': 'cltbld', 04:05:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:42 INFO - '_': '/tools/buildbot/bin/python'} 04:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:05:42 INFO - Cleaning up... 04:05:42 INFO - Return code: 0 04:05:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/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 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:42 INFO - Running command: ['/builds/slave/test-pgo/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-pgo/build 04:05:42 INFO - Copy/paste: /builds/slave/test-pgo/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 04:05:42 INFO - Using env: {'DISPLAY': ':0', 04:05:42 INFO - 'HOME': '/home/cltbld', 04:05:42 INFO - 'LANG': 'en_US.UTF-8', 04:05:42 INFO - 'LANGUAGE': 'en_US:en', 04:05:42 INFO - 'LOGNAME': 'cltbld', 04:05:42 INFO - 'MAIL': '/var/mail/cltbld', 04:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:42 INFO - 'MOZ_NO_REMOTE': '1', 04:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:42 INFO - 'NO_EM_RESTART': '1', 04:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:42 INFO - 'SHELL': '/bin/bash', 04:05:42 INFO - 'SHLVL': '1', 04:05:42 INFO - 'TERM': 'linux', 04:05:42 INFO - 'TMOUT': '86400', 04:05:42 INFO - 'USER': 'cltbld', 04:05:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:42 INFO - '_': '/tools/buildbot/bin/python'} 04:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:43 INFO - Downloading/unpacking jsonschema 04:05:43 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 04:05:43 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 04:05:43 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 04:05:43 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 04:05:43 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 04:05:43 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 04:05:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:44 INFO - Downloading/unpacking functools32 (from jsonschema) 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:45 INFO - warning: no files found matching '*.txt' 04:05:45 INFO - no previously-included directories found matching 'build' 04:05:45 INFO - no previously-included directories found matching 'dist' 04:05:45 INFO - no previously-included directories found matching '.git*' 04:05:45 INFO - Installing collected packages: jsonschema, functools32 04:05:45 INFO - Running setup.py install for functools32 04:05:45 INFO - warning: no files found matching '*.txt' 04:05:45 INFO - no previously-included directories found matching 'build' 04:05:45 INFO - no previously-included directories found matching 'dist' 04:05:45 INFO - no previously-included directories found matching '.git*' 04:05:45 INFO - Successfully installed jsonschema functools32 04:05:45 INFO - Cleaning up... 04:05:45 INFO - Return code: 0 04:05:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3ce1eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b9560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', '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-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/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 04:05:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:05:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:05:45 INFO - Using env: {'DISPLAY': ':0', 04:05:45 INFO - 'HOME': '/home/cltbld', 04:05:45 INFO - 'LANG': 'en_US.UTF-8', 04:05:45 INFO - 'LANGUAGE': 'en_US:en', 04:05:45 INFO - 'LOGNAME': 'cltbld', 04:05:45 INFO - 'MAIL': '/var/mail/cltbld', 04:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:45 INFO - 'MOZ_NO_REMOTE': '1', 04:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:45 INFO - 'NO_EM_RESTART': '1', 04:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:45 INFO - 'SHELL': '/bin/bash', 04:05:45 INFO - 'SHLVL': '1', 04:05:45 INFO - 'TERM': 'linux', 04:05:45 INFO - 'TMOUT': '86400', 04:05:45 INFO - 'USER': 'cltbld', 04:05:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:45 INFO - '_': '/tools/buildbot/bin/python'} 04:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:45 INFO - Downloading/unpacking flake8 04:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:05:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:05:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:05:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:47 INFO - no previously-included directories found matching 'docs/_build' 04:05:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:05:48 INFO - Running setup.py install for pep8 04:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:48 INFO - no previously-included directories found matching 'docs/_build' 04:05:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:05:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:05:48 INFO - Cleaning up... 04:05:48 INFO - Return code: 0 04:05:48 INFO - Running post-action listener: _resource_record_post_action 04:05:48 INFO - Running post-action listener: _start_resource_monitoring 04:05:48 INFO - Starting resource monitoring. 04:05:48 INFO - ##### 04:05:48 INFO - ##### Running install step. 04:05:48 INFO - ##### 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: install 04:05:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:48 INFO - Reading from file tmpfile_stdout 04:05:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:05:48 INFO - Reading from file tmpfile_stdout 04:05:48 INFO - Output received: 04:05:48 INFO - Usage: mozinstall [options] installer 04:05:48 INFO - Options: 04:05:48 INFO - -h, --help show this help message and exit 04:05:48 INFO - -d DEST, --destination=DEST 04:05:48 INFO - Directory to install application into. [default: 04:05:48 INFO - "/builds/slave/test-pgo"] 04:05:48 INFO - --app=APP Application being installed. [default: firefox] 04:05:48 INFO - mkdir: /builds/slave/test-pgo/build/application 04:05:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:05:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:06:04 INFO - Reading from file tmpfile_stdout 04:06:04 INFO - Output received: 04:06:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:06:04 INFO - Running post-action listener: _resource_record_post_action 04:06:04 INFO - ##### 04:06:04 INFO - ##### Running run-tests step. 04:06:04 INFO - ##### 04:06:04 INFO - Running pre-action listener: _resource_record_pre_action 04:06:04 INFO - Running main action method: run_tests 04:06:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:06:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:06:04 INFO - Python 2.7.3 04:06:04 INFO - Return code: 0 04:06:04 INFO - grabbing minidump binary from tooltool 04:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:04 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-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2748740>, '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 0x2749640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2749af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:06:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:06:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:06:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:04 INFO - Return code: 0 04:06:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:06:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:06:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:06:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:06:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:06:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:06:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:06:05 INFO - Return code: 0 04:06:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 04:06:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:06:05 INFO - Using env: {'DISPLAY': ':0', 04:06:05 INFO - 'HOME': '/home/cltbld', 04:06:05 INFO - 'LANG': 'en_US.UTF-8', 04:06:05 INFO - 'LANGUAGE': 'en_US:en', 04:06:05 INFO - 'LOGNAME': 'cltbld', 04:06:05 INFO - 'MAIL': '/var/mail/cltbld', 04:06:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:06:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:05 INFO - 'MOZ_NO_REMOTE': '1', 04:06:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:05 INFO - 'NO_EM_RESTART': '1', 04:06:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:06:05 INFO - 'PWD': '/builds/slave/test-pgo', 04:06:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:06:05 INFO - 'SHELL': '/bin/bash', 04:06:05 INFO - 'SHLVL': '1', 04:06:05 INFO - 'TERM': 'linux', 04:06:05 INFO - 'TMOUT': '86400', 04:06:05 INFO - 'USER': 'cltbld', 04:06:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795', 04:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:05 INFO - '_': '/tools/buildbot/bin/python'} 04:06:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:06:05 INFO - mozversion application_buildid: 20160127013049 04:06:05 INFO - mozversion application_changeset: 0049e7998c1a820f4a987b851f147803ee3f4ced 04:06:05 INFO - mozversion application_display_name: Nightly 04:06:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:05 INFO - mozversion application_name: Firefox 04:06:05 INFO - mozversion application_remotingname: firefox 04:06:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:06:05 INFO - mozversion application_vendor: Mozilla 04:06:05 INFO - mozversion application_version: 47.0a1 04:06:05 INFO - mozversion platform_buildid: 20160127013049 04:06:05 INFO - mozversion platform_changeset: 0049e7998c1a820f4a987b851f147803ee3f4ced 04:06:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:06:05 INFO - mozversion platform_version: 47.0a1 04:06:05 INFO - using testdate: 1453896365 04:06:05 INFO - actual date: 1453896365 04:06:05 INFO - starting webserver on 'localhost:35663' 04:06:05 INFO - SUITE-START | Running 3 tests 04:06:05 INFO - TEST-START | dromaeo_css 04:06:05 INFO - operating with platform_type : linux_ 04:06:05 INFO - Initialising browser for dromaeo_css test... 04:06:06 INFO - TEST-INFO | started process 3956 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ3VXGJ/profile http://localhost:35663/getInfo.html) 04:06:09 INFO - PROCESS | 3956 | 04:06:09 INFO - PROCESS | 3956 | (process:4039): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:11 INFO - PROCESS | 3956 | __metrics Screen width/height:1600/1200 04:06:11 INFO - PROCESS | 3956 | colorDepth:24 04:06:11 INFO - PROCESS | 3956 | Browser inner width/height: 1024/697 04:06:11 INFO - PROCESS | 3956 | __metrics 04:06:11 INFO - PROCESS | 3956 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:06:11 INFO - PROCESS | 3956 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:06:12 INFO - TEST-INFO | 3956: exit 0 04:06:12 INFO - Browser initialized. 04:06:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:12 INFO - TEST-INFO | started process 4088 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZ3VXGJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:14 INFO - PROCESS | 4088 | 04:06:14 INFO - PROCESS | 4088 | (process:4147): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:24 INFO - PROCESS | 4088 | RSS: Main: 152109056 04:06:24 INFO - PROCESS | 4088 | 04:07:14 INFO - PROCESS | 4088 | 1453896434314 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] 04:09:22 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35663/tests/dromaeo/cssquery-ext.html) 04:09:23 INFO - PROCESS | 4088 | RSS: Main: 161234944 04:09:23 INFO - PROCESS | 4088 | 04:12:25 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-ext.html (next: http://localhost:35663/tests/dromaeo/cssquery-jquery.html) 04:12:26 INFO - PROCESS | 4088 | RSS: Main: 154935296 04:12:26 INFO - PROCESS | 4088 | 04:15:28 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35663/tests/dromaeo/cssquery-mootools.html) 04:15:28 INFO - PROCESS | 4088 | RSS: Main: 156434432 04:15:28 INFO - PROCESS | 4088 | 04:18:30 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35663/tests/dromaeo/cssquery-prototype.html) 04:18:31 INFO - PROCESS | 4088 | RSS: Main: 155471872 04:18:31 INFO - PROCESS | 4088 | 04:21:33 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35663/tests/dromaeo/cssquery-yui.html) 04:21:34 INFO - PROCESS | 4088 | RSS: Main: 155648000 04:21:34 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | Cycle 1(1): loaded http://localhost:35663/tests/dromaeo/cssquery-yui.html (next: http://localhost:35663/tests/dromaeo/cssquery-dojo.html) 04:24:36 INFO - PROCESS | 4088 | RSS: Main: 158777344 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | __start_tp_report 04:24:36 INFO - PROCESS | 4088 | _x_x_mozilla_page_load 04:24:36 INFO - PROCESS | 4088 | _x_x_mozilla_page_load_details 04:24:36 INFO - PROCESS | 4088 | |i|pagename|runs| 04:24:36 INFO - PROCESS | 4088 | |0;dojo.html;3237.595300587426;3269.3461307738444;3303.554020207271;3310.884119055832;3317.6682331766824;5251.763670634821;5331.413544510106;5367.543758780504;5408.729563521818;5419.891602167954;5292;5301.575873930076;5351.973240133794;5421.701806400646;5440.891182176364;4852.369192005034;4888.682235654689;4933.309336692866;4939.382577177853;5008.649394542384;687.6494970225738;4848.5636292733825;4886.853394398156;4892.3639926809465;4946.134426475371;4851;4854.732989685584;4859.173940430135;4871.147549178915;4893.04585605807;4886.02279544089;4902.436219834729;4914.7788349524;4923.975380123113;4924.60603151747;4799.352087468182;4861.295112208745;4899.632527560448;4932.901341973176;4988.201887697987;4827.61379089672;5127.282180494733;5148.897022059537;5162.5611822994715;5229.50319719626;5726.255586773693;5737.254156959611;5748.540116790647;5776.8844623107725;5779.653220806765;5701.486866182022;5808.361080281165;5879.176915231871;5904.586678932476;5961.433663801932;5423.2949716537;5428.809991650273;5429.918551221735;5432.2123292122815;5438.510534051954;5763.337216220189;5864.413558644187;5867.266591676041;5884.08796636522;5885.676287804212;5686.545076393879;5752.568557358215;5787.218725472091;5800.274965629296;5869.031609784338;5803.47768700819;5813.418658134237;5815.098659707752;5826;5833.79581714638;5642.322921249476;5732.3407808101765;5790.739416726257;5794.681292528951;5807.767689292466;5699.74351154199;5705.74324155414;5705.885882282331;5718.428157184331;5730.169125476783;4447.644188464915;4459;4475.462944446622;4485.730856148642;4517.028838799608;3993.101552150801;3993.940090898639;3995.6403923647013;4007.6994225432627;4031.637152656275;5321.909008653217;5393.13709806437;5403.486668766461;5433.130699088127;5486.945130548644;5781.335146458211;5783.652980821164;5788.392218817048;5809.88380232393;5816.098504731774;5378.946210537844;5382.569394448435;5388.973055134699;5402.540784033401;5405.7567409466665;4828.517148285144;4900.828471003498;4905.3623029006;4931.728754918514;4938.604911607063;6040.7885724000325;6056.394360563996;6084.4828189603495;6088.995315772936;6099.603525770811;5824.330202026652;5872.1778950946045;5873.94126058751;5879.470847623735;5882.647041177543;5873.442023007808;5970.791022314372;6002.159697642421;6074.210352654127;6102.420270074336;5699.715014249188;5706.686132262599;5709.115087161496;5710.8001219957105;5711.171880077282;5754.769809207753;5767.048437007847;5767.682777447113;5779.190913272229;5785;5494.80768173112;5548.4174161712435;5665.405132461197;5679.091345384719;5740.483356497935;5600.0759874620235;5638.577106716931;5683.261176047087;5687.77248910039;5706.657600543981;5448.318960129984;5536.086545719912;5584.692841893735;5601.775928962796;5617.438256174513;5577.8047768327915;5654.745536450787;5733.885322293448;5742.971285143548;5772.9031484017905;5559.583031272751;5606.803761868315;5619.409961954099;5622.212890195294;5635.042042852643 04:24:36 INFO - PROCESS | 4088 | |1;ext.html;545.6480570032329;566.4392251670847;580.3094317761866;601.5007543738695;608.1121562518722;37415.06462338443;38192.80903595485;38238.235235295346;38347;38387.84836454907;39130;39170.21659566807;39552;39595.20809583814;39696.80151599238;8304.91695083049;8504.532250726208;8526.74419767408;8529.317654587649;8540.402171847973;8267.586620668942;8297.83404331913;8372.03721572021;8387.370947178955;8405.41162118652;8325.209105135002;8380.20388063133;8427.325813934902;8440.28257598105;8442.15578442157;8316.293115085226;8349.874751878726;8377.62300696464;8381.539015354183;8387.62255698492;8140.511569305861;8280.420370574062;8304.211099945496;8335.791605209857;8344.958275208646;35256.29487410237;35653.3260005498;35814.34413526225;35962.640373596194;36007.4598881017;3353.9832300838584;3456;3671.320805650963;3944.7041471889725;3979.9403008954887;29253.70746292531;29483.410331793457;29499;30508.54237186444;32075.198120046953;3761.9059523511855;3814.8664796731982;3815.187785801722;3816.503854498925;3961.6632586230203;256944;261586;262126.75746485154;262493;263150;53859.73070134624;54642.72678636581;60870.91290870966;61146;61514;63657.315981821244;64464.35535644677;64692.353076469575;65023.67488162623;65032;14840.703185936221;14969.925150374178;15062.774058388914;15076.246187690791;15078.095314281178;11303.321800691985;11324.773504529863;11387.601433949772;11398.772024559463;11409.372484513431;19248.63734156131;19403.223871045284;19697.40907772769;20249.39251822448;20428.795712042986;8007.199280072063;8204;8263.091059983397;8289.171082891662;8302.335813134934;986.413084214891;1035.5961175141701;1057.1489950589848;1059.3961441978154;1111.766529028913;27974.160775176777;28065.71934280672;28192.8590357051;28519.429611407657;29553;1022.4376592874038;1033.813913495563;1062.028244156588;1083.4366129612558;1111.0445017285128;13805.654858628413;13956.371963261678;14107.647308817157;14145.292735363191;14168.362423690958;381563;382084;383368;383867;384179;50684.493155067976;50932;51226.23160652593;51345.229821552704;51394.74302628463;1341.496938648007;1346.5556366399064;1354.1874875075073;1357.5045108535314;1359.9116057456233;25078.874605626854;25986.61020084738;26103.216903492925;26145.73854261433;26203.60694589621;41002.38496422496;41577;41755.58244417638;41936.790316048224;42036.789816050725;288698;290035;291034;291742;291816;31126.22184445407;41677.37483937804;42317.36523952082;42558.93602659834;43438;37012;37961.240775184895;38586;41498.79250603728;42260.36609450799;35416.635419635095;35450.29099417946;35759.64240357563;36408.81795591005;36812.63187368092;35795.10512237215;35832;37633.43549846809;40955.38566921558;42429;34837.65162348344;35167.47248791219;35185.296294074484;35494.822525887204;35559.288814224084;31667.36665266728;32662.34675306528;32694.673053270115;32976.67023329832;33193.17017074592;24563.508729825662;25259.87370063138;25286.39866694386;25514.74485255198;25572.616410753482 04:24:36 INFO - PROCESS | 4088 | |2;jquery.html;353.4027493535924;355.69054922217674;362.7007718632128;364.1242811039451;368.5687745337954;15437.6140596485;15953.521394358173;16382;16923.238454269558;17094.743578846297;10761.192910531703;10799.946000270007;10844.403557804317;12318.753624927496;15681.29434175462;4787.114383839001;4982.551570358667;5004.599632029447;5516.227728118067;5547.417521160281;5408.215808707735;5431.592630552705;5525.889482210353;5527.198556209347;5539.224508568804;4923.704577725348;4953.430355509108;5058.645894787366;5237.45006774289;5285.841424757264;5192.454792246816;5193.714345710965;5218.921716174261;5491.121420572689;5996.280446346466;5284.9207261890715;5317.41508434072;5337.4662533746705;5344.973275133639;5352.170413585901;13557.864421355858;18944.336948206746;19675.31136410233;19752.901235493875;19783.7032444512;2183.967240491394;2209.834262430324;2289.713785776778;2301.8618882866913;2333.171724037959;9135.634574617074;9194.586243618985;9212.447253164764;9243.722688319362;9568.521573921276;1768.619746754454;1810.2306519729193;1824.4709034380014;1840.355875443584;1858.7397764313007;50815.491845081444;53191;54180.72909635466;56024.159637605466;57202;9129.311077450693;9535.189508891823;9729.97835227305;9742.366746161477;9849.950750246202;12626.621201363974;12659;12679.556215532411;12683.746325073631;12714.809277860839;7148.535345202546;7177.102862142232;7178.38983686382;7233.45749068822;7372.594507302043;6909.654517274116;6977.232504424509;7068.681909314093;7246.60143692102;7296.051513303237;4317.762523061199;4348.847790327323;4366.934495982563;4436.534163912807;4485.955140448619;1728.075479618398;1744.284843214276;1792.803815326215;1794.7257447212364;1805.7923338816204;894.7360528643935;915.5696822493418;926.249737712455;929.6142101027998;1032.9535170917327;15840.841591583936;16452.259648315856;16777;16871.240794164045;16973.49079527616;888.493558671551;964.1804466203811;1025.2980053111798;1038.8389799581078;1047.5809676129609;9213.815723685622;9525.476098814632;9608.2793790466;9636.277279204087;9779;373151;378304;379100;501441;505429;44834.55165448369;58050.419495804505;61158.69420652957;63914;72197;1100.3947828694347;1118.59730497021;1131.1572878205625;1157.5427706056062;1208.873068327813;14232.430702771773;14238.715225695221;14367.28163591837;14655.047421917541;14669;31572;31657.36685266236;32641.18397040093;32747;33489.497657534666;40376;41811.37282940819;43103.19829211217;43785.78107109444;43865.34201986909;4039.656629186552;5052.484254723642;7236.855262894607;7389.371903388273;7655.5023923447025;11619.6514104577;11630.53477860876;11666.941665291619;11684.298942063504;11956.46195921203;9186.40288381253;9546.236301095756;9882.802343953224;9971.202303815533;9997.100260976547;9577.904220957702;9601.855972160563;9757.853632195382;10138.847917281098;10631.787364252517;9051.498877646067;9422.670206542738;9656.227501799698;9719.465429401167;10249.897501024894;7053.964730176316;7247.710091596277;7266.527675701062;7280.089988751406;7297.489175757646;8069.515829050276;9609.519524023632;9651.565679544297;9758.707238782848;9813.9018609813 04:24:36 INFO - PROCESS | 4088 | |3;mootools.html;1434.8206474190729;1470.6102882736072;1623.5778697538644;1748.676494848453;1762.2246211666857;7811.375089992801;7842.52944823311;7996.160403157672;8019.599020049003;8041.437099403044;7982.441229113964;7984.92015079849;8007.479513831597;8067.757967260992;8125.91874081259;2262.5022495051103;2268.9092436302526;2286.6570014497793;2286.7598902115287;2288.107638021173;2315.386422598013;2330;2375.3824005758543;2376.0733314007553;2390.127603424755;2307.4231442139467;2308.145985985188;2323.372689373868;2344.2498400511845;2346.1319311854636;2149.946251343721;2247.123621787496;2247.9775202248097;2251.3358559225067;2259.1302348595746;2323.2449453927543;2342.5197834443898;2345.82406319525;2360.280114565057;2373.1219448804054;7846.725364612268;7856.685732570691;7856.978592782959;7877.172896845863;7902.209779022051;4736.360591320196;4846.684965477232;4850.442199147073;4860.8055677772845;4865;3169.762267829899;3208.4385232584436;3221.548983142362;3252.0569034980062;3263.216827961296;1005.6580762540772;1009.4145395670494;1009.5002973528077;1034.3948789957808;1041.7187359412992;10769.138468922467;10787.676369708843;10834.133269338434;10841.999999999922;10938.12495000406;4064.5122585289955;4203.768792716369;4215.578442155821;4219.78901054946;4240.575942405735;8748.47509149453;8776.341774366949;8785.472871627722;8856.38005339633;8878.73363799087;4709.81160753566;4716.056788642285;4739.289106634033;4750.904981900412;4770.403699537558;4367.323064924942;4375.78121093944;4384.495782984997;4386.736795792199;4394.494633117232;3649.927001459956;3654.5979942206336;3661.9633803662155;3669.211119609297;3694.5935947045805;1086.1853609792656;1094.217634391398;1100.9284396514201;1123.8988491035846;1129.4578602270956;1052.6368402900987;1063.6702622187147;1066.36018388966;1199.5681554640323;1291.14139097501;7410.147832999274;7416.221296763762;7451.180370159278;7457.701691932262;7495.737649182252;1058.8517607534952;1088.891215579525;1096.5065720425841;1102.3551222534747;1116.4361997191365;5852.502537284378;5905.734241959122;5923.792667256712;5935.109733540004;5936;9200.861987070199;9353.719388418222;9665.951670241604;9721.70834874955;9723.270754693427;9503.28725345602;9603.087706667855;9645.662401815904;9653.855192172123;9661.758456038655;7252.673629686677;7439.590822504706;7449.8882516761205;7472.887906681404;7551.5846628434865;7439.070116235471;7451.888221676788;7525.435592330487;7546.66040028189;7550.056242969629;8504.149585041447;8701.086385929639;8751.693690720795;8792.912070879465;8853.778655533406;8827;8860.246879015356;8864.512451815212;8906.153915378029;9073.954630226806;7237.565746055254;7325.377342925698;7371.705131794668;7379.483436159418;7387.482876198615;7688.154303026775;7786.805329866798;7787.883181752165;7824.64789084504;7829.647665854936;7469.253074692705;7493.213212612597;7517.398608111447;7673.693052277847;7720;6412.454941329853;6562.8359291018105;6881.13985751781;7024.964875175591;7158.3557479824985;7008.159020917318;7033.824154396181;7094.929050709633;7128.465365097535;7160.462965277521;6416.903746443901;6441.1626488556185;6446.839568877647;6459.741610335534;6461.256955450183;6430.710618022106;6504.317046710027;6524.151860258136;6539.803805885831;6544.28012918569 04:24:36 INFO - PROCESS | 4088 | |4;prototype.html;319.4696803306511;329.2312450428249;344.65190157940475;352.66496828013396;358.0761634981747;6155.230596175478;6274.341194174614;6289.245290565127;6292.905606415901;6355.52333574982;6057;6240.5943613665195;6240.84397890053;6266.122742816009;6266.467350275232;4753.429588449374;4779.307000484928;4812.398450193726;4820.349252850855;4821.915069109448;4800.063987522434;4805.183118869801;4814.927776083362;4819.301201325806;4822.445418776833;4679.08757792229;4750.7149571025675;4755.524447555252;4767.42790865095;4784.1866882629865;4719.386479757643;4756.66703330767;4761.047790441891;4769.761511924425;4788.545088216614;4178.6448151907125;4189.162167566468;4195.979020104911;4208.810603522818;4222.725522841006;5896.97051514744;5900.970495147497;5922.733476993546;5958.523318134538;5961.672108034057;5468.562514998791;5526.198701188305;5533.335999680024;5551.361593416768;5568.49883510486;6578.93421065788;6613.239477460057;6621.867562648768;6626.370494802986;6626.635535045571;4650.4186976627925;4663.556962088596;4663.720176789404;4667.95332046682;4675.064987002613;6816.9318306816795;6982.406495447893;6982.476314276399;6990.6155161466095;6995.335443132945;4757.09615173116;4761.95238047622;4765.833195838199;4784.569388755029;4807.158747219222;4807;4835.984443266883;4843.612510999112;4847.321375007502;4848.515148485194;5524.116141417434;5538.723063846792;5540.113581826889;5559.416261292587;5570.359408668055;6549.6070235786;6679.131712877295;6687.899681504781;6695.866082678319;6739.258681545026;1638.2054703468807;1680.8655307575364;1683.75585540096;1688.839560241775;1700.1499250374814;1108.141190577309;1117.3463523838645;1124.173732306754;1124.5670416889393;1136.6419577832955;6206.348333425016;6264.248290205204;6266.24545127365;6269.5611307208055;6271.905921411182;6786.287439818847;6789.762358317435;6793.388595026471;6811.727530898807;6814.659267036628;6073.39266073398;6218.284897236876;6274.278457977391;6279.120923070774;6280.340564240781;3673.577538583097;3674.4855720199193;3680.466332381843;3691.335559599298;3694.2980833641523;7037.331453511908;7093.467989900778;7124.536905101256;7133.251008644122;7134.964325178341;6915.654217289115;6916.377526022581;6935;6961.895571566431;6976.058232138698;7269.3094156055095;7324.560526368435;7336.853262934711;7351.411887049023;7363.815904602321;6927.965360173167;6928.579641173648;6929.896051559332;6966.686499107654;6986.580805151707;6756.662166891734;6814.8637027260165;6844.5208835381045;6860;6893.310668933066;7274.236205198589;7297.343239108506;7301.233370496234;7317.15852676949;7321.890171647323;4651.697639653412;4676.1115388077515;4685.6017238535105;4710.6231501479115;4711.882202944954;6835.521513494008;6888.793336199922;6930.480213984072;6946.44428445713;6958;6719.395254427125;6753.0883330751685;6757.695903684445;6760.93239067603;6777.525573209828;6772.153480814898;6778.152730908637;6778.525503214925;6782.69477873487;6788.25329213796;6470.029495575702;6607;6624.503162262753;6624.6025238485845;6657;6660.866782664222;6733.6296503692765;6739.8542247817;6775.288594697683;6796.422304104207;6552.934470655233;6556.377144171296;6565.310642382481;6568.244651865097;6570.441512471493 04:24:36 INFO - PROCESS | 4088 | |5;yui.html;767.4167632599223;769.9067324399352;809.5021561739532;851.8424091543066;856.0754385263915;13864.445422183113;13902.443902243924;14070.296485175739;14137.222452765094;14174.503892363782;12952.093353465261;12980.54568090117;12990.610281691565;12999.935000324986;13041;808.3492788305397;812.078291139555;825.5500752090126;826.6652005937605;827.9710210142646;803.8593246181895;815.9918400815975;821.080389963242;830.0495932157676;835.8871552340447;836.7113345895656;853.3429259470204;853.8804567360575;858.29619711836;861.5821326656597;829.7593697827623;845.121074082953;852.6845067325067;854.8931383577053;858.9398742088088;626.4268194601934;631.5579094633774;631.958922670025;632.0361448790585;633.4742164003866;13721.794173087412;13805.585832425044;13877.097988630807;13887.097338672955;13903.443862245498;12383.318917459535;12541.561045363369;12579.245245285312;12611.432485538173;12798.808017879739;9592.90407095927;9702.12680858719;9724.951375243149;9799.706008819676;10116.645917392856;3574.410222313315;3613.837377318027;3620.2035552178477;3633.909152271214;3682.723795715305;45317.77341113273;45718.54281457176;45843.54156458459;45943.081138377376;46032;9594.376365536218;9865.605375784888;9911.504424778732;10067.244956628283;10166.796664066676;17304.913475432542;17445.563860903578;17447.47657570275;17468.388606398716;17496.387626433014;7447.255274472618;7564.735234266775;7586.468947173645;7624.351930086005;7676.57778822159;4238.766867822299;4275.8075886585175;4314.374415709767;4340.804663790137;4366.912661746747;3162.794418362799;3167.3506931079073;3182.172635114887;3186.522021696764;3187.6971687689634;577.6938222741953;584.3309410724696;591.9644821310735;597.6832278892194;606.9136246119485;511.29951965807084;562.521856422038;566.3911295357507;590.9793157239476;616.6731632234922;7781.688732450752;7864.21357864209;7936.563489008045;8074.919250807417;8133.877991830127;630.6815058395481;631.8451979265018;641.5188608543592;656.0913135307634;659.8383396067994;3699;3832.1952389997855;3833.4058220975794;3920.17676287977;3995.5205375355144;53386.19920701192;54250.72874635681;54334;54414.727926360116;54853.177202342;47634.285485717744;48353.758231208616;48424.757876210395;50252.49747502478;50829.23756143661;42635.36046959298;42850.57149428466;43734;44694;48889.755551222726;7822.843543129219;7912.497322820444;7973.880391794244;8068.757937261891;8465.28045116172;32438.675613243566;32557.674423255463;33031.33937321288;33180;33187;40551.59448405596;40826.38760418655;42173.578264216965;42178.578214218694;43616.34575481307;10615.256932014685;10788.568457261621;11104.389258590854;11129.721756956142;11231.38227397501;12242.693932651398;12382.938085309515;12557.560485382968;12590.496380145058;12933.547325843927;10124.291299608956;10519.526621302213;10594.576216951236;10609.522571484456;10981.286216395909;11185.552577896793;11383.943080284545;11427.428628568372;11537.538498459968;11757.941210293893;10944.781104378028;10998.505067272152;11008.339499629727;11031.117510599293;11469.655910322703;8706.825863482822;8735.606897689746;8745.256653184551;8765.474071555727;8884.644614215358;8083.9191608083165;8121.918780812116;8153.1846815317995;8244.938765308672;9148.908510914805 04:24:36 INFO - PROCESS | 4088 | __end_tp_report 04:24:36 INFO - PROCESS | 4088 | __start_cc_report 04:24:36 INFO - PROCESS | 4088 | _x_x_mozilla_cycle_collect,300 04:24:36 INFO - PROCESS | 4088 | __end_cc_report 04:24:36 INFO - PROCESS | 4088 | __startTimestamp1453897476840__endTimestamp 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | ------- Summary: start ------- 04:24:36 INFO - PROCESS | 4088 | Number of tests: 6 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#0] dojo.html Cycles:165 Average:5341.15 Median:5601.78 stddev:698.57 (12.5%) stddev-sans-first:680.94 04:24:36 INFO - PROCESS | 4088 | Values: 3237.6 3269.3 3303.6 3310.9 3317.7 5251.8 5331.4 5367.5 5408.7 5419.9 5292.0 5301.6 5352.0 5421.7 5440.9 4852.4 4888.7 4933.3 4939.4 5008.6 687.6 4848.6 4886.9 4892.4 4946.1 4851.0 4854.7 4859.2 4871.1 4893.0 4886.0 4902.4 4914.8 4924.0 4924.6 4799.4 4861.3 4899.6 4932.9 4988.2 4827.6 5127.3 5148.9 5162.6 5229.5 5726.3 5737.3 5748.5 5776.9 5779.7 5701.5 5808.4 5879.2 5904.6 5961.4 5423.3 5428.8 5429.9 5432.2 5438.5 5763.3 5864.4 5867.3 5884.1 5885.7 5686.5 5752.6 5787.2 5800.3 5869.0 5803.5 5813.4 5815.1 5826.0 5833.8 5642.3 5732.3 5790.7 5794.7 5807.8 5699.7 5705.7 5705.9 5718.4 5730.2 4447.6 4459.0 4475.5 4485.7 4517.0 3993.1 3993.9 3995.6 4007.7 4031.6 5321.9 5393.1 5403.5 5433.1 5486.9 5781.3 5783.7 5788.4 5809.9 5816.1 5378.9 5382.6 5389.0 5402.5 5405.8 4828.5 4900.8 4905.4 4931.7 4938.6 6040.8 6056.4 6084.5 6089.0 6099.6 5824.3 5872.2 5873.9 5879.5 5882.6 5873.4 5970.8 6002.2 6074.2 6102.4 5699.7 5706.7 5709.1 5710.8 5711.2 5754.8 5767.0 5767.7 5779.2 5785.0 5494.8 5548.4 5665.4 5679.1 5740.5 5600.1 5638.6 5683.3 5687.8 5706.7 5448.3 5536.1 5584.7 5601.8 5617.4 5577.8 5654.7 5733.9 5743.0 5772.9 5559.6 5606.8 5619.4 5622.2 5635.0 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#1] ext.html Cycles:180 Average:47713.37 Median:37213.53 stddev:82968.33 (223.0%) stddev-sans-first:83125.49 04:24:36 INFO - PROCESS | 4088 | Values: 545.6 566.4 580.3 601.5 608.1 37415.1 38192.8 38238.2 38347.0 38387.8 39130.0 39170.2 39552.0 39595.2 39696.8 8304.9 8504.5 8526.7 8529.3 8540.4 8267.6 8297.8 8372.0 8387.4 8405.4 8325.2 8380.2 8427.3 8440.3 8442.2 8316.3 8349.9 8377.6 8381.5 8387.6 8140.5 8280.4 8304.2 8335.8 8345.0 35256.3 35653.3 35814.3 35962.6 36007.5 3354.0 3456.0 3671.3 3944.7 3979.9 29253.7 29483.4 29499.0 30508.5 32075.2 3761.9 3814.9 3815.2 3816.5 3961.7 256944.0 261586.0 262126.8 262493.0 263150.0 53859.7 54642.7 60870.9 61146.0 61514.0 63657.3 64464.4 64692.4 65023.7 65032.0 14840.7 14969.9 15062.8 15076.2 15078.1 11303.3 11324.8 11387.6 11398.8 11409.4 19248.6 19403.2 19697.4 20249.4 20428.8 8007.2 8204.0 8263.1 8289.2 8302.3 986.4 1035.6 1057.1 1059.4 1111.8 27974.2 28065.7 28192.9 28519.4 29553.0 1022.4 1033.8 1062.0 1083.4 1111.0 13805.7 13956.4 14107.6 14145.3 14168.4 381563.0 382084.0 383368.0 383867.0 384179.0 50684.5 50932.0 51226.2 51345.2 51394.7 1341.5 1346.6 1354.2 1357.5 1359.9 25078.9 25986.6 26103.2 26145.7 26203.6 41002.4 41577.0 41755.6 41936.8 42036.8 288698.0 290035.0 291034.0 291742.0 291816.0 31126.2 41677.4 42317.4 42558.9 43438.0 37012.0 37961.2 38586.0 41498.8 42260.4 35416.6 35450.3 35759.6 36408.8 36812.6 35795.1 35832.0 37633.4 40955.4 42429.0 34837.7 35167.5 35185.3 35494.8 35559.3 31667.4 32662.3 32694.7 32976.7 33193.2 24563.5 25259.9 25286.4 25514.7 25572.6 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#2] jquery.html Cycles:180 Average:23724.25 Median:4993.58 stddev:70590.33 (1413.6%) stddev-sans-first:70766.54 04:24:36 INFO - PROCESS | 4088 | Values: 353.4 355.7 362.7 364.1 368.6 15437.6 15953.5 16382.0 16923.2 17094.7 10761.2 10799.9 10844.4 12318.8 15681.3 4787.1 4982.6 5004.6 5516.2 5547.4 5408.2 5431.6 5525.9 5527.2 5539.2 4923.7 4953.4 5058.6 5237.5 5285.8 5192.5 5193.7 5218.9 5491.1 5996.3 5284.9 5317.4 5337.5 5345.0 5352.2 13557.9 18944.3 19675.3 19752.9 19783.7 2184.0 2209.8 2289.7 2301.9 2333.2 9135.6 9194.6 9212.4 9243.7 9568.5 1768.6 1810.2 1824.5 1840.4 1858.7 50815.5 53191.0 54180.7 56024.2 57202.0 9129.3 9535.2 9730.0 9742.4 9850.0 12626.6 12659.0 12679.6 12683.7 12714.8 7148.5 7177.1 7178.4 7233.5 7372.6 6909.7 6977.2 7068.7 7246.6 7296.1 4317.8 4348.8 4366.9 4436.5 4486.0 1728.1 1744.3 1792.8 1794.7 1805.8 894.7 915.6 926.2 929.6 1033.0 15840.8 16452.3 16777.0 16871.2 16973.5 888.5 964.2 1025.3 1038.8 1047.6 9213.8 9525.5 9608.3 9636.3 9779.0 373151.0 378304.0 379100.0 501441.0 505429.0 44834.6 58050.4 61158.7 63914.0 72197.0 1100.4 1118.6 1131.2 1157.5 1208.9 14232.4 14238.7 14367.3 14655.0 14669.0 31572.0 31657.4 32641.2 32747.0 33489.5 40376.0 41811.4 43103.2 43785.8 43865.3 4039.7 5052.5 7236.9 7389.4 7655.5 11619.7 11630.5 11666.9 11684.3 11956.5 9186.4 9546.2 9882.8 9971.2 9997.1 9577.9 9601.9 9757.9 10138.8 10631.8 9051.5 9422.7 9656.2 9719.5 10249.9 7054.0 7247.7 7266.5 7280.1 7297.5 8069.5 9609.5 9651.6 9758.7 9813.9 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#3] mootools.html Cycles:180 Average:5573.12 Median:6414.68 stddev:2894.03 (45.1%) stddev-sans-first:2885.43 04:24:36 INFO - PROCESS | 4088 | Values: 1434.8 1470.6 1623.6 1748.7 1762.2 7811.4 7842.5 7996.2 8019.6 8041.4 7982.4 7984.9 8007.5 8067.8 8125.9 2262.5 2268.9 2286.7 2286.8 2288.1 2315.4 2330.0 2375.4 2376.1 2390.1 2307.4 2308.1 2323.4 2344.2 2346.1 2149.9 2247.1 2248.0 2251.3 2259.1 2323.2 2342.5 2345.8 2360.3 2373.1 7846.7 7856.7 7857.0 7877.2 7902.2 4736.4 4846.7 4850.4 4860.8 4865.0 3169.8 3208.4 3221.5 3252.1 3263.2 1005.7 1009.4 1009.5 1034.4 1041.7 10769.1 10787.7 10834.1 10842.0 10938.1 4064.5 4203.8 4215.6 4219.8 4240.6 8748.5 8776.3 8785.5 8856.4 8878.7 4709.8 4716.1 4739.3 4750.9 4770.4 4367.3 4375.8 4384.5 4386.7 4394.5 3649.9 3654.6 3662.0 3669.2 3694.6 1086.2 1094.2 1100.9 1123.9 1129.5 1052.6 1063.7 1066.4 1199.6 1291.1 7410.1 7416.2 7451.2 7457.7 7495.7 1058.9 1088.9 1096.5 1102.4 1116.4 5852.5 5905.7 5923.8 5935.1 5936.0 9200.9 9353.7 9666.0 9721.7 9723.3 9503.3 9603.1 9645.7 9653.9 9661.8 7252.7 7439.6 7449.9 7472.9 7551.6 7439.1 7451.9 7525.4 7546.7 7550.1 8504.1 8701.1 8751.7 8792.9 8853.8 8827.0 8860.2 8864.5 8906.2 9074.0 7237.6 7325.4 7371.7 7379.5 7387.5 7688.2 7786.8 7787.9 7824.6 7829.6 7469.3 7493.2 7517.4 7673.7 7720.0 6412.5 6562.8 6881.1 7025.0 7158.4 7008.2 7033.8 7094.9 7128.5 7160.5 6416.9 6441.2 6446.8 6459.7 6461.3 6430.7 6504.3 6524.2 6539.8 6544.3 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#4] prototype.html Cycles:180 Average:5581.03 Median:6268.01 stddev:1692.90 (27.0%) stddev-sans-first:1650.95 04:24:36 INFO - PROCESS | 4088 | Values: 319.5 329.2 344.7 352.7 358.1 6155.2 6274.3 6289.2 6292.9 6355.5 6057.0 6240.6 6240.8 6266.1 6266.5 4753.4 4779.3 4812.4 4820.3 4821.9 4800.1 4805.2 4814.9 4819.3 4822.4 4679.1 4750.7 4755.5 4767.4 4784.2 4719.4 4756.7 4761.0 4769.8 4788.5 4178.6 4189.2 4196.0 4208.8 4222.7 5897.0 5901.0 5922.7 5958.5 5961.7 5468.6 5526.2 5533.3 5551.4 5568.5 6578.9 6613.2 6621.9 6626.4 6626.6 4650.4 4663.6 4663.7 4668.0 4675.1 6816.9 6982.4 6982.5 6990.6 6995.3 4757.1 4762.0 4765.8 4784.6 4807.2 4807.0 4836.0 4843.6 4847.3 4848.5 5524.1 5538.7 5540.1 5559.4 5570.4 6549.6 6679.1 6687.9 6695.9 6739.3 1638.2 1680.9 1683.8 1688.8 1700.1 1108.1 1117.3 1124.2 1124.6 1136.6 6206.3 6264.2 6266.2 6269.6 6271.9 6786.3 6789.8 6793.4 6811.7 6814.7 6073.4 6218.3 6274.3 6279.1 6280.3 3673.6 3674.5 3680.5 3691.3 3694.3 7037.3 7093.5 7124.5 7133.3 7135.0 6915.7 6916.4 6935.0 6961.9 6976.1 7269.3 7324.6 7336.9 7351.4 7363.8 6928.0 6928.6 6929.9 6966.7 6986.6 6756.7 6814.9 6844.5 6860.0 6893.3 7274.2 7297.3 7301.2 7317.2 7321.9 4651.7 4676.1 4685.6 4710.6 4711.9 6835.5 6888.8 6930.5 6946.4 6958.0 6719.4 6753.1 6757.7 6760.9 6777.5 6772.2 6778.2 6778.5 6782.7 6788.3 6470.0 6607.0 6624.5 6624.6 6657.0 6660.9 6733.6 6739.9 6775.3 6796.4 6552.9 6556.4 6565.3 6568.2 6570.4 04:24:36 INFO - PROCESS | 4088 | 04:24:36 INFO - PROCESS | 4088 | [#5] yui.html Cycles:180 Average:13275.07 Median:45987.54 stddev:15119.63 (32.9%) stddev-sans-first:15132.87 04:24:36 INFO - PROCESS | 4088 | Values: 767.4 769.9 809.5 851.8 856.1 13864.4 13902.4 14070.3 14137.2 14174.5 12952.1 12980.5 12990.6 12999.9 13041.0 808.3 812.1 825.6 826.7 828.0 803.9 816.0 821.1 830.0 835.9 836.7 853.3 853.9 858.3 861.6 829.8 845.1 852.7 854.9 858.9 626.4 631.6 632.0 632.0 633.5 13721.8 13805.6 13877.1 13887.1 13903.4 12383.3 12541.6 12579.2 12611.4 12798.8 9592.9 9702.1 9725.0 9799.7 10116.6 3574.4 3613.8 3620.2 3633.9 3682.7 45317.8 45718.5 45843.5 45943.1 46032.0 9594.4 9865.6 9911.5 10067.2 10166.8 17304.9 17445.6 17447.5 17468.4 17496.4 7447.3 7564.7 7586.5 7624.4 7676.6 4238.8 4275.8 4314.4 4340.8 4366.9 3162.8 3167.4 3182.2 3186.5 3187.7 577.7 584.3 592.0 597.7 606.9 511.3 562.5 566.4 591.0 616.7 7781.7 7864.2 7936.6 8074.9 8133.9 630.7 631.8 641.5 656.1 659.8 3699.0 3832.2 3833.4 3920.2 3995.5 53386.2 54250.7 54334.0 54414.7 54853.2 47634.3 48353.8 48424.8 50252.5 50829.2 42635.4 42850.6 43734.0 44694.0 48889.8 7822.8 7912.5 7973.9 8068.8 8465.3 32438.7 32557.7 33031.3 33180.0 33187.0 40551.6 40826.4 42173.6 42178.6 43616.3 10615.3 10788.6 11104.4 11129.7 11231.4 12242.7 12382.9 12557.6 12590.5 12933.5 10124.3 10519.5 10594.6 10609.5 10981.3 11185.6 11383.9 11427.4 11537.5 11757.9 10944.8 10998.5 11008.3 11031.1 11469.7 8706.8 8735.6 8745.3 8765.5 8884.6 8083.9 8121.9 8153.2 8244.9 9148.9 04:24:36 INFO - PROCESS | 4088 | -------- Summary: end -------- 04:24:36 INFO - PROCESS | 4088 | 04:24:37 INFO - TEST-INFO | 4088: exit 0 04:24:37 INFO - TEST-OK | dromaeo_css | took 1111498ms 04:24:37 INFO - TEST-START | kraken 04:24:37 INFO - operating with platform_type : linux_ 04:24:37 INFO - Initialising browser for kraken test... 04:24:37 INFO - TEST-INFO | started process 4333 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBrOOXr/profile http://localhost:35663/getInfo.html) 04:24:41 INFO - PROCESS | 4333 | 04:24:41 INFO - PROCESS | 4333 | (process:4407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:24:41 INFO - PROCESS | 4333 | __metrics Screen width/height:1600/1200 04:24:41 INFO - PROCESS | 4333 | colorDepth:24 04:24:41 INFO - PROCESS | 4333 | Browser inner width/height: 1024/697 04:24:41 INFO - PROCESS | 4333 | __metrics 04:24:41 INFO - PROCESS | 4333 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:24:42 INFO - TEST-INFO | 4333: exit 0 04:24:42 INFO - Browser initialized. 04:24:42 INFO - Running cycle 1/1 for kraken test... 04:24:42 INFO - TEST-INFO | started process 4456 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBrOOXr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:44 INFO - PROCESS | 4456 | 04:24:44 INFO - PROCESS | 4456 | (process:4512): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:24:54 INFO - PROCESS | 4456 | RSS: Main: 150740992 04:24:54 INFO - PROCESS | 4456 | 04:24:57 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35663/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:57 INFO - PROCESS | 4456 | RSS: Main: 155115520 04:24:57 INFO - PROCESS | 4456 | 04:25:00 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35663/tests/kraken/driver.html?testName=audio-dft) 04:25:01 INFO - PROCESS | 4456 | RSS: Main: 158429184 04:25:01 INFO - PROCESS | 4456 | 04:25:03 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35663/tests/kraken/driver.html?testName=audio-fft) 04:25:04 INFO - PROCESS | 4456 | RSS: Main: 151855104 04:25:04 INFO - PROCESS | 4456 | 04:25:06 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35663/tests/kraken/driver.html?testName=audio-oscillator) 04:25:07 INFO - PROCESS | 4456 | RSS: Main: 153268224 04:25:07 INFO - PROCESS | 4456 | 04:25:09 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35663/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:10 INFO - PROCESS | 4456 | RSS: Main: 153538560 04:25:10 INFO - PROCESS | 4456 | 04:25:13 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35663/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:13 INFO - PROCESS | 4456 | RSS: Main: 153649152 04:25:13 INFO - PROCESS | 4456 | 04:25:17 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35663/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:17 INFO - PROCESS | 4456 | RSS: Main: 153931776 04:25:17 INFO - PROCESS | 4456 | 04:25:20 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35663/tests/kraken/driver.html?testName=json-parse-financial) 04:25:21 INFO - PROCESS | 4456 | RSS: Main: 153690112 04:25:21 INFO - PROCESS | 4456 | 04:25:22 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35663/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:23 INFO - PROCESS | 4456 | RSS: Main: 154148864 04:25:23 INFO - PROCESS | 4456 | 04:25:25 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:25 INFO - PROCESS | 4456 | RSS: Main: 155009024 04:25:25 INFO - PROCESS | 4456 | 04:25:27 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:28 INFO - PROCESS | 4456 | RSS: Main: 154750976 04:25:28 INFO - PROCESS | 4456 | 04:25:30 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:31 INFO - PROCESS | 4456 | RSS: Main: 155025408 04:25:31 INFO - PROCESS | 4456 | 04:25:34 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:34 INFO - PROCESS | 4456 | RSS: Main: 155635712 04:25:34 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | Cycle 1(1): loaded http://localhost:35663/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35663/tests/kraken/driver.html?testName=ai-astar) 04:25:36 INFO - PROCESS | 4456 | RSS: Main: 155668480 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | __start_tp_report 04:25:36 INFO - PROCESS | 4456 | _x_x_mozilla_page_load 04:25:36 INFO - PROCESS | 4456 | _x_x_mozilla_page_load_details 04:25:36 INFO - PROCESS | 4456 | |i|pagename|runs| 04:25:36 INFO - PROCESS | 4456 | |0;ai-astar;114;109;113;113;112;123;111;111;110;111 04:25:36 INFO - PROCESS | 4456 | |1;audio-beat-detection;156;128;153;163;135;161;165;144;163;128 04:25:36 INFO - PROCESS | 4456 | |2;audio-dft;165;162;161;163;162;162;161;167;166;161 04:25:36 INFO - PROCESS | 4456 | |3;audio-fft;78;77;73;76;74;131;73;76;74;72 04:25:36 INFO - PROCESS | 4456 | |4;audio-oscillator;95;95;138;95;95;95;136;95;97;135 04:25:36 INFO - PROCESS | 4456 | |5;imaging-gaussian-blur;120;115;115;115;114;116;116;116;115;116 04:25:36 INFO - PROCESS | 4456 | |6;imaging-darkroom;147;147;146;147;146;147;147;148;146;146 04:25:36 INFO - PROCESS | 4456 | |7;imaging-desaturate;97;97;96;98;96;97;96;96;97;97 04:25:36 INFO - PROCESS | 4456 | |8;json-parse-financial;62;60;60;59;63;61;61;63;69;58 04:25:36 INFO - PROCESS | 4456 | |9;json-stringify-tinderbox;67;67;67;67;68;68;68;69;69;69 04:25:36 INFO - PROCESS | 4456 | |10;stanford-crypto-aes;82;80;83;82;83;85;84;83;83;83 04:25:36 INFO - PROCESS | 4456 | |11;stanford-crypto-ccm;116;123;115;124;115;120;132;121;124;120 04:25:36 INFO - PROCESS | 4456 | |12;stanford-crypto-pbkdf2;132;145;146;148;146;137;135;143;150;128 04:25:36 INFO - PROCESS | 4456 | |13;stanford-crypto-sha256-iterative;78;67;69;69;70;67;68;68;71;67 04:25:36 INFO - PROCESS | 4456 | __end_tp_report 04:25:36 INFO - PROCESS | 4456 | __start_cc_report 04:25:36 INFO - PROCESS | 4456 | _x_x_mozilla_cycle_collect,746 04:25:36 INFO - PROCESS | 4456 | __end_cc_report 04:25:36 INFO - PROCESS | 4456 | __startTimestamp1453897536585__endTimestamp 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | ------- Summary: start ------- 04:25:36 INFO - PROCESS | 4456 | Number of tests: 14 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:3.92 (3.5%) stddev-sans-first:4.13 04:25:36 INFO - PROCESS | 4456 | Values: 114.0 109.0 113.0 113.0 112.0 123.0 111.0 111.0 110.0 111.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:158.50 stddev:14.74 (9.3%) stddev-sans-first:15.46 04:25:36 INFO - PROCESS | 4456 | Values: 156.0 128.0 153.0 163.0 135.0 161.0 165.0 144.0 163.0 128.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.21 (1.4%) stddev-sans-first:2.22 04:25:36 INFO - PROCESS | 4456 | Values: 165.0 162.0 161.0 163.0 162.0 162.0 161.0 167.0 166.0 161.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:17.88 (23.8%) stddev-sans-first:18.95 04:25:36 INFO - PROCESS | 4456 | Values: 78.0 77.0 73.0 76.0 74.0 131.0 73.0 76.0 74.0 72.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:95.00 stddev:19.85 (20.9%) stddev-sans-first:20.52 04:25:36 INFO - PROCESS | 4456 | Values: 95.0 95.0 138.0 95.0 95.0 95.0 136.0 95.0 97.0 135.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:1.62 (1.4%) stddev-sans-first:0.71 04:25:36 INFO - PROCESS | 4456 | Values: 120.0 115.0 115.0 115.0 114.0 116.0 116.0 116.0 115.0 116.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:25:36 INFO - PROCESS | 4456 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:25:36 INFO - PROCESS | 4456 | Values: 97.0 97.0 96.0 98.0 96.0 97.0 96.0 96.0 97.0 97.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:3.06 (5.0%) stddev-sans-first:3.24 04:25:36 INFO - PROCESS | 4456 | Values: 62.0 60.0 60.0 59.0 63.0 61.0 61.0 63.0 69.0 58.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 04:25:36 INFO - PROCESS | 4456 | Values: 67.0 67.0 67.0 67.0 68.0 68.0 68.0 69.0 69.0 69.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.32 (1.6%) stddev-sans-first:1.36 04:25:36 INFO - PROCESS | 4456 | Values: 82.0 80.0 83.0 82.0 83.0 85.0 84.0 83.0 83.0 83.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.00 stddev:5.19 (4.3%) stddev-sans-first:5.17 04:25:36 INFO - PROCESS | 4456 | Values: 116.0 123.0 115.0 124.0 115.0 120.0 132.0 121.0 124.0 120.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:145.50 stddev:7.47 (5.1%) stddev-sans-first:7.18 04:25:36 INFO - PROCESS | 4456 | Values: 132.0 145.0 146.0 148.0 146.0 137.0 135.0 143.0 150.0 128.0 04:25:36 INFO - PROCESS | 4456 | 04:25:36 INFO - PROCESS | 4456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:3.31 (4.8%) stddev-sans-first:1.42 04:25:36 INFO - PROCESS | 4456 | Values: 78.0 67.0 69.0 69.0 70.0 67.0 68.0 68.0 71.0 67.0 04:25:36 INFO - PROCESS | 4456 | -------- Summary: end -------- 04:25:36 INFO - PROCESS | 4456 | 04:25:37 INFO - TEST-INFO | 4456: exit 0 04:25:37 INFO - TEST-OK | kraken | took 60027ms 04:25:37 INFO - TEST-START | v8_7 04:25:37 INFO - operating with platform_type : linux_ 04:25:37 INFO - Initialising browser for v8_7 test... 04:25:37 INFO - TEST-INFO | started process 4741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8e433u/profile http://localhost:35663/getInfo.html) 04:25:41 INFO - PROCESS | 4741 | 04:25:41 INFO - PROCESS | 4741 | (process:4813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:41 INFO - PROCESS | 4741 | __metrics Screen width/height:1600/1200 04:25:41 INFO - PROCESS | 4741 | colorDepth:24 04:25:41 INFO - PROCESS | 4741 | Browser inner width/height: 1024/697 04:25:41 INFO - PROCESS | 4741 | __metrics 04:25:42 INFO - PROCESS | 4741 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:42 INFO - TEST-INFO | 4741: exit 0 04:25:42 INFO - Browser initialized. 04:25:42 INFO - Running cycle 1/1 for v8_7 test... 04:25:42 INFO - TEST-INFO | started process 4862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8e433u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:44 INFO - PROCESS | 4862 | 04:25:44 INFO - PROCESS | 4862 | (process:4920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:54 INFO - PROCESS | 4862 | RSS: Main: 150745088 04:25:54 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | Cycle 1(1): loaded http://localhost:35663/tests/v8_7/run.html (next: http://localhost:35663/tests/v8_7/run.html) 04:26:17 INFO - PROCESS | 4862 | RSS: Main: 151031808 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | __start_tp_report 04:26:17 INFO - PROCESS | 4862 | _x_x_mozilla_page_load 04:26:17 INFO - PROCESS | 4862 | _x_x_mozilla_page_load_details 04:26:17 INFO - PROCESS | 4862 | |i|pagename|runs| 04:26:17 INFO - PROCESS | 4862 | |0;Richards;166.91704223001167 04:26:17 INFO - PROCESS | 4862 | |1;DeltaBlue;190.69412662090008 04:26:17 INFO - PROCESS | 4862 | |2;Encrypt;272.33115468409585 04:26:17 INFO - PROCESS | 4862 | |3;Decrypt;5268.421052631579 04:26:17 INFO - PROCESS | 4862 | |4;RayTrace;1061.5711252653928 04:26:17 INFO - PROCESS | 4862 | |5;Earley;722.0216606498195 04:26:17 INFO - PROCESS | 4862 | |6;Boyer;12550 04:26:17 INFO - PROCESS | 4862 | |7;RegExp;40019.60784313725 04:26:17 INFO - PROCESS | 4862 | |8;Splay;579.0387955993051 04:26:17 INFO - PROCESS | 4862 | |9;NavierStokes;4826.923076923077 04:26:17 INFO - PROCESS | 4862 | __end_tp_report 04:26:17 INFO - PROCESS | 4862 | __startTimestamp1453897577456__endTimestamp 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | ------- Summary: start ------- 04:26:17 INFO - PROCESS | 4862 | Number of tests: 10 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 166.9 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#1] DeltaBlue Cycles:1 Average:190.69 Median:190.69 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 190.7 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#2] Encrypt Cycles:1 Average:272.33 Median:272.33 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 272.3 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 5268.4 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 1061.6 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#5] Earley Cycles:1 Average:722.02 Median:722.02 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 722.0 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 12550.0 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#7] RegExp Cycles:1 Average:40019.61 Median:40019.61 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 40019.6 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#8] Splay Cycles:1 Average:579.04 Median:579.04 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 579.0 04:26:17 INFO - PROCESS | 4862 | 04:26:17 INFO - PROCESS | 4862 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:26:17 INFO - PROCESS | 4862 | Values: 4826.9 04:26:17 INFO - PROCESS | 4862 | -------- Summary: end -------- 04:26:17 INFO - PROCESS | 4862 | 04:26:18 INFO - TEST-INFO | 4862: exit 0 04:26:18 INFO - TEST-OK | v8_7 | took 40866ms 04:26:18 INFO - SUITE-END | took 1212s 04:26:18 INFO - Completed test suite (00:20:12) 04:26:18 INFO - Working with test: dromaeo_css 04:26:18 INFO - Generating results file: dromaeo_css 04:26:18 INFO - Working with test: kraken 04:26:18 INFO - Generating results file: kraken 04:26:18 INFO - javascript benchmark 04:26:18 INFO - Working with test: v8_7 04:26:18 INFO - Generating results file: v8_7 04:26:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:26:18 INFO - process_Request line: dromaeo_css 6913.71 graph.html#tests=[[72,63,43]] 04:26:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:18 INFO - process_Request line: kraken 1516.20 graph.html#tests=[[232,63,43]] 04:26:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:18 INFO - process_Request line: v8_7 20461.28 graph.html#tests=[[230,63,43]] 04:26:18 INFO - RETURN: dromaeo_css: 6913.71 04:26:18 INFO - RETURN: kraken: 1516.20 04:26:18 INFO - RETURN: v8_7: 20461.28 04:26:18 INFO - javascript benchmark 04:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3237.595300587426, 3269.3461307738444, 3303.554020207271, 3310.884119055832, 3317.6682331766824, 5251.763670634821, 5331.413544510106, 5367.543758780504, 5408.729563521818, 5419.891602167954, 5292.0, 5301.575873930076, 5351.973240133794, 5421.701806400646, 5440.891182176364, 4852.369192005034, 4888.682235654689, 4933.309336692866, 4939.382577177853, 5008.649394542384, 687.6494970225738, 4848.5636292733825, 4886.853394398156, 4892.3639926809465, 4946.134426475371, 4851.0, 4854.732989685584, 4859.173940430135, 4871.147549178915, 4893.04585605807, 4886.02279544089, 4902.436219834729, 4914.7788349524, 4923.975380123113, 4924.60603151747, 4799.352087468182, 4861.295112208745, 4899.632527560448, 4932.901341973176, 4988.201887697987, 4827.61379089672, 5127.282180494733, 5148.897022059537, 5162.5611822994715, 5229.50319719626, 5726.255586773693, 5737.254156959611, 5748.540116790647, 5776.8844623107725, 5779.653220806765, 5701.486866182022, 5808.361080281165, 5879.176915231871, 5904.586678932476, 5961.433663801932, 5423.2949716537, 5428.809991650273, 5429.918551221735, 5432.2123292122815, 5438.510534051954, 5763.337216220189, 5864.413558644187, 5867.266591676041, 5884.08796636522, 5885.676287804212, 5686.545076393879, 5752.568557358215, 5787.218725472091, 5800.274965629296, 5869.031609784338, 5803.47768700819, 5813.418658134237, 5815.098659707752, 5826.0, 5833.79581714638, 5642.322921249476, 5732.3407808101765, 5790.739416726257, 5794.681292528951, 5807.767689292466, 5699.74351154199, 5705.74324155414, 5705.885882282331, 5718.428157184331, 5730.169125476783, 4447.644188464915, 4459.0, 4475.462944446622, 4485.730856148642, 4517.028838799608, 3993.101552150801, 3993.940090898639, 3995.6403923647013, 4007.6994225432627, 4031.637152656275, 5321.909008653217, 5393.13709806437, 5403.486668766461, 5433.130699088127, 5486.945130548644, 5781.335146458211, 5783.652980821164, 5788.392218817048, 5809.88380232393, 5816.098504731774, 5378.946210537844, 5382.569394448435, 5388.973055134699, 5402.540784033401, 5405.7567409466665, 4828.517148285144, 4900.828471003498, 4905.3623029006, 4931.728754918514, 4938.604911607063, 6040.7885724000325, 6056.394360563996, 6084.4828189603495, 6088.995315772936, 6099.603525770811, 5824.330202026652, 5872.1778950946045, 5873.94126058751, 5879.470847623735, 5882.647041177543, 5873.442023007808, 5970.791022314372, 6002.159697642421, 6074.210352654127, 6102.420270074336, 5699.715014249188, 5706.686132262599, 5709.115087161496, 5710.8001219957105, 5711.171880077282, 5754.769809207753, 5767.048437007847, 5767.682777447113, 5779.190913272229, 5785.0, 5494.80768173112, 5548.4174161712435, 5665.405132461197, 5679.091345384719, 5740.483356497935, 5600.0759874620235, 5638.577106716931, 5683.261176047087, 5687.77248910039, 5706.657600543981, 5448.318960129984, 5536.086545719912, 5584.692841893735, 5601.775928962796, 5617.438256174513, 5577.8047768327915, 5654.745536450787, 5733.885322293448, 5742.971285143548, 5772.9031484017905, 5559.583031272751, 5606.803761868315, 5619.409961954099, 5622.212890195294, 5635.042042852643], "unit": "score", "name": "dojo.html", "value": 5298.049112025096}, {"lowerIsBetter": false, "replicates": [545.6480570032329, 566.4392251670847, 580.3094317761866, 601.5007543738695, 608.1121562518722, 37415.06462338443, 38192.80903595485, 38238.235235295346, 38347.0, 38387.84836454907, 39130.0, 39170.21659566807, 39552.0, 39595.20809583814, 39696.80151599238, 8304.91695083049, 8504.532250726208, 8526.74419767408, 8529.317654587649, 8540.402171847973, 8267.586620668942, 8297.83404331913, 8372.03721572021, 8387.370947178955, 8405.41162118652, 8325.209105135002, 8380.20388063133, 8427.325813934902, 8440.28257598105, 8442.15578442157, 8316.293115085226, 8349.874751878726, 8377.62300696464, 8381.539015354183, 8387.62255698492, 8140.511569305861, 8280.420370574062, 8304.211099945496, 8335.791605209857, 8344.958275208646, 35256.29487410237, 35653.3260005498, 35814.34413526225, 35962.640373596194, 36007.4598881017, 3353.9832300838584, 3456.0, 3671.320805650963, 3944.7041471889725, 3979.9403008954887, 29253.70746292531, 29483.410331793457, 29499.0, 30508.54237186444, 32075.198120046953, 3761.9059523511855, 3814.8664796731982, 3815.187785801722, 3816.503854498925, 3961.6632586230203, 256944.0, 261586.0, 262126.75746485154, 262493.0, 263150.0, 53859.73070134624, 54642.72678636581, 60870.91290870966, 61146.0, 61514.0, 63657.315981821244, 64464.35535644677, 64692.353076469575, 65023.67488162623, 65032.0, 14840.703185936221, 14969.925150374178, 15062.774058388914, 15076.246187690791, 15078.095314281178, 11303.321800691985, 11324.773504529863, 11387.601433949772, 11398.772024559463, 11409.372484513431, 19248.63734156131, 19403.223871045284, 19697.40907772769, 20249.39251822448, 20428.795712042986, 8007.199280072063, 8204.0, 8263.091059983397, 8289.171082891662, 8302.335813134934, 986.413084214891, 1035.5961175141701, 1057.1489950589848, 1059.3961441978154, 1111.766529028913, 27974.160775176777, 28065.71934280672, 28192.8590357051, 28519.429611407657, 29553.0, 1022.4376592874038, 1033.813913495563, 1062.028244156588, 1083.4366129612558, 1111.0445017285128, 13805.654858628413, 13956.371963261678, 14107.647308817157, 14145.292735363191, 14168.362423690958, 381563.0, 382084.0, 383368.0, 383867.0, 384179.0, 50684.493155067976, 50932.0, 51226.23160652593, 51345.229821552704, 51394.74302628463, 1341.496938648007, 1346.5556366399064, 1354.1874875075073, 1357.5045108535314, 1359.9116057456233, 25078.874605626854, 25986.61020084738, 26103.216903492925, 26145.73854261433, 26203.60694589621, 41002.38496422496, 41577.0, 41755.58244417638, 41936.790316048224, 42036.789816050725, 288698.0, 290035.0, 291034.0, 291742.0, 291816.0, 31126.22184445407, 41677.37483937804, 42317.36523952082, 42558.93602659834, 43438.0, 37012.0, 37961.240775184895, 38586.0, 41498.79250603728, 42260.36609450799, 35416.635419635095, 35450.29099417946, 35759.64240357563, 36408.81795591005, 36812.63187368092, 35795.10512237215, 35832.0, 37633.43549846809, 40955.38566921558, 42429.0, 34837.65162348344, 35167.47248791219, 35185.296294074484, 35494.822525887204, 35559.288814224084, 31667.36665266728, 32662.34675306528, 32694.673053270115, 32976.67023329832, 33193.17017074592, 24563.508729825662, 25259.87370063138, 25286.39866694386, 25514.74485255198, 25572.616410753482], "unit": "score", "name": "ext.html", "value": 18419.502516094268}, {"lowerIsBetter": false, "replicates": [353.4027493535924, 355.69054922217674, 362.7007718632128, 364.1242811039451, 368.5687745337954, 15437.6140596485, 15953.521394358173, 16382.0, 16923.238454269558, 17094.743578846297, 10761.192910531703, 10799.946000270007, 10844.403557804317, 12318.753624927496, 15681.29434175462, 4787.114383839001, 4982.551570358667, 5004.599632029447, 5516.227728118067, 5547.417521160281, 5408.215808707735, 5431.592630552705, 5525.889482210353, 5527.198556209347, 5539.224508568804, 4923.704577725348, 4953.430355509108, 5058.645894787366, 5237.45006774289, 5285.841424757264, 5192.454792246816, 5193.714345710965, 5218.921716174261, 5491.121420572689, 5996.280446346466, 5284.9207261890715, 5317.41508434072, 5337.4662533746705, 5344.973275133639, 5352.170413585901, 13557.864421355858, 18944.336948206746, 19675.31136410233, 19752.901235493875, 19783.7032444512, 2183.967240491394, 2209.834262430324, 2289.713785776778, 2301.8618882866913, 2333.171724037959, 9135.634574617074, 9194.586243618985, 9212.447253164764, 9243.722688319362, 9568.521573921276, 1768.619746754454, 1810.2306519729193, 1824.4709034380014, 1840.355875443584, 1858.7397764313007, 50815.491845081444, 53191.0, 54180.72909635466, 56024.159637605466, 57202.0, 9129.311077450693, 9535.189508891823, 9729.97835227305, 9742.366746161477, 9849.950750246202, 12626.621201363974, 12659.0, 12679.556215532411, 12683.746325073631, 12714.809277860839, 7148.535345202546, 7177.102862142232, 7178.38983686382, 7233.45749068822, 7372.594507302043, 6909.654517274116, 6977.232504424509, 7068.681909314093, 7246.60143692102, 7296.051513303237, 4317.762523061199, 4348.847790327323, 4366.934495982563, 4436.534163912807, 4485.955140448619, 1728.075479618398, 1744.284843214276, 1792.803815326215, 1794.7257447212364, 1805.7923338816204, 894.7360528643935, 915.5696822493418, 926.249737712455, 929.6142101027998, 1032.9535170917327, 15840.841591583936, 16452.259648315856, 16777.0, 16871.240794164045, 16973.49079527616, 888.493558671551, 964.1804466203811, 1025.2980053111798, 1038.8389799581078, 1047.5809676129609, 9213.815723685622, 9525.476098814632, 9608.2793790466, 9636.277279204087, 9779.0, 373151.0, 378304.0, 379100.0, 501441.0, 505429.0, 44834.55165448369, 58050.419495804505, 61158.69420652957, 63914.0, 72197.0, 1100.3947828694347, 1118.59730497021, 1131.1572878205625, 1157.5427706056062, 1208.873068327813, 14232.430702771773, 14238.715225695221, 14367.28163591837, 14655.047421917541, 14669.0, 31572.0, 31657.36685266236, 32641.18397040093, 32747.0, 33489.497657534666, 40376.0, 41811.37282940819, 43103.19829211217, 43785.78107109444, 43865.34201986909, 4039.656629186552, 5052.484254723642, 7236.855262894607, 7389.371903388273, 7655.5023923447025, 11619.6514104577, 11630.53477860876, 11666.941665291619, 11684.298942063504, 11956.46195921203, 9186.40288381253, 9546.236301095756, 9882.802343953224, 9971.202303815533, 9997.100260976547, 9577.904220957702, 9601.855972160563, 9757.853632195382, 10138.847917281098, 10631.787364252517, 9051.498877646067, 9422.670206542738, 9656.227501799698, 9719.465429401167, 10249.897501024894, 7053.964730176316, 7247.710091596277, 7266.527675701062, 7280.089988751406, 7297.489175757646, 8069.515829050276, 9609.519524023632, 9651.565679544297, 9758.707238782848, 9813.9018609813], "unit": "score", "name": "jquery.html", "value": 7915.095416765708}, {"lowerIsBetter": false, "replicates": [1434.8206474190729, 1470.6102882736072, 1623.5778697538644, 1748.676494848453, 1762.2246211666857, 7811.375089992801, 7842.52944823311, 7996.160403157672, 8019.599020049003, 8041.437099403044, 7982.441229113964, 7984.92015079849, 8007.479513831597, 8067.757967260992, 8125.91874081259, 2262.5022495051103, 2268.9092436302526, 2286.6570014497793, 2286.7598902115287, 2288.107638021173, 2315.386422598013, 2330.0, 2375.3824005758543, 2376.0733314007553, 2390.127603424755, 2307.4231442139467, 2308.145985985188, 2323.372689373868, 2344.2498400511845, 2346.1319311854636, 2149.946251343721, 2247.123621787496, 2247.9775202248097, 2251.3358559225067, 2259.1302348595746, 2323.2449453927543, 2342.5197834443898, 2345.82406319525, 2360.280114565057, 2373.1219448804054, 7846.725364612268, 7856.685732570691, 7856.978592782959, 7877.172896845863, 7902.209779022051, 4736.360591320196, 4846.684965477232, 4850.442199147073, 4860.8055677772845, 4865.0, 3169.762267829899, 3208.4385232584436, 3221.548983142362, 3252.0569034980062, 3263.216827961296, 1005.6580762540772, 1009.4145395670494, 1009.5002973528077, 1034.3948789957808, 1041.7187359412992, 10769.138468922467, 10787.676369708843, 10834.133269338434, 10841.999999999922, 10938.12495000406, 4064.5122585289955, 4203.768792716369, 4215.578442155821, 4219.78901054946, 4240.575942405735, 8748.47509149453, 8776.341774366949, 8785.472871627722, 8856.38005339633, 8878.73363799087, 4709.81160753566, 4716.056788642285, 4739.289106634033, 4750.904981900412, 4770.403699537558, 4367.323064924942, 4375.78121093944, 4384.495782984997, 4386.736795792199, 4394.494633117232, 3649.927001459956, 3654.5979942206336, 3661.9633803662155, 3669.211119609297, 3694.5935947045805, 1086.1853609792656, 1094.217634391398, 1100.9284396514201, 1123.8988491035846, 1129.4578602270956, 1052.6368402900987, 1063.6702622187147, 1066.36018388966, 1199.5681554640323, 1291.14139097501, 7410.147832999274, 7416.221296763762, 7451.180370159278, 7457.701691932262, 7495.737649182252, 1058.8517607534952, 1088.891215579525, 1096.5065720425841, 1102.3551222534747, 1116.4361997191365, 5852.502537284378, 5905.734241959122, 5923.792667256712, 5935.109733540004, 5936.0, 9200.861987070199, 9353.719388418222, 9665.951670241604, 9721.70834874955, 9723.270754693427, 9503.28725345602, 9603.087706667855, 9645.662401815904, 9653.855192172123, 9661.758456038655, 7252.673629686677, 7439.590822504706, 7449.8882516761205, 7472.887906681404, 7551.5846628434865, 7439.070116235471, 7451.888221676788, 7525.435592330487, 7546.66040028189, 7550.056242969629, 8504.149585041447, 8701.086385929639, 8751.693690720795, 8792.912070879465, 8853.778655533406, 8827.0, 8860.246879015356, 8864.512451815212, 8906.153915378029, 9073.954630226806, 7237.565746055254, 7325.377342925698, 7371.705131794668, 7379.483436159418, 7387.482876198615, 7688.154303026775, 7786.805329866798, 7787.883181752165, 7824.64789084504, 7829.647665854936, 7469.253074692705, 7493.213212612597, 7517.398608111447, 7673.693052277847, 7720.0, 6412.454941329853, 6562.8359291018105, 6881.13985751781, 7024.964875175591, 7158.3557479824985, 7008.159020917318, 7033.824154396181, 7094.929050709633, 7128.465365097535, 7160.462965277521, 6416.903746443901, 6441.1626488556185, 6446.839568877647, 6459.741610335534, 6461.256955450183, 6430.710618022106, 6504.317046710027, 6524.151860258136, 6539.803805885831, 6544.28012918569], "unit": "score", "name": "mootools.html", "value": 4562.294939153075}, {"lowerIsBetter": false, "replicates": [319.4696803306511, 329.2312450428249, 344.65190157940475, 352.66496828013396, 358.0761634981747, 6155.230596175478, 6274.341194174614, 6289.245290565127, 6292.905606415901, 6355.52333574982, 6057.0, 6240.5943613665195, 6240.84397890053, 6266.122742816009, 6266.467350275232, 4753.429588449374, 4779.307000484928, 4812.398450193726, 4820.349252850855, 4821.915069109448, 4800.063987522434, 4805.183118869801, 4814.927776083362, 4819.301201325806, 4822.445418776833, 4679.08757792229, 4750.7149571025675, 4755.524447555252, 4767.42790865095, 4784.1866882629865, 4719.386479757643, 4756.66703330767, 4761.047790441891, 4769.761511924425, 4788.545088216614, 4178.6448151907125, 4189.162167566468, 4195.979020104911, 4208.810603522818, 4222.725522841006, 5896.97051514744, 5900.970495147497, 5922.733476993546, 5958.523318134538, 5961.672108034057, 5468.562514998791, 5526.198701188305, 5533.335999680024, 5551.361593416768, 5568.49883510486, 6578.93421065788, 6613.239477460057, 6621.867562648768, 6626.370494802986, 6626.635535045571, 4650.4186976627925, 4663.556962088596, 4663.720176789404, 4667.95332046682, 4675.064987002613, 6816.9318306816795, 6982.406495447893, 6982.476314276399, 6990.6155161466095, 6995.335443132945, 4757.09615173116, 4761.95238047622, 4765.833195838199, 4784.569388755029, 4807.158747219222, 4807.0, 4835.984443266883, 4843.612510999112, 4847.321375007502, 4848.515148485194, 5524.116141417434, 5538.723063846792, 5540.113581826889, 5559.416261292587, 5570.359408668055, 6549.6070235786, 6679.131712877295, 6687.899681504781, 6695.866082678319, 6739.258681545026, 1638.2054703468807, 1680.8655307575364, 1683.75585540096, 1688.839560241775, 1700.1499250374814, 1108.141190577309, 1117.3463523838645, 1124.173732306754, 1124.5670416889393, 1136.6419577832955, 6206.348333425016, 6264.248290205204, 6266.24545127365, 6269.5611307208055, 6271.905921411182, 6786.287439818847, 6789.762358317435, 6793.388595026471, 6811.727530898807, 6814.659267036628, 6073.39266073398, 6218.284897236876, 6274.278457977391, 6279.120923070774, 6280.340564240781, 3673.577538583097, 3674.4855720199193, 3680.466332381843, 3691.335559599298, 3694.2980833641523, 7037.331453511908, 7093.467989900778, 7124.536905101256, 7133.251008644122, 7134.964325178341, 6915.654217289115, 6916.377526022581, 6935.0, 6961.895571566431, 6976.058232138698, 7269.3094156055095, 7324.560526368435, 7336.853262934711, 7351.411887049023, 7363.815904602321, 6927.965360173167, 6928.579641173648, 6929.896051559332, 6966.686499107654, 6986.580805151707, 6756.662166891734, 6814.8637027260165, 6844.5208835381045, 6860.0, 6893.310668933066, 7274.236205198589, 7297.343239108506, 7301.233370496234, 7317.15852676949, 7321.890171647323, 4651.697639653412, 4676.1115388077515, 4685.6017238535105, 4710.6231501479115, 4711.882202944954, 6835.521513494008, 6888.793336199922, 6930.480213984072, 6946.44428445713, 6958.0, 6719.395254427125, 6753.0883330751685, 6757.695903684445, 6760.93239067603, 6777.525573209828, 6772.153480814898, 6778.152730908637, 6778.525503214925, 6782.69477873487, 6788.25329213796, 6470.029495575702, 6607.0, 6624.503162262753, 6624.6025238485845, 6657.0, 6660.866782664222, 6733.6296503692765, 6739.8542247817, 6775.288594697683, 6796.422304104207, 6552.934470655233, 6556.377144171296, 6565.310642382481, 6568.244651865097, 6570.441512471493], "unit": "score", "name": "prototype.html", "value": 5025.466988210173}, {"lowerIsBetter": false, "replicates": [767.4167632599223, 769.9067324399352, 809.5021561739532, 851.8424091543066, 856.0754385263915, 13864.445422183113, 13902.443902243924, 14070.296485175739, 14137.222452765094, 14174.503892363782, 12952.093353465261, 12980.54568090117, 12990.610281691565, 12999.935000324986, 13041.0, 808.3492788305397, 812.078291139555, 825.5500752090126, 826.6652005937605, 827.9710210142646, 803.8593246181895, 815.9918400815975, 821.080389963242, 830.0495932157676, 835.8871552340447, 836.7113345895656, 853.3429259470204, 853.8804567360575, 858.29619711836, 861.5821326656597, 829.7593697827623, 845.121074082953, 852.6845067325067, 854.8931383577053, 858.9398742088088, 626.4268194601934, 631.5579094633774, 631.958922670025, 632.0361448790585, 633.4742164003866, 13721.794173087412, 13805.585832425044, 13877.097988630807, 13887.097338672955, 13903.443862245498, 12383.318917459535, 12541.561045363369, 12579.245245285312, 12611.432485538173, 12798.808017879739, 9592.90407095927, 9702.12680858719, 9724.951375243149, 9799.706008819676, 10116.645917392856, 3574.410222313315, 3613.837377318027, 3620.2035552178477, 3633.909152271214, 3682.723795715305, 45317.77341113273, 45718.54281457176, 45843.54156458459, 45943.081138377376, 46032.0, 9594.376365536218, 9865.605375784888, 9911.504424778732, 10067.244956628283, 10166.796664066676, 17304.913475432542, 17445.563860903578, 17447.47657570275, 17468.388606398716, 17496.387626433014, 7447.255274472618, 7564.735234266775, 7586.468947173645, 7624.351930086005, 7676.57778822159, 4238.766867822299, 4275.8075886585175, 4314.374415709767, 4340.804663790137, 4366.912661746747, 3162.794418362799, 3167.3506931079073, 3182.172635114887, 3186.522021696764, 3187.6971687689634, 577.6938222741953, 584.3309410724696, 591.9644821310735, 597.6832278892194, 606.9136246119485, 511.29951965807084, 562.521856422038, 566.3911295357507, 590.9793157239476, 616.6731632234922, 7781.688732450752, 7864.21357864209, 7936.563489008045, 8074.919250807417, 8133.877991830127, 630.6815058395481, 631.8451979265018, 641.5188608543592, 656.0913135307634, 659.8383396067994, 3699.0, 3832.1952389997855, 3833.4058220975794, 3920.17676287977, 3995.5205375355144, 53386.19920701192, 54250.72874635681, 54334.0, 54414.727926360116, 54853.177202342, 47634.285485717744, 48353.758231208616, 48424.757876210395, 50252.49747502478, 50829.23756143661, 42635.36046959298, 42850.57149428466, 43734.0, 44694.0, 48889.755551222726, 7822.843543129219, 7912.497322820444, 7973.880391794244, 8068.757937261891, 8465.28045116172, 32438.675613243566, 32557.674423255463, 33031.33937321288, 33180.0, 33187.0, 40551.59448405596, 40826.38760418655, 42173.578264216965, 42178.578214218694, 43616.34575481307, 10615.256932014685, 10788.568457261621, 11104.389258590854, 11129.721756956142, 11231.38227397501, 12242.693932651398, 12382.938085309515, 12557.560485382968, 12590.496380145058, 12933.547325843927, 10124.291299608956, 10519.526621302213, 10594.576216951236, 10609.522571484456, 10981.286216395909, 11185.552577896793, 11383.943080284545, 11427.428628568372, 11537.538498459968, 11757.941210293893, 10944.781104378028, 10998.505067272152, 11008.339499629727, 11031.117510599293, 11469.655910322703, 8706.825863482822, 8735.606897689746, 8745.256653184551, 8765.474071555727, 8884.644614215358, 8083.9191608083165, 8121.918780812116, 8153.1846815317995, 8244.938765308672, 9148.908510914805], "unit": "score", "name": "yui.html", "value": 6166.275639372242}], "name": "dromaeo_css", "value": 6913.713576093064}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 113.0, 113.0, 112.0, 123.0, 111.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.7}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 153.0, 163.0, 135.0, 161.0, 165.0, 144.0, 163.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 161.0, 163.0, 162.0, 162.0, 161.0, 167.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 73.0, 76.0, 74.0, 131.0, 73.0, 76.0, 74.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 95.0, 95.0, 95.0, 136.0, 95.0, 97.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 115.0, 114.0, 116.0, 116.0, 116.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 98.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [62.0, 60.0, 60.0, 59.0, 63.0, 61.0, 61.0, 63.0, 69.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 83.0, 82.0, 83.0, 85.0, 84.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [116.0, 123.0, 115.0, 124.0, 115.0, 120.0, 132.0, 121.0, 124.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [132.0, 145.0, 146.0, 148.0, 146.0, 137.0, 135.0, 143.0, 150.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [78.0, 67.0, 69.0, 69.0, 70.0, 67.0, 68.0, 68.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1516.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [190.69412662090008], "unit": "score", "name": "DeltaBlue", "value": 346.72279200000014}, {"lowerIsBetter": false, "replicates": [272.33115468409585], "unit": "score", "name": "Encrypt", "value": 977.4166320000003}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [722.0216606498195], "unit": "score", "name": "Earley", "value": 923.0512549999999}, {"lowerIsBetter": false, "replicates": [12550.0], "unit": "score", "name": "Boyer", "value": 53.10462151394425}, {"lowerIsBetter": false, "replicates": [40019.60784313725], "unit": "score", "name": "RegExp", "value": 22.763466438020597}, {"lowerIsBetter": false, "replicates": [579.0387955993051], "unit": "score", "name": "Splay", "value": 140.73495699999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20461.28464775993}]} 04:26:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20461.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1516.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6913.71"}}} 04:26:18 INFO - Return code: 0 04:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:18 INFO - # TBPL SUCCESS # 04:26:18 INFO - Running post-action listener: _resource_record_post_action 04:26:18 INFO - Running post-run listener: _resource_record_post_run 04:26:19 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 544768; Write bytes: 384188416; Read time: 124; Write time: 272028 04:26:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69386240; Read time: 0; Write time: 72620 04:26:19 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 544768; Write bytes: 243023872; Read time: 124; Write time: 160712 04:26:19 INFO - Running post-run listener: _upload_blobber_files 04:26:19 INFO - Blob upload gear active. 04:26:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:26:19 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:26:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:26:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:21 INFO - (blobuploader) - INFO - Done attempting. 04:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:22 INFO - (blobuploader) - INFO - Done attempting. 04:26:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:22 INFO - Return code: 0 04:26:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:26:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a835f6623766088f07ce9a94f0ded9f7ec62083d6c1c5435a46f0720bda0e308116da2457f5d862082cacd0638130d4facf2a17eafad6c9bc3f93eef7aa0c55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b582392e482548e2c884d9322fe01497dfd011eff4a4ba074ac6dcc05a8833db5c95bcf73a8524068d403d64c4ad418b19fab452d650dd6771510b0cf3118649"} 04:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:26:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:26:22 INFO - Contents: 04:26:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a835f6623766088f07ce9a94f0ded9f7ec62083d6c1c5435a46f0720bda0e308116da2457f5d862082cacd0638130d4facf2a17eafad6c9bc3f93eef7aa0c55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b582392e482548e2c884d9322fe01497dfd011eff4a4ba074ac6dcc05a8833db5c95bcf73a8524068d403d64c4ad418b19fab452d650dd6771510b0cf3118649"} 04:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:22 INFO - Copying logs to upload dir... 04:26:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.595038 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-27 04:26:22.071602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 04:26:22.075006) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/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-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a835f6623766088f07ce9a94f0ded9f7ec62083d6c1c5435a46f0720bda0e308116da2457f5d862082cacd0638130d4facf2a17eafad6c9bc3f93eef7aa0c55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b582392e482548e2c884d9322fe01497dfd011eff4a4ba074ac6dcc05a8833db5c95bcf73a8524068d403d64c4ad418b19fab452d650dd6771510b0cf3118649"} build_url:https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/DB9MeqkLTwmG1KEtJwEGWg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9a835f6623766088f07ce9a94f0ded9f7ec62083d6c1c5435a46f0720bda0e308116da2457f5d862082cacd0638130d4facf2a17eafad6c9bc3f93eef7aa0c55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b582392e482548e2c884d9322fe01497dfd011eff4a4ba074ac6dcc05a8833db5c95bcf73a8524068d403d64c4ad418b19fab452d650dd6771510b0cf3118649"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 04:26:22.227204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:26:22.227545) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (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-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1453896305.5234-1009093795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 04:26:22.243604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 04:26:22.243918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 04:26:22.244223) ========= ========= Total master_lag: 0.31 =========