builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1454828558.16 results: success (0) buildid: 20160206203325 builduid: 8cd4fbb2ed72464e9045bf8dc24fce0e revision: c8ecda902de00888ff0ee2fb816970c1b15e4806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.164884) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.165239) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.165550) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.190446) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.190788) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.204766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.205024) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.253848) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.254113) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.254459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.254725) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 23:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-02-06 23:02:39 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.421893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.422171) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:38.471034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-06 23:02:38.471394) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c8ecda902de00888ff0ee2fb816970c1b15e4806 --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/fx-team --rev c8ecda902de00888ff0ee2fb816970c1b15e4806 --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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 23:02:39,684 truncating revision to first 12 chars 2016-02-06 23:02:39,684 Setting DEBUG logging. 2016-02-06 23:02:39,684 attempt 1/10 2016-02-06 23:02:39,684 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c8ecda902de0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 23:02:39,919 unpacking tar archive at: fx-team-c8ecda902de0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527234 ========= master_lag: 2.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-06 23:02:41.231215) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:41.231527) ========= echo c8ecda902de00888ff0ee2fb816970c1b15e4806 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c8ecda902de00888ff0ee2fb816970c1b15e4806'] 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c8ecda902de00888ff0ee2fb816970c1b15e4806 program finished with exit code 0 elapsedTime=0.003917 script_repo_revision: 'c8ecda902de00888ff0ee2fb816970c1b15e4806' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:41.252858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:41.253122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 23:02:41.284170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-06 23:02:41.284477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:02:42 INFO - MultiFileLogger online at 20160206 23:02:42 in /builds/slave/test-pgo 23:02:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:02:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:02:42 INFO - {'append_to_log': False, 23:02:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:02:42 INFO - 'blob_upload_branch': 'Fx-Team', 23:02:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:02:42 INFO - 'branch': 'Fx-Team', 23:02:42 INFO - 'buildbot_json_path': 'buildprops.json', 23:02:42 INFO - 'config_files': ('talos/linux_config.py',), 23:02:42 INFO - 'default_actions': ('clobber', 23:02:42 INFO - 'read-buildbot-config', 23:02:42 INFO - 'download-and-extract', 23:02:42 INFO - 'populate-webroot', 23:02:42 INFO - 'create-virtualenv', 23:02:42 INFO - 'install', 23:02:42 INFO - 'run-tests'), 23:02:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:02:42 INFO - 'download_minidump_stackwalk': True, 23:02:42 INFO - 'download_symbols': 'ondemand', 23:02:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:02:42 INFO - 'tooltool.py': '/tools/tooltool.py', 23:02:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:02:42 INFO - '/tools/misc-python/virtualenv.py')}, 23:02:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:02:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:02:42 INFO - 'installer_path': 'installer.exe', 23:02:42 INFO - 'log_level': 'info', 23:02:42 INFO - 'log_name': 'talos', 23:02:42 INFO - 'log_to_console': True, 23:02:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:02:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:02:42 INFO - 'opt_config_files': (), 23:02:42 INFO - 'pip_index': False, 23:02:42 INFO - 'sps_profile': False, 23:02:42 INFO - 'sps_profile_interval': 0, 23:02:42 INFO - 'suite': 'dromaeojs', 23:02:42 INFO - 'system_bits': '32', 23:02:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:02:42 INFO - 'title': 'talos-linux64-ix-069', 23:02:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:02:42 INFO - 'use_talos_json': True, 23:02:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:02:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:02:42 INFO - 'work_dir': 'build'} 23:02:42 INFO - ##### 23:02:42 INFO - ##### Running clobber step. 23:02:42 INFO - ##### 23:02:42 INFO - Running pre-action listener: _resource_record_pre_action 23:02:42 INFO - Running main action method: clobber 23:02:42 INFO - rmtree: /builds/slave/test-pgo/build 23:02:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:02:43 INFO - Running post-action listener: _resource_record_post_action 23:02:43 INFO - ##### 23:02:43 INFO - ##### Running read-buildbot-config step. 23:02:43 INFO - ##### 23:02:43 INFO - Running pre-action listener: _resource_record_pre_action 23:02:43 INFO - Running main action method: read_buildbot_config 23:02:43 INFO - Using buildbot properties: 23:02:43 INFO - { 23:02:43 INFO - "project": "", 23:02:43 INFO - "product": "firefox", 23:02:43 INFO - "script_repo_revision": "production", 23:02:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:02:43 INFO - "repository": "", 23:02:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:02:43 INFO - "buildid": "20160206203325", 23:02:43 INFO - "pgo_build": "True", 23:02:43 INFO - "basedir": "/builds/slave/test-pgo", 23:02:43 INFO - "buildnumber": 922, 23:02:43 INFO - "slavename": "talos-linux64-ix-069", 23:02:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:02:43 INFO - "platform": "ubuntu64_hw", 23:02:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:02:43 INFO - "branch": "fx-team", 23:02:43 INFO - "repo_path": "integration/fx-team", 23:02:43 INFO - "revision": "c8ecda902de00888ff0ee2fb816970c1b15e4806", 23:02:43 INFO - "stage_platform": "linux64-pgo", 23:02:43 INFO - "builduid": "8cd4fbb2ed72464e9045bf8dc24fce0e", 23:02:43 INFO - "slavebuilddir": "test" 23:02:43 INFO - } 23:02:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 23:02:43 INFO - Running post-action listener: _resource_record_post_action 23:02:43 INFO - ##### 23:02:43 INFO - ##### Running download-and-extract step. 23:02:43 INFO - ##### 23:02:43 INFO - Running pre-action listener: _resource_record_pre_action 23:02:43 INFO - Running main action method: download_and_extract 23:02:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:02:43 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')]} 23:02:43 INFO - https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/test_packages.json 23:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/test_packages.json 23:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:02:45 INFO - Downloaded 1448 bytes. 23:02:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:02:45 INFO - Using the following test package requirements: 23:02:45 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:45 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:02:45 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:02:45 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'jsshell-linux-x86_64.zip'], 23:02:45 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:02:45 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:45 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:02:45 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:02:45 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:02:45 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:02:45 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:02:45 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:02:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:02: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')]} 23:02:45 INFO - https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:46 INFO - Downloaded 23575026 bytes. 23:02:46 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'] 23:02:46 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 23:02:47 INFO - Return code: 0 23:02:47 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 23:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:02:47 INFO - https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:51 INFO - Downloaded 23575026 bytes. 23:02:51 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'] 23:02:51 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 23:02:52 INFO - Return code: 0 23:02:52 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')]} 23:02:52 INFO - https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:53 INFO - Downloaded 10706547 bytes. 23:02:53 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'] 23:02:53 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 23:02:54 INFO - Return code: 0 23:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:02:54 INFO - https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eOgETzmzSIS_7Z1mFu851Q/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 23:02:55 INFO - Downloaded 56558363 bytes. 23:02:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:02:55 INFO - mkdir: /builds/slave/test-pgo/properties 23:02:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:02:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:02:55 INFO - Contents: 23:02:55 INFO - build_url:https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:02:56 INFO - Running post-action listener: _resource_record_post_action 23:02:56 INFO - Running post-action listener: set_extra_try_arguments 23:02:56 INFO - ##### 23:02:56 INFO - ##### Running populate-webroot step. 23:02:56 INFO - ##### 23:02:56 INFO - Running pre-action listener: _resource_record_pre_action 23:02:56 INFO - Running main action method: populate_webroot 23:02:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:02:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:02:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:02:56 INFO - '--tppagecycles', 23:02:56 INFO - '7'], 23:02:56 INFO - 'tests': ['tsvgm']}}, 23:02:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:02:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:02:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:02:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:02:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:02:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['damp', 'tps']}, 23:02:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['damp', 'tps']}, 23:02:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:02:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:02:56 INFO - 'other': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'other_l64': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'other_nol64': {'tests': ['a11yr', 23:02:56 INFO - 'ts_paint', 23:02:56 INFO - 'tpaint', 23:02:56 INFO - 'sessionrestore', 23:02:56 INFO - 'sessionrestore_no_auto_restore']}, 23:02:56 INFO - 'svgr': {'tests': ['tsvgx', 23:02:56 INFO - 'tsvgr_opacity', 23:02:56 INFO - 'tart', 23:02:56 INFO - 'tscrollx', 23:02:56 INFO - 'cart']}, 23:02:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['tsvgx', 23:02:56 INFO - 'tsvgr_opacity', 23:02:56 INFO - 'tart', 23:02:56 INFO - 'tscrollx', 23:02:56 INFO - 'cart']}, 23:02:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'tests': ['tp5o']}, 23:02:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--e10s'], 23:02:56 INFO - 'tests': ['tp5o']}, 23:02:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--xperf_path', 23:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:56 INFO - 'tests': ['tp5n']}, 23:02:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:02:56 INFO - 'talos_options': ['--e10s', 23:02:56 INFO - '--xperf_path', 23:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:02:56 INFO - 'tests': ['tp5n']}}, 23:02:56 INFO - 'talos.zip': {'path': '', 23:02:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:02:56 INFO - Running post-action listener: _resource_record_post_action 23:02:56 INFO - ##### 23:02:56 INFO - ##### Running create-virtualenv step. 23:02:56 INFO - ##### 23:02:56 INFO - Running pre-action listener: _resource_record_pre_action 23:02:56 INFO - Running main action method: create_virtualenv 23:02:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:02:56 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 23:02:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:02:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:02:56 INFO - Using real prefix '/usr' 23:02:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:02:56 INFO - Installing distribute.............................................................................................................................................................................................done. 23:02:58 INFO - Installing pip.................done. 23:02:58 INFO - Return code: 0 23:02:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:02:58 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')]} 23:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:58 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')]} 23:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:58 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:02:58 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 23:02:58 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 23:02:58 INFO - Using env: {'DISPLAY': ':0', 23:02:58 INFO - 'HOME': '/home/cltbld', 23:02:58 INFO - 'LANG': 'en_US.UTF-8', 23:02:58 INFO - 'LANGUAGE': 'en_US:en', 23:02:58 INFO - 'LOGNAME': 'cltbld', 23:02:58 INFO - 'MAIL': '/var/mail/cltbld', 23:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:58 INFO - 'MOZ_NO_REMOTE': '1', 23:02:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:58 INFO - 'NO_EM_RESTART': '1', 23:02:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:58 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:58 INFO - 'SHELL': '/bin/bash', 23:02:58 INFO - 'SHLVL': '1', 23:02:58 INFO - 'TERM': 'linux', 23:02:58 INFO - 'TMOUT': '86400', 23:02:58 INFO - 'USER': 'cltbld', 23:02:58 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:58 INFO - '_': '/tools/buildbot/bin/python'} 23:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:59 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 23:02:59 INFO - Cleaning up... 23:02:59 INFO - Return code: 0 23:02:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:02:59 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')]} 23:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 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')]} 23:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:59 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:02:59 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 23:02:59 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 23:02:59 INFO - Using env: {'DISPLAY': ':0', 23:02:59 INFO - 'HOME': '/home/cltbld', 23:02:59 INFO - 'LANG': 'en_US.UTF-8', 23:02:59 INFO - 'LANGUAGE': 'en_US:en', 23:02:59 INFO - 'LOGNAME': 'cltbld', 23:02:59 INFO - 'MAIL': '/var/mail/cltbld', 23:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:59 INFO - 'MOZ_NO_REMOTE': '1', 23:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:59 INFO - 'NO_EM_RESTART': '1', 23:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:59 INFO - 'SHELL': '/bin/bash', 23:02:59 INFO - 'SHLVL': '1', 23:02:59 INFO - 'TERM': 'linux', 23:02:59 INFO - 'TMOUT': '86400', 23:02:59 INFO - 'USER': 'cltbld', 23:02:59 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:59 INFO - '_': '/tools/buildbot/bin/python'} 23:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:59 INFO - Downloading/unpacking psutil>=0.7.1 23:02:59 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 23:02:59 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 23:02:59 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 23:02:59 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 23:02:59 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 23:02:59 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 23:03:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:01 INFO - Installing collected packages: psutil 23:03:01 INFO - Running setup.py install for psutil 23:03:01 INFO - building 'psutil._psutil_linux' extension 23:03:01 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 23:03:01 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 23:03:01 INFO - building 'psutil._psutil_posix' extension 23:03:01 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 23:03:01 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 23:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:03:01 INFO - Successfully installed psutil 23:03:01 INFO - Cleaning up... 23:03:01 INFO - Return code: 0 23:03:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:01 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:01 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 23:03:01 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 23:03:01 INFO - Using env: {'DISPLAY': ':0', 23:03:01 INFO - 'HOME': '/home/cltbld', 23:03:01 INFO - 'LANG': 'en_US.UTF-8', 23:03:01 INFO - 'LANGUAGE': 'en_US:en', 23:03:01 INFO - 'LOGNAME': 'cltbld', 23:03:01 INFO - 'MAIL': '/var/mail/cltbld', 23:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:01 INFO - 'MOZ_NO_REMOTE': '1', 23:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:01 INFO - 'NO_EM_RESTART': '1', 23:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:01 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:01 INFO - 'SHELL': '/bin/bash', 23:03:01 INFO - 'SHLVL': '1', 23:03:01 INFO - 'TERM': 'linux', 23:03:01 INFO - 'TMOUT': '86400', 23:03:01 INFO - 'USER': 'cltbld', 23:03:01 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:01 INFO - '_': '/tools/buildbot/bin/python'} 23:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:03:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:03:03 INFO - Installing collected packages: mozsystemmonitor 23:03:03 INFO - Running setup.py install for mozsystemmonitor 23:03:03 INFO - Successfully installed mozsystemmonitor 23:03:03 INFO - Cleaning up... 23:03:03 INFO - Return code: 0 23:03:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:03 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:03 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 23:03:03 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 23:03:03 INFO - Using env: {'DISPLAY': ':0', 23:03:03 INFO - 'HOME': '/home/cltbld', 23:03:03 INFO - 'LANG': 'en_US.UTF-8', 23:03:03 INFO - 'LANGUAGE': 'en_US:en', 23:03:03 INFO - 'LOGNAME': 'cltbld', 23:03:03 INFO - 'MAIL': '/var/mail/cltbld', 23:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:03 INFO - 'MOZ_NO_REMOTE': '1', 23:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:03 INFO - 'NO_EM_RESTART': '1', 23:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:03 INFO - 'SHELL': '/bin/bash', 23:03:03 INFO - 'SHLVL': '1', 23:03:03 INFO - 'TERM': 'linux', 23:03:03 INFO - 'TMOUT': '86400', 23:03:03 INFO - 'USER': 'cltbld', 23:03:03 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:03 INFO - '_': '/tools/buildbot/bin/python'} 23:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:04 INFO - Downloading/unpacking blobuploader==1.2.4 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:04 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 23:03:05 INFO - Downloading blobuploader-1.2.4.tar.gz 23:03:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:03:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:03:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:06 INFO - Downloading docopt-0.6.1.tar.gz 23:03:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:03:06 INFO - Installing collected packages: blobuploader, requests, docopt 23:03:06 INFO - Running setup.py install for blobuploader 23:03:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:03:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:03:06 INFO - Running setup.py install for requests 23:03:07 INFO - Running setup.py install for docopt 23:03:07 INFO - Successfully installed blobuploader requests docopt 23:03:07 INFO - Cleaning up... 23:03:07 INFO - Return code: 0 23:03:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:07 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:07 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 23:03:07 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 23:03:07 INFO - Using env: {'DISPLAY': ':0', 23:03:07 INFO - 'HOME': '/home/cltbld', 23:03:07 INFO - 'LANG': 'en_US.UTF-8', 23:03:07 INFO - 'LANGUAGE': 'en_US:en', 23:03:07 INFO - 'LOGNAME': 'cltbld', 23:03:07 INFO - 'MAIL': '/var/mail/cltbld', 23:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:07 INFO - 'MOZ_NO_REMOTE': '1', 23:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:07 INFO - 'NO_EM_RESTART': '1', 23:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:07 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:07 INFO - 'SHELL': '/bin/bash', 23:03:07 INFO - 'SHLVL': '1', 23:03:07 INFO - 'TERM': 'linux', 23:03:07 INFO - 'TMOUT': '86400', 23:03:07 INFO - 'USER': 'cltbld', 23:03:07 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:07 INFO - '_': '/tools/buildbot/bin/python'} 23:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:07 INFO - Running setup.py (path:/tmp/pip-PVsGEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:07 INFO - Running setup.py (path:/tmp/pip-e4Ugy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:07 INFO - Running setup.py (path:/tmp/pip-TWPEgx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:07 INFO - Running setup.py (path:/tmp/pip-u0c2pW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:07 INFO - Running setup.py (path:/tmp/pip-eV_TIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:07 INFO - Running setup.py (path:/tmp/pip-hv66j_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:07 INFO - Running setup.py (path:/tmp/pip-YqyJt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:07 INFO - Running setup.py (path:/tmp/pip-38rrPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:08 INFO - Running setup.py (path:/tmp/pip-BEcQfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:08 INFO - Running setup.py (path:/tmp/pip-WIPm1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:08 INFO - Running setup.py (path:/tmp/pip-OqMz1o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:08 INFO - Running setup.py (path:/tmp/pip-CZi3F_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:08 INFO - Running setup.py (path:/tmp/pip-xUfiRH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:08 INFO - Running setup.py (path:/tmp/pip-Xt0tau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:08 INFO - Running setup.py (path:/tmp/pip-s6G589-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:08 INFO - Running setup.py (path:/tmp/pip-U2Ck48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:08 INFO - Running setup.py (path:/tmp/pip-i_QwW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:03:08 INFO - Running setup.py install for manifestparser 23:03:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:03:08 INFO - Running setup.py install for mozcrash 23:03:08 INFO - Running setup.py install for mozdebug 23:03:08 INFO - Running setup.py install for mozdevice 23:03:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for mozfile 23:03:09 INFO - Running setup.py install for mozhttpd 23:03:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for mozinfo 23:03:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for mozInstall 23:03:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for mozleak 23:03:09 INFO - Running setup.py install for mozlog 23:03:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for moznetwork 23:03:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:03:09 INFO - Running setup.py install for mozprocess 23:03:09 INFO - Running setup.py install for mozprofile 23:03:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:03:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:03:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:03:10 INFO - Running setup.py install for mozrunner 23:03:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:03:10 INFO - Running setup.py install for mozscreenshot 23:03:10 INFO - Running setup.py install for moztest 23:03:10 INFO - Running setup.py install for mozversion 23:03:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:03:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:03:10 INFO - Cleaning up... 23:03:10 INFO - Return code: 0 23:03:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:10 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:10 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 23:03:10 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 23:03:10 INFO - Using env: {'DISPLAY': ':0', 23:03:10 INFO - 'HOME': '/home/cltbld', 23:03:10 INFO - 'LANG': 'en_US.UTF-8', 23:03:10 INFO - 'LANGUAGE': 'en_US:en', 23:03:10 INFO - 'LOGNAME': 'cltbld', 23:03:10 INFO - 'MAIL': '/var/mail/cltbld', 23:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:10 INFO - 'MOZ_NO_REMOTE': '1', 23:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:10 INFO - 'NO_EM_RESTART': '1', 23:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:10 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:10 INFO - 'SHELL': '/bin/bash', 23:03:10 INFO - 'SHLVL': '1', 23:03:10 INFO - 'TERM': 'linux', 23:03:10 INFO - 'TMOUT': '86400', 23:03:10 INFO - 'USER': 'cltbld', 23:03:10 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:10 INFO - '_': '/tools/buildbot/bin/python'} 23:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:10 INFO - Running setup.py (path:/tmp/pip-7UM9uX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:03:10 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)) 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:10 INFO - Running setup.py (path:/tmp/pip-6IA2uh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:03:10 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)) 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:10 INFO - Running setup.py (path:/tmp/pip-pUnYU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:03:10 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)) 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:10 INFO - Running setup.py (path:/tmp/pip-aJveXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:03:10 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)) 23:03:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:10 INFO - Running setup.py (path:/tmp/pip-Fz8kqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:11 INFO - Running setup.py (path:/tmp/pip-5vOXMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:11 INFO - Running setup.py (path:/tmp/pip-Tacs8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:11 INFO - Running setup.py (path:/tmp/pip-Xj0o9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:11 INFO - Running setup.py (path:/tmp/pip-tXEy1q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:11 INFO - Running setup.py (path:/tmp/pip-bxyICs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:11 INFO - Running setup.py (path:/tmp/pip-FmT4Hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:11 INFO - Running setup.py (path:/tmp/pip-h4hZHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:11 INFO - Running setup.py (path:/tmp/pip-88rSpC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:11 INFO - Running setup.py (path:/tmp/pip-O4yJgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:11 INFO - Running setup.py (path:/tmp/pip-BzTElI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:11 INFO - Running setup.py (path:/tmp/pip-UYNVsz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:03:11 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)) 23:03:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:11 INFO - Running setup.py (path:/tmp/pip-51hZI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:03:11 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)) 23:03:11 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)) 23:03:11 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)) 23:03:11 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)) 23:03:11 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)) 23:03:11 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)) 23:03:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:03:11 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 23:03:11 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 23:03:11 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 23:03:11 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 23:03:11 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 23:03:11 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 23:03:13 INFO - Downloading blessings-1.6.tar.gz 23:03:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:03:13 INFO - Installing collected packages: blessings 23:03:13 INFO - Running setup.py install for blessings 23:03:13 INFO - Successfully installed blessings 23:03:13 INFO - Cleaning up... 23:03:13 INFO - Return code: 0 23:03:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:03:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:03:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:03:14 INFO - Reading from file tmpfile_stdout 23:03:14 INFO - Current package versions: 23:03:14 INFO - argparse == 1.2.1 23:03:14 INFO - blessings == 1.6 23:03:14 INFO - blobuploader == 1.2.4 23:03:14 INFO - docopt == 0.6.1 23:03:14 INFO - manifestparser == 1.1 23:03:14 INFO - mozInstall == 1.12 23:03:14 INFO - mozcrash == 0.16 23:03:14 INFO - mozdebug == 0.1 23:03:14 INFO - mozdevice == 0.48 23:03:14 INFO - mozfile == 1.2 23:03:14 INFO - mozhttpd == 0.7 23:03:14 INFO - mozinfo == 0.9 23:03:14 INFO - mozleak == 0.1 23:03:14 INFO - mozlog == 3.1 23:03:14 INFO - moznetwork == 0.27 23:03:14 INFO - mozprocess == 0.22 23:03:14 INFO - mozprofile == 0.28 23:03:14 INFO - mozrunner == 6.11 23:03:14 INFO - mozscreenshot == 0.1 23:03:14 INFO - mozsystemmonitor == 0.0 23:03:14 INFO - moztest == 0.7 23:03:14 INFO - mozversion == 1.4 23:03:14 INFO - psutil == 3.1.1 23:03:14 INFO - requests == 1.2.3 23:03:14 INFO - wsgiref == 0.1.2 23:03:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:14 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 23:03:14 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 23:03:14 INFO - Using env: {'DISPLAY': ':0', 23:03:14 INFO - 'HOME': '/home/cltbld', 23:03:14 INFO - 'LANG': 'en_US.UTF-8', 23:03:14 INFO - 'LANGUAGE': 'en_US:en', 23:03:14 INFO - 'LOGNAME': 'cltbld', 23:03:14 INFO - 'MAIL': '/var/mail/cltbld', 23:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:14 INFO - 'MOZ_NO_REMOTE': '1', 23:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:14 INFO - 'NO_EM_RESTART': '1', 23:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:14 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:14 INFO - 'SHELL': '/bin/bash', 23:03:14 INFO - 'SHLVL': '1', 23:03:14 INFO - 'TERM': 'linux', 23:03:14 INFO - 'TMOUT': '86400', 23:03:14 INFO - 'USER': 'cltbld', 23:03:14 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:14 INFO - '_': '/tools/buildbot/bin/python'} 23:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 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)) 23:03:14 INFO - Cleaning up... 23:03:14 INFO - Return code: 0 23:03:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:14 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:14 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 23:03:14 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 23:03:14 INFO - Using env: {'DISPLAY': ':0', 23:03:14 INFO - 'HOME': '/home/cltbld', 23:03:14 INFO - 'LANG': 'en_US.UTF-8', 23:03:14 INFO - 'LANGUAGE': 'en_US:en', 23:03:14 INFO - 'LOGNAME': 'cltbld', 23:03:14 INFO - 'MAIL': '/var/mail/cltbld', 23:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:14 INFO - 'MOZ_NO_REMOTE': '1', 23:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:14 INFO - 'NO_EM_RESTART': '1', 23:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:14 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:14 INFO - 'SHELL': '/bin/bash', 23:03:14 INFO - 'SHLVL': '1', 23:03:14 INFO - 'TERM': 'linux', 23:03:14 INFO - 'TMOUT': '86400', 23:03:14 INFO - 'USER': 'cltbld', 23:03:14 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:14 INFO - '_': '/tools/buildbot/bin/python'} 23:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:14 INFO - Downloading/unpacking jsonschema 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:14 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 23:03:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:03:16 INFO - Downloading/unpacking functools32 (from jsonschema) 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 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 23:03:16 INFO - Downloading functools32-3.2.3-2.tar.gz 23:03:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:03:16 INFO - warning: no files found matching '*.txt' 23:03:16 INFO - no previously-included directories found matching 'build' 23:03:16 INFO - no previously-included directories found matching 'dist' 23:03:16 INFO - no previously-included directories found matching '.git*' 23:03:16 INFO - Installing collected packages: jsonschema, functools32 23:03:16 INFO - Running setup.py install for functools32 23:03:16 INFO - warning: no files found matching '*.txt' 23:03:16 INFO - no previously-included directories found matching 'build' 23:03:16 INFO - no previously-included directories found matching 'dist' 23:03:16 INFO - no previously-included directories found matching '.git*' 23:03:16 INFO - Successfully installed jsonschema functools32 23:03:16 INFO - Cleaning up... 23:03:16 INFO - Return code: 0 23:03:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:03: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')]} 23:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03: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')]} 23:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:16 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 0x7ff6fc9dcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, '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': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', '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 23:03:16 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 23:03:16 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 23:03:16 INFO - Using env: {'DISPLAY': ':0', 23:03:16 INFO - 'HOME': '/home/cltbld', 23:03:16 INFO - 'LANG': 'en_US.UTF-8', 23:03:16 INFO - 'LANGUAGE': 'en_US:en', 23:03:16 INFO - 'LOGNAME': 'cltbld', 23:03:16 INFO - 'MAIL': '/var/mail/cltbld', 23:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:16 INFO - 'MOZ_NO_REMOTE': '1', 23:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:16 INFO - 'NO_EM_RESTART': '1', 23:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:16 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:16 INFO - 'SHELL': '/bin/bash', 23:03:16 INFO - 'SHLVL': '1', 23:03:16 INFO - 'TERM': 'linux', 23:03:16 INFO - 'TMOUT': '86400', 23:03:16 INFO - 'USER': 'cltbld', 23:03:16 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:16 INFO - '_': '/tools/buildbot/bin/python'} 23:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:17 INFO - Downloading/unpacking flake8 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:17 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 23:03:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:03:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:03:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:18 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 23:03:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:03:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:03:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:03:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:03:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:03:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:03:19 INFO - no previously-included directories found matching 'docs/_build' 23:03:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:03:19 INFO - Running setup.py install for pep8 23:03:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:03:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:03:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:03:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:03:19 INFO - no previously-included directories found matching 'docs/_build' 23:03:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:03:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:03:19 INFO - Cleaning up... 23:03:19 INFO - Return code: 0 23:03:19 INFO - Running post-action listener: _resource_record_post_action 23:03:19 INFO - Running post-action listener: _start_resource_monitoring 23:03:19 INFO - Starting resource monitoring. 23:03:19 INFO - ##### 23:03:19 INFO - ##### Running install step. 23:03:19 INFO - ##### 23:03:19 INFO - Running pre-action listener: _resource_record_pre_action 23:03:19 INFO - Running main action method: install 23:03:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:03:19 INFO - Reading from file tmpfile_stdout 23:03:19 INFO - Detecting whether we're running mozinstall >=1.0... 23:03:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:03:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:03:20 INFO - Reading from file tmpfile_stdout 23:03:20 INFO - Output received: 23:03:20 INFO - Usage: mozinstall [options] installer 23:03:20 INFO - Options: 23:03:20 INFO - -h, --help show this help message and exit 23:03:20 INFO - -d DEST, --destination=DEST 23:03:20 INFO - Directory to install application into. [default: 23:03:20 INFO - "/builds/slave/test-pgo"] 23:03:20 INFO - --app=APP Application being installed. [default: firefox] 23:03:20 INFO - mkdir: /builds/slave/test-pgo/build/application 23:03:20 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'] 23:03:20 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 23:03:36 INFO - Reading from file tmpfile_stdout 23:03:36 INFO - Output received: 23:03:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:03:36 INFO - Running post-action listener: _resource_record_post_action 23:03:36 INFO - ##### 23:03:36 INFO - ##### Running run-tests step. 23:03:36 INFO - ##### 23:03:36 INFO - Running pre-action listener: _resource_record_pre_action 23:03:36 INFO - Running main action method: run_tests 23:03:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:03:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:03:36 INFO - Python 2.7.3 23:03:36 INFO - Return code: 0 23:03:36 INFO - grabbing minidump binary from tooltool 23:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:03:36 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 0xe57840>, '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 0xdc46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:03:36 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 23:03:36 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 23:03:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:03:36 INFO - Return code: 0 23:03:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:03:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:03:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:03:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:03:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:03:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:03:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:03:37 INFO - Return code: 0 23:03:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 23:03:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 23:03:37 INFO - Using env: {'DISPLAY': ':0', 23:03:37 INFO - 'HOME': '/home/cltbld', 23:03:37 INFO - 'LANG': 'en_US.UTF-8', 23:03:37 INFO - 'LANGUAGE': 'en_US:en', 23:03:37 INFO - 'LOGNAME': 'cltbld', 23:03:37 INFO - 'MAIL': '/var/mail/cltbld', 23:03:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:03:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:37 INFO - 'MOZ_NO_REMOTE': '1', 23:03:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:03:37 INFO - 'NO_EM_RESTART': '1', 23:03:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:03:37 INFO - 'PWD': '/builds/slave/test-pgo', 23:03:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:03:37 INFO - 'SHELL': '/bin/bash', 23:03:37 INFO - 'SHLVL': '1', 23:03:37 INFO - 'TERM': 'linux', 23:03:37 INFO - 'TMOUT': '86400', 23:03:37 INFO - 'USER': 'cltbld', 23:03:37 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605', 23:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:37 INFO - '_': '/tools/buildbot/bin/python'} 23:03:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:03:37 INFO - mozversion application_buildid: 20160206203325 23:03:37 INFO - mozversion application_changeset: c8ecda902de00888ff0ee2fb816970c1b15e4806 23:03:37 INFO - mozversion application_display_name: Nightly 23:03:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:03:37 INFO - mozversion application_name: Firefox 23:03:37 INFO - mozversion application_remotingname: firefox 23:03:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:03:37 INFO - mozversion application_vendor: Mozilla 23:03:37 INFO - mozversion application_version: 47.0a1 23:03:37 INFO - mozversion platform_buildid: 20160206203325 23:03:37 INFO - mozversion platform_changeset: c8ecda902de00888ff0ee2fb816970c1b15e4806 23:03:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:03:37 INFO - mozversion platform_version: 47.0a1 23:03:37 INFO - using testdate: 1454828617 23:03:37 INFO - actual date: 1454828617 23:03:37 INFO - starting webserver on 'localhost:56552' 23:03:37 INFO - SUITE-START | Running 2 tests 23:03:37 INFO - TEST-START | dromaeo_css 23:03:37 INFO - operating with platform_type : linux_ 23:03:37 INFO - Initialising browser for dromaeo_css test... 23:03:37 INFO - TEST-INFO | started process 19650 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZ55Bq/profile http://localhost:56552/getInfo.html) 23:03:42 INFO - PROCESS | 19650 | __metrics Screen width/height:1600/1200 23:03:42 INFO - PROCESS | 19650 | colorDepth:24 23:03:42 INFO - PROCESS | 19650 | Browser inner width/height: 1024/697 23:03:42 INFO - PROCESS | 19650 | __metrics 23:03:42 INFO - PROCESS | 19650 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:03:43 INFO - TEST-INFO | 19650: exit 0 23:03:43 INFO - Browser initialized. 23:03:43 INFO - Running cycle 1/1 for dromaeo_css test... 23:03:43 INFO - TEST-INFO | started process 19742 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZ55Bq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:55 INFO - PROCESS | 19742 | RSS: Main: 151146496 23:03:55 INFO - PROCESS | 19742 | 23:04:47 INFO - PROCESS | 19742 | 1454828687074 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] 23:06:55 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56552/tests/dromaeo/cssquery-ext.html) 23:06:56 INFO - PROCESS | 19742 | RSS: Main: 263114752 23:06:56 INFO - PROCESS | 19742 | 23:09:59 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-ext.html (next: http://localhost:56552/tests/dromaeo/cssquery-jquery.html) 23:09:59 INFO - PROCESS | 19742 | RSS: Main: 242966528 23:09:59 INFO - PROCESS | 19742 | 23:13:01 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56552/tests/dromaeo/cssquery-mootools.html) 23:13:02 INFO - PROCESS | 19742 | RSS: Main: 239587328 23:13:02 INFO - PROCESS | 19742 | 23:16:04 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56552/tests/dromaeo/cssquery-prototype.html) 23:16:04 INFO - PROCESS | 19742 | RSS: Main: 219299840 23:16:04 INFO - PROCESS | 19742 | 23:19:07 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56552/tests/dromaeo/cssquery-yui.html) 23:19:07 INFO - PROCESS | 19742 | RSS: Main: 220434432 23:19:07 INFO - PROCESS | 19742 | 23:22:10 INFO - PROCESS | 19742 | Cycle 1(1): loaded http://localhost:56552/tests/dromaeo/cssquery-yui.html (next: http://localhost:56552/tests/dromaeo/cssquery-dojo.html) 23:22:11 INFO - PROCESS | 19742 | RSS: Main: 286380032 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | __start_tp_report 23:22:11 INFO - PROCESS | 19742 | _x_x_mozilla_page_load 23:22:11 INFO - PROCESS | 19742 | _x_x_mozilla_page_load_details 23:22:11 INFO - PROCESS | 19742 | |i|pagename|runs| 23:22:11 INFO - PROCESS | 19742 | |0;dojo.html;3144.2296637323852;3155.3689262147577;3188.5057816038493;3194.3770964661885;3226.064441312019;5050.520200580948;5113.105206588846;5143.922841157381;5150.896982060362;5184.196449550316;5158.2004789257635;5160.3033590465275;5177.689338639684;5191.948080519193;5195.714235717034;4663.860084197479;4735.573798358147;4804.567588916997;4817.22924332107;4835;4586.082783443308;4702.083093796711;4767.237242041274;4787;4895.36360273164;4721.787519561593;4727.621790256771;4742.573168414825;4759.61923046159;4760.309755085511;4720.575148236675;4732.952670473285;4747.786349614275;4761.714297142183;4773.952260477386;4631.328457373662;4719.4100737407825;4734.360861283717;4773.832915847964;4808.807647694088;4954.232094025432;4975.303457515951;4999.100161970844;5006.524380183877;5029.4216165141115;5416.729163541807;5520.227168196456;5524.530414914737;5528.281323427928;5536.806211782568;5519.806806761784;5527.474889885454;5543.501084902378;5551.250581171571;5604.075327570946;5209;5211.374635043819;5212.270282160501;5212.739363031833;5213.165893457029;5576.86057848557;5661.830145095571;5665.093585026376;5672.035753921843;5674.489295963301;5433.8369848904595;5497.45025497455;5506.889862202734;5508.228847961289;5527.806526771544;5534.501894829485;5583;5586.245856809279;5588.720563971785;5589.161625756169;5439.728013599304;5445.210444485528;5531.363893152258;5535.225068490415;5592.944070559323;5536.058869992111;5541.113421852484;5544.528715059185;5551.3893471718075;5555.861103472445;4306.978465107654;4313.568643135662;4317.827286908551;4318.913621727548;4354;3794.2221844521805;3861.5366156061455;3875.4961854958674;3887.5140607424073;3920.9413458366653;5155.625541923741;5159.458256883048;5162.92255616166;5165.638405311667;5205.193195054772;5565.443455654402;5569.916451253234;5572.219889215513;5574.498295153456;5579.38626751057;5044.545990860766;5116.386033675983;5120.385553733576;5158.74206289684;5189.481051894856;4779.545943135397;4814.15752243356;4817.349657796222;4835.6131509479155;4857.368542089505;5528.530074943595;5755.309362876398;5787;5788.565857560699;5793.768249269982;5414.187871819258;5526.088195447706;5537.2524709165355;5541.5289700375915;5593.804216852391;5718.22803921482;5742.598018138858;5743.827685169452;5748.6838223898085;5762;5268.81559145428;5336.546393556591;5499.312585926759;5500.339959204921;5510.972445137749;5548.167774833807;5571.526420254162;5581.469760372758;5583.972080139736;5633.098704207471;5382.650127741685;5414.35027796667;5421;5421.566274697936;5423.213634023124;5273.34083239595;5382.3541175059245;5399.352077750695;5404.972975135256;5449.100898351886;5371.382291036581;5371.731413429391;5379.1662292344745;5382.596305277041;5383.407825139153;5430.891382172414;5442.8639284016635;5473.370562385217;5481.75332110048;5525.972370138124;5193.324867767166;5257.211418287287;5375.274337964481;5389.973050134724;5429.837104886859 23:22:11 INFO - PROCESS | 19742 | |1;ext.html;532.6937011218549;536.2733496112769;542.6689719271244;554.6422557450446;558.416454804729;28446.857765711167;29201.85399073007;39576.604233957616;39938.20123597526;40222.396664050066;43803.561964380344;44321;44340.3348949766;44377.55622443774;44432.3335149973;8787.297016238701;8905.198532132106;8972.282217422591;8982.64069437225;8984.910150898506;8807.339449541278;8901.554922253894;8935.106489351045;8953.955230223872;8958;8887.422317549372;8933.330000249975;8962.86555701665;8978.23684986777;9007.639694412215;8856.247218986395;8941.418807777474;8946.329025323063;8952.14954579314;8953.910460895373;8859.867101993475;9014.819703605892;9016.504092274923;9017.098290170996;9025.41334813235;39808;40046.799766000986;40249.798751006354;40430;40460.79769601133;3285.8685652573868;3297.9010629681147;3413.7098346640564;3549.361114999299;4070.0028493019104;30341.393172136653;30405.087847364615;30580.235494112603;31066.37867242665;32133.196670083435;4015.819288132041;4053.2906741320153;4056.545789797189;4107.794610269475;4150.792460376999;258060;260816;261920;261963;262020;54013;54697;59250;60059;60733.69633151806;54261.1860822088;54265.45734542683;54385;54457.72771136119;54497.45502545003;13756.587302380945;13921.721565568834;13931.303434828218;13983.300834958414;14029.088109272865;10941.835872461761;11252.718682033015;11253.887461125447;11264;11283.040941520063;19375.12811923467;19394.515137121685;19397.51506212328;19399.127039283267;19562.8043719561;7149.499535032602;7338.972543843866;7382;7462.738804141829;7499.737509187153;1035.53400969564;1051.7107795356337;1055.4880882772004;1059.1685526861531;1080.1628737728324;28730.281742956176;28850;29050.27374315659;29179;29249.707502925125;1078.396098185019;1083.5286650307141;1099.8295264233896;1110.3781882146025;1138.317009794117;14281.500147494995;14463.204523751085;14633.952281022788;14664.266786660837;14767.778483322758;311782;316863;317469;317934;318082;45714.54285457103;51782.48217517852;51929.48070519322;52137;52141;1341.9798703019462;1349.0556610372778;1350.1898860683707;1356.4980957045957;1366.1461586508433;27287.181384558495;28362.574561382007;29184.708152919047;29247.85376073106;29750.404991900472;47446.96700780472;47953;48061.27908081312;48132.75933620449;48148.27777583269;246513;246559;246602;248199;248218;30527.847360763055;30637.540436893018;30888.38223235478;30904.0728778137;31219.37561248808;43365.34951975786;43455;44047.339289910036;44249.77875110604;44486;37103.81448092742;37225.81387093047;37941;38035.619643803206;38202;36434.27131457409;37111.25777484489;37312.626873730915;37682.246355072195;37753.24493510169;36927.261454771295;36967.26065478729;37724.245515088995;37755;38014.61985380111;31783.52324715085;33170.83414582912;33258.83370583132;33416.67789572381;33868.49197262093;25398.619020714334;25755.227343179733;25779.355516112246;26005.869970650027;26146.477070458866 23:22:11 INFO - PROCESS | 19742 | |2;jquery.html;360.5259084304142;364.61715199041;365.78235949609973;366.1012215012145;366.22360595537464;13699.041067125305;13971.720565588683;16285.185740712961;17853.285868565257;18675.346362877302;11026.44867756611;11433.942830285858;16158.515244542654;16372;16387.180640967934;4664.486906440289;4789;4819.807207711688;4825.662203645747;4827.058723548909;3772.735908486407;4770.2606096055;5180.300659410969;5360.624756267063;5374;5350.143976963686;5357.4106848246665;5378.8924221515545;5382.381026182;5489.917651235215;5994.820155395345;5996.8500787480225;6000.33996260411;6001.129836173752;6009.879802403972;5123.1546794778815;5237.711925844077;5255.264263003144;5288.444713305124;5293.020791153611;13094.279814610192;13182.274974876378;16069.758953615705;20244.089015994316;20261.594768104704;2245.4498647831224;2279.4073540879326;2387.033251533132;2622.55416579182;2832.61759662445;9565.091316324939;9656.90343096567;9785.26610504208;10445.425501597409;13306.733865322736;1828.9817101828944;1866.0669665167416;1875.756151700284;1886.1606585069649;1895.6682580548486;59113.704431478;59121.70439147777;61882;62138.37861621416;63581.999999999534;10188.796224075477;10351.844722329171;10363.792724145474;10430.16558675304;10511.684649460529;13753.312334383241;13832.100913440594;13838.446462141603;13853.515126970507;13864.197654304875;7324.414046876237;7382.18795932447;7736.149023607399;7886;7891.171427000198;7570.470067095361;7608.467407281437;7614.543127412373;7615.6953721850505;7634.541927484369;4072.124493233969;4490.887727806766;4510.21071312519;4517.41273634432;4581.748003859753;1785.4911350265113;1787.294018862568;1854.1100271869577;1858.1173942377263;1861.7300491428666;943.7687766497252;955.3837774635322;976.2677991506371;989.1641562879355;1024.9846252306222;15648.608784780245;15950.157622045328;16550.42073527421;16708.6658266834;17030.829691702926;968.9563969621383;1004.2668851738126;1028.6194108179873;1057.5875408590655;1074.2050882347164;6794.286599906938;9374.437533747998;9722.75693107678;9726.36778609388;9860.556274967643;366110;370827;372798;373593;505753;71333;72912.63543682247;73837;74185;77791;1190.743990042145;1191.0709646475764;1212.6847019774746;1236.5981056156786;1255.152771878978;15017.098974061591;15296.617584560476;15401.768973465183;15437.459688910834;15558.222088895283;33260;33642;33739.49390759091;33916.49125263074;34944.126396840285;47495.525044750495;48277;48412;49805.75097124636;49834.25248621346;7457;7515.098188217449;7670.961645191738;7714.190010048864;7735.303822655988;7718.0822642903595;9915.355501892354;10051;10569.682909512727;11597.18819682614;8971.282297416321;9727.805443891224;9834.803303933739;9847.015298470382;9909;3141.1675905884504;7405.9629701851145;9506.621539876542;9517.571709273238;10379.169666426818;7188.712451501881;7298.525595836254;7405.074365704287;10010.849837252592;10182.083612474913;9446.480443575394;10340.431276279876;10362.4259986754;10828.18788590843;10886.856880027482;10164.89835101669;10194.490275486345;10367.896321036693;10479.266451348638;10530.57877684884 23:22:11 INFO - PROCESS | 19742 | |3;mootools.html;1346.2393747532637;1491.0978857791035;1520.3918432626951;1714.528504661218;1878.3707458001568;6779.559328643635;7420.109586849579;7598.088229412464;7599.126100498437;7600.429967752427;7391.408687305016;7574.166841647429;7585.5069420487625;7585.544867307965;7595.278448547393;1964.0965156028244;2014.2949967511327;2015.0428546440396;2254.199759085526;2298.425393651587;2003.4390370696228;2227.9554408911813;2285.2116019973164;2288.599495088361;2289.461976435536;2194.572058448603;2204.7684993075654;2227.9108835646634;2255.9436014099615;2257.5372048730055;2244.7979681828715;2282.4522114692522;2285.885705714716;2286.47411095449;2290.0267386360815;2274.6588011798362;2277.5103352779065;2278.0659929428853;2278.9316320510247;2289.8511596746157;7768.611569421563;7823.726169584037;7824.921750782533;7837;7866.174051724601;4774.355462012619;4871.2206047032305;4872.439669438025;4881.511848815126;4882.048000639877;3077.8461076946064;3121.9687803121906;3141.104785136225;3149.5590617313596;3152.4640811062172;938.8732521109631;947.9715608531686;1861.3485280151974;1915.6073005033934;1940.9126589303373;10346.12057975073;10475.371477711362;10478.109360704273;10492.265541412104;10515.894841051568;4342.413774140514;4433.091216300651;4482.125985432809;4512.638988880882;4554.27131658933;9351.298652601083;9363.0168832273;9368.2973776967;9371.437713737198;9395.483248421266;4962.478939711351;4990.451050384455;4993.101241776442;4999.625028122905;5004.899902001939;4503.414556107685;4545.272756358967;4547.226971414867;4547.47704014036;4549.249373853343;3344.364570731553;3627.6553727395853;3669.339518886626;3717.1636381813873;3750.8124593770203;1186.2763714134371;1225.136278923357;1226.8037114061885;1230.7661544306732;1232.6302109367155;1307.9934600326937;1311.7901135818224;1322.6627210061565;1323.2920387592592;1353.9796903046463;7077.009218709385;7131.964340178266;7168.426525877917;7172.784816455514;7173.748918787922;1121.506537123663;1122.0630773304383;1124.1793490751797;1126.4424110065406;1152.654203738875;5617.41017193197;5674.4892959633835;5689.260396148474;5695.288088988877;5699.287589051369;8934.73195804127;9073.13805188506;9307.488088155216;9331.860022099674;9382.437053776795;9127.589258483384;9191.402558833654;9214.401063930824;9258.21305189053;9260.490673012915;7149.285071492913;7280.708771649181;7292.635368231673;7355.374793142642;7371.5945622990175;7014.5440546364325;7060.293970602898;7073.151221853204;7073.257307982588;7075.893861591977;8089;8237.588120593826;8242.752717418487;8261.049979252462;8409.369297302605;8464.915350846413;8486.787830304293;8640.913590864011;8708;8710.520921349387;6687.598744075371;6950.721971121301;6956.339147780953;6957;6961.095057642474;6512.381323774234;7081.82295442618;7232;7423.777286681408;7512.699492020258;6874;6894.448444124358;6982.615956122462;6988.126484189476;7000.929990700231;6663.13379260693;6776.424003959719;6813.488988325995;6885.793426197222;6914.343137401939;6754.459643228432;6889.965550172217;6894.620795856276;6897.620630865351;6899.6205208712;6267.310595834546;6283.937160628518;6332;6333.366663333814;6372.044193370846;6338.302786693368;6343.175387199634;6385.712642931172;6390.93609063922;6396.93603063982 23:22:11 INFO - PROCESS | 19742 | |4;prototype.html;333.1006283035804;340.86876552527275;341.73856999395457;342.6984253856606;349.8932825488225;5776.682282474462;5790.797322093727;5800.071988481844;5832.475077243047;5867.7066146692705;5495.368032676243;5610.551155907528;5647.717614119299;5690.687012214326;5781.913271300934;4481.417415735949;4494.617957473619;4512;4512.638988880882;4532.818687252506;4303.33298338758;4513.232750432418;4516.977415112936;4530;4534.1158474097565;4338.58783415575;4436.511983681792;4445.933311000337;4466.776661166945;4476.395686582318;4403.735775853459;4408.030233348658;4416.492103408117;4429.977850110745;4441.089576636782;3918.4122381642696;3922.2743792398496;3928.764274143532;3931.233409485123;3931.3120203964477;5460.044492213887;5516.117421212587;5543.916841247385;5551.056320425538;5553.944460555424;5207.323048003773;5216.58267338612;5218.582513398919;5219.399769026572;5223.895522089537;6082.8783424331705;6111.113888486145;6130.325664176937;6130.816075517697;6144.17053697754;4339.869803905888;4349.760763158025;4352.541898464018;4352.7605981670995;4356.302991521373;6294.779682711083;6418.775342863024;6428.582142160744;6433.388828061374;6446.387593178687;4527.7509736964785;4531.84138555149;4533.9319910201375;4537.6143027842345;4538.636909047268;4594.908101838011;4598.471175814824;4601.654875884322;4601.884952876205;4602.539746025371;5211.635185537052;5222.686638801684;5223.399309079428;5224.92162617561;5231.24146998683;6091.878162436727;6194.938050619527;6200.286966998853;6205.596636218631;6208.875822483525;1581.343742346936;1581.7152912475865;1583.2716950202805;1584.8098228212689;1586.6588683433117;1094.4965315954591;1108.4956344863228;1109.9223054386116;1131.971700707489;1132.1961407400672;5822.825315240465;5825.679587622722;5850.5904586678525;5862.589618726648;5871.911921321183;6370.331115232926;6372.012338087604;6380.074889141141;6387.776427825004;6393.808185754435;5678.858028549319;5726.942730572724;5826.82519524415;5910.911336329958;5915.08316210988;3426.9314613708084;3463.5324231228965;3472.166679996833;3476.165720227127;3477.3045390921916;6641.203055633258;6643.966780166165;6663.900041499382;6670.199576050808;6676.9666151668935;6437.2918978912285;6589.17635295588;6635;6638.17022872141;6647.036179754005;6691.79924602253;6693.09643198162;6694.832629184212;6703.329667033355;6711.496637752188;6463.7737679181;6502.057201705821;6519.837004074936;6521.706523206372;6525.673716314071;6249.593776404701;6340.809775706736;6349.523785716182;6353.491720662429;6377.17096777416;6664.166979127609;6683.398494135551;6694.196696396269;6696.19645642526;6705.698243579148;4402.207602631557;4406.272964960745;4440;4447.066116115652;4448.199324121689;6232.532560057924;6434.227892652912;6448.29068802422;6460.192475940507;6463.385978332051;6282.026285925689;6297.055441683784;6299.842503937438;6300.432961033529;6305.716242769178;6279.215098112736;6279.717412716347;6280.874382512233;6282.308946016026;6282.748690052346;6063.939360606514;6152.876942461216;6166.568340216142;6168.414000669929;6170.876582468415;6280.9685951569945;6285.465735412541;6291.528135389773;6292.087647291209;6302.5588208826775;6123.510119190365;6138.9386106140155;6146.78486252979;6146.938530614637;6147.66187859672 23:22:11 INFO - PROCESS | 19742 | |5;yui.html;731.6305265840749;823.0617096509977;825.9752207433779;830.6718846055807;831.7089018843405;13655.31723413829;13936.163830170197;13951.651208719788;13958;13964.930175349122;14189.290535473237;14413.207273599948;14432.13407195569;14435.494757683484;14448.494302699408;678.3623394009616;823.1274848660424;831.9251267385933;833.5332213960202;833.6332013913858;687.8933765266391;816.8366326734647;824.6948629007246;829.4194064155085;833.8457385383693;854.7563944275882;862.3360012790148;862.6678728689437;864.006392648453;864.0150228739242;700.5586480517267;833.4124442268186;853.2235665544356;853.3770347646222;865.0830120072743;638.1034646321879;638.3233772201481;638.86903184847;639.4085470939362;639.5970538560723;12994.28531430771;13231.867681323256;13232.338383080903;13247.735045299136;13265.071444998854;12646.620601381974;12956.157849739737;13035;13289.534866279633;13488.5279015234;10569.894301056967;10700.357978521313;10731.302465339728;11794.410279486077;11995.64013079609;4353.869383918487;4430.446194225722;4439.644828413751;4555.04344087742;4561.475430325522;44974.55025449769;45245.321320180556;45322.32016519755;45523.77238113822;45821;9978.850317245247;10284.845727314096;10580;10813.513391897384;10927.617533386452;18885.43343699691;18956.715649265272;18960.905195473933;18964.905175474036;18979.145938432805;7820.178881217504;7960.84078318442;7965.8805117923275;7971.123176450702;7985.640646170937;4349.608535231844;4390.165868484977;4573.108243892476;4675.392199014106;4684.1334353144775;3144.0410674743966;3148.0870547541413;3148.480500717402;3155.8422078896424;3227.4190645684002;596.0939372154388;602.0698021556706;604.5133667397787;615.5783288447428;619.8171539395889;554.814137264021;626.9122322874802;667.7762949411904;697.3514631392752;705.1925545250659;7700.268474494914;8223.465474744242;8324;8499.532525711145;8560.657573696983;564.1903867949505;623.9438450539474;653.7417720000573;657.7303305644663;709.51752808091;3937.704672149543;4083.270579842236;4226.788660566959;4283.828646854091;4297.957020429818;56780.148297775566;57216;57679;57735.71132144312;57867;49011.50988490141;49491.50508494869;49792.50207497951;49847.50152498428;50436;45561.54438455639;45752.771236144275;45900;45971.540284596726;46378.76810615925;8309.95845020771;8492.363072769444;8657.567121644019;8712.607932642919;9079.727608171765;33811.83094084514;34210.31579368449;35024.47463288002;35412.29175416426;35824.64175358213;43899.34150987802;44104.7794761037;44673.63563262548;44793.552064478936;45104.548954511345;10886.129109671048;10997.725056873642;11074.778504430027;11210;11371.601993930173;12102.394880255775;12160;12342.938285308515;12745.219920933188;12770.61688149357;11476.598319058792;11510.136739744385;11553.884461155618;12057.216280941711;12444.564440244549;9789.951050244703;10193.23550733683;10237.129843963347;10393;10438.843417348899;11538.307701537935;11544.19190656646;11574.6527604172;11665.24175928562;11892.940535297268;9203.263738900738;9368.531573421165;9439.811203776024;9549.856752148862;9635.710928672152;8836.513991730517;9249.30630202724;9333;9417.952910235404;9532.571034303612 23:22:11 INFO - PROCESS | 19742 | __end_tp_report 23:22:11 INFO - PROCESS | 19742 | __start_cc_report 23:22:11 INFO - PROCESS | 19742 | _x_x_mozilla_cycle_collect,881 23:22:11 INFO - PROCESS | 19742 | __end_cc_report 23:22:11 INFO - PROCESS | 19742 | __startTimestamp1454829731006__endTimestamp 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | ------- Summary: start ------- 23:22:11 INFO - PROCESS | 19742 | Number of tests: 6 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#0] dojo.html Cycles:165 Average:5155.10 Median:5375.27 stddev:550.03 (10.2%) stddev-sans-first:528.61 23:22:11 INFO - PROCESS | 19742 | Values: 3144.2 3155.4 3188.5 3194.4 3226.1 5050.5 5113.1 5143.9 5150.9 5184.2 5158.2 5160.3 5177.7 5191.9 5195.7 4663.9 4735.6 4804.6 4817.2 4835.0 4586.1 4702.1 4767.2 4787.0 4895.4 4721.8 4727.6 4742.6 4759.6 4760.3 4720.6 4733.0 4747.8 4761.7 4774.0 4631.3 4719.4 4734.4 4773.8 4808.8 4954.2 4975.3 4999.1 5006.5 5029.4 5416.7 5520.2 5524.5 5528.3 5536.8 5519.8 5527.5 5543.5 5551.3 5604.1 5209.0 5211.4 5212.3 5212.7 5213.2 5576.9 5661.8 5665.1 5672.0 5674.5 5433.8 5497.5 5506.9 5508.2 5527.8 5534.5 5583.0 5586.2 5588.7 5589.2 5439.7 5445.2 5531.4 5535.2 5592.9 5536.1 5541.1 5544.5 5551.4 5555.9 4307.0 4313.6 4317.8 4318.9 4354.0 3794.2 3861.5 3875.5 3887.5 3920.9 5155.6 5159.5 5162.9 5165.6 5205.2 5565.4 5569.9 5572.2 5574.5 5579.4 5044.5 5116.4 5120.4 5158.7 5189.5 4779.5 4814.2 4817.3 4835.6 4857.4 5528.5 5755.3 5787.0 5788.6 5793.8 5414.2 5526.1 5537.3 5541.5 5593.8 5718.2 5742.6 5743.8 5748.7 5762.0 5268.8 5336.5 5499.3 5500.3 5511.0 5548.2 5571.5 5581.5 5584.0 5633.1 5382.7 5414.4 5421.0 5421.6 5423.2 5273.3 5382.4 5399.4 5405.0 5449.1 5371.4 5371.7 5379.2 5382.6 5383.4 5430.9 5442.9 5473.4 5481.8 5526.0 5193.3 5257.2 5375.3 5390.0 5429.8 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#1] ext.html Cycles:180 Average:44805.05 Median:37168.54 stddev:72080.23 (193.9%) stddev-sans-first:72205.78 23:22:11 INFO - PROCESS | 19742 | Values: 532.7 536.3 542.7 554.6 558.4 28446.9 29201.9 39576.6 39938.2 40222.4 43803.6 44321.0 44340.3 44377.6 44432.3 8787.3 8905.2 8972.3 8982.6 8984.9 8807.3 8901.6 8935.1 8954.0 8958.0 8887.4 8933.3 8962.9 8978.2 9007.6 8856.2 8941.4 8946.3 8952.1 8953.9 8859.9 9014.8 9016.5 9017.1 9025.4 39808.0 40046.8 40249.8 40430.0 40460.8 3285.9 3297.9 3413.7 3549.4 4070.0 30341.4 30405.1 30580.2 31066.4 32133.2 4015.8 4053.3 4056.5 4107.8 4150.8 258060.0 260816.0 261920.0 261963.0 262020.0 54013.0 54697.0 59250.0 60059.0 60733.7 54261.2 54265.5 54385.0 54457.7 54497.5 13756.6 13921.7 13931.3 13983.3 14029.1 10941.8 11252.7 11253.9 11264.0 11283.0 19375.1 19394.5 19397.5 19399.1 19562.8 7149.5 7339.0 7382.0 7462.7 7499.7 1035.5 1051.7 1055.5 1059.2 1080.2 28730.3 28850.0 29050.3 29179.0 29249.7 1078.4 1083.5 1099.8 1110.4 1138.3 14281.5 14463.2 14634.0 14664.3 14767.8 311782.0 316863.0 317469.0 317934.0 318082.0 45714.5 51782.5 51929.5 52137.0 52141.0 1342.0 1349.1 1350.2 1356.5 1366.1 27287.2 28362.6 29184.7 29247.9 29750.4 47447.0 47953.0 48061.3 48132.8 48148.3 246513.0 246559.0 246602.0 248199.0 248218.0 30527.8 30637.5 30888.4 30904.1 31219.4 43365.3 43455.0 44047.3 44249.8 44486.0 37103.8 37225.8 37941.0 38035.6 38202.0 36434.3 37111.3 37312.6 37682.2 37753.2 36927.3 36967.3 37724.2 37755.0 38014.6 31783.5 33170.8 33258.8 33416.7 33868.5 25398.6 25755.2 25779.4 26005.9 26146.5 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#2] jquery.html Cycles:180 Average:23841.63 Median:373195.50 stddev:66039.26 (17.7%) stddev-sans-first:66200.98 23:22:11 INFO - PROCESS | 19742 | Values: 360.5 364.6 365.8 366.1 366.2 13699.0 13971.7 16285.2 17853.3 18675.3 11026.4 11433.9 16158.5 16372.0 16387.2 4664.5 4789.0 4819.8 4825.7 4827.1 3772.7 4770.3 5180.3 5360.6 5374.0 5350.1 5357.4 5378.9 5382.4 5489.9 5994.8 5996.9 6000.3 6001.1 6009.9 5123.2 5237.7 5255.3 5288.4 5293.0 13094.3 13182.3 16069.8 20244.1 20261.6 2245.4 2279.4 2387.0 2622.6 2832.6 9565.1 9656.9 9785.3 10445.4 13306.7 1829.0 1866.1 1875.8 1886.2 1895.7 59113.7 59121.7 61882.0 62138.4 63582.0 10188.8 10351.8 10363.8 10430.2 10511.7 13753.3 13832.1 13838.4 13853.5 13864.2 7324.4 7382.2 7736.1 7886.0 7891.2 7570.5 7608.5 7614.5 7615.7 7634.5 4072.1 4490.9 4510.2 4517.4 4581.7 1785.5 1787.3 1854.1 1858.1 1861.7 943.8 955.4 976.3 989.2 1025.0 15648.6 15950.2 16550.4 16708.7 17030.8 969.0 1004.3 1028.6 1057.6 1074.2 6794.3 9374.4 9722.8 9726.4 9860.6 366110.0 370827.0 372798.0 373593.0 505753.0 71333.0 72912.6 73837.0 74185.0 77791.0 1190.7 1191.1 1212.7 1236.6 1255.2 15017.1 15296.6 15401.8 15437.5 15558.2 33260.0 33642.0 33739.5 33916.5 34944.1 47495.5 48277.0 48412.0 49805.8 49834.3 7457.0 7515.1 7671.0 7714.2 7735.3 7718.1 9915.4 10051.0 10569.7 11597.2 8971.3 9727.8 9834.8 9847.0 9909.0 3141.2 7406.0 9506.6 9517.6 10379.2 7188.7 7298.5 7405.1 10010.8 10182.1 9446.5 10340.4 10362.4 10828.2 10886.9 10164.9 10194.5 10367.9 10479.3 10530.6 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#3] mootools.html Cycles:180 Average:5441.83 Median:6332.68 stddev:2744.68 (43.3%) stddev-sans-first:2735.11 23:22:11 INFO - PROCESS | 19742 | Values: 1346.2 1491.1 1520.4 1714.5 1878.4 6779.6 7420.1 7598.1 7599.1 7600.4 7391.4 7574.2 7585.5 7585.5 7595.3 1964.1 2014.3 2015.0 2254.2 2298.4 2003.4 2228.0 2285.2 2288.6 2289.5 2194.6 2204.8 2227.9 2255.9 2257.5 2244.8 2282.5 2285.9 2286.5 2290.0 2274.7 2277.5 2278.1 2278.9 2289.9 7768.6 7823.7 7824.9 7837.0 7866.2 4774.4 4871.2 4872.4 4881.5 4882.0 3077.8 3122.0 3141.1 3149.6 3152.5 938.9 948.0 1861.3 1915.6 1940.9 10346.1 10475.4 10478.1 10492.3 10515.9 4342.4 4433.1 4482.1 4512.6 4554.3 9351.3 9363.0 9368.3 9371.4 9395.5 4962.5 4990.5 4993.1 4999.6 5004.9 4503.4 4545.3 4547.2 4547.5 4549.2 3344.4 3627.7 3669.3 3717.2 3750.8 1186.3 1225.1 1226.8 1230.8 1232.6 1308.0 1311.8 1322.7 1323.3 1354.0 7077.0 7132.0 7168.4 7172.8 7173.7 1121.5 1122.1 1124.2 1126.4 1152.7 5617.4 5674.5 5689.3 5695.3 5699.3 8934.7 9073.1 9307.5 9331.9 9382.4 9127.6 9191.4 9214.4 9258.2 9260.5 7149.3 7280.7 7292.6 7355.4 7371.6 7014.5 7060.3 7073.2 7073.3 7075.9 8089.0 8237.6 8242.8 8261.0 8409.4 8464.9 8486.8 8640.9 8708.0 8710.5 6687.6 6950.7 6956.3 6957.0 6961.1 6512.4 7081.8 7232.0 7423.8 7512.7 6874.0 6894.4 6982.6 6988.1 7000.9 6663.1 6776.4 6813.5 6885.8 6914.3 6754.5 6890.0 6894.6 6897.6 6899.6 6267.3 6283.9 6332.0 6333.4 6372.0 6338.3 6343.2 6385.7 6390.9 6396.9 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#4] prototype.html Cycles:180 Average:5205.22 Median:5824.25 stddev:1557.26 (26.7%) stddev-sans-first:1518.08 23:22:11 INFO - PROCESS | 19742 | Values: 333.1 340.9 341.7 342.7 349.9 5776.7 5790.8 5800.1 5832.5 5867.7 5495.4 5610.6 5647.7 5690.7 5781.9 4481.4 4494.6 4512.0 4512.6 4532.8 4303.3 4513.2 4517.0 4530.0 4534.1 4338.6 4436.5 4445.9 4466.8 4476.4 4403.7 4408.0 4416.5 4430.0 4441.1 3918.4 3922.3 3928.8 3931.2 3931.3 5460.0 5516.1 5543.9 5551.1 5553.9 5207.3 5216.6 5218.6 5219.4 5223.9 6082.9 6111.1 6130.3 6130.8 6144.2 4339.9 4349.8 4352.5 4352.8 4356.3 6294.8 6418.8 6428.6 6433.4 6446.4 4527.8 4531.8 4533.9 4537.6 4538.6 4594.9 4598.5 4601.7 4601.9 4602.5 5211.6 5222.7 5223.4 5224.9 5231.2 6091.9 6194.9 6200.3 6205.6 6208.9 1581.3 1581.7 1583.3 1584.8 1586.7 1094.5 1108.5 1109.9 1132.0 1132.2 5822.8 5825.7 5850.6 5862.6 5871.9 6370.3 6372.0 6380.1 6387.8 6393.8 5678.9 5726.9 5826.8 5910.9 5915.1 3426.9 3463.5 3472.2 3476.2 3477.3 6641.2 6644.0 6663.9 6670.2 6677.0 6437.3 6589.2 6635.0 6638.2 6647.0 6691.8 6693.1 6694.8 6703.3 6711.5 6463.8 6502.1 6519.8 6521.7 6525.7 6249.6 6340.8 6349.5 6353.5 6377.2 6664.2 6683.4 6694.2 6696.2 6705.7 4402.2 4406.3 4440.0 4447.1 4448.2 6232.5 6434.2 6448.3 6460.2 6463.4 6282.0 6297.1 6299.8 6300.4 6305.7 6279.2 6279.7 6280.9 6282.3 6282.7 6063.9 6152.9 6166.6 6168.4 6170.9 6281.0 6285.5 6291.5 6292.1 6302.6 6123.5 6138.9 6146.8 6146.9 6147.7 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - PROCESS | 19742 | [#5] yui.html Cycles:180 Average:13798.19 Median:25162.94 stddev:15620.73 (62.1%) stddev-sans-first:15633.73 23:22:11 INFO - PROCESS | 19742 | Values: 731.6 823.1 826.0 830.7 831.7 13655.3 13936.2 13951.7 13958.0 13964.9 14189.3 14413.2 14432.1 14435.5 14448.5 678.4 823.1 831.9 833.5 833.6 687.9 816.8 824.7 829.4 833.8 854.8 862.3 862.7 864.0 864.0 700.6 833.4 853.2 853.4 865.1 638.1 638.3 638.9 639.4 639.6 12994.3 13231.9 13232.3 13247.7 13265.1 12646.6 12956.2 13035.0 13289.5 13488.5 10569.9 10700.4 10731.3 11794.4 11995.6 4353.9 4430.4 4439.6 4555.0 4561.5 44974.6 45245.3 45322.3 45523.8 45821.0 9978.9 10284.8 10580.0 10813.5 10927.6 18885.4 18956.7 18960.9 18964.9 18979.1 7820.2 7960.8 7965.9 7971.1 7985.6 4349.6 4390.2 4573.1 4675.4 4684.1 3144.0 3148.1 3148.5 3155.8 3227.4 596.1 602.1 604.5 615.6 619.8 554.8 626.9 667.8 697.4 705.2 7700.3 8223.5 8324.0 8499.5 8560.7 564.2 623.9 653.7 657.7 709.5 3937.7 4083.3 4226.8 4283.8 4298.0 56780.1 57216.0 57679.0 57735.7 57867.0 49011.5 49491.5 49792.5 49847.5 50436.0 45561.5 45752.8 45900.0 45971.5 46378.8 8310.0 8492.4 8657.6 8712.6 9079.7 33811.8 34210.3 35024.5 35412.3 35824.6 43899.3 44104.8 44673.6 44793.6 45104.5 10886.1 10997.7 11074.8 11210.0 11371.6 12102.4 12160.0 12342.9 12745.2 12770.6 11476.6 11510.1 11553.9 12057.2 12444.6 9790.0 10193.2 10237.1 10393.0 10438.8 11538.3 11544.2 11574.7 11665.2 11892.9 9203.3 9368.5 9439.8 9549.9 9635.7 8836.5 9249.3 9333.0 9418.0 9532.6 23:22:11 INFO - PROCESS | 19742 | -------- Summary: end -------- 23:22:11 INFO - PROCESS | 19742 | 23:22:11 INFO - TEST-INFO | 19742: exit 0 23:22:11 INFO - TEST-OK | dromaeo_css | took 1114075ms 23:22:11 INFO - TEST-START | kraken 23:22:11 INFO - operating with platform_type : linux_ 23:22:11 INFO - Initialising browser for kraken test... 23:22:11 INFO - TEST-INFO | started process 19929 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkHF8IS/profile http://localhost:56552/getInfo.html) 23:22:16 INFO - PROCESS | 19929 | __metrics Screen width/height:1600/1200 23:22:16 INFO - PROCESS | 19929 | colorDepth:24 23:22:16 INFO - PROCESS | 19929 | Browser inner width/height: 1024/697 23:22:16 INFO - PROCESS | 19929 | __metrics 23:22:16 INFO - PROCESS | 19929 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:17 INFO - TEST-INFO | 19929: exit 0 23:22:17 INFO - Browser initialized. 23:22:17 INFO - Running cycle 1/1 for kraken test... 23:22:17 INFO - TEST-INFO | started process 20009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkHF8IS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:29 INFO - PROCESS | 20009 | RSS: Main: 150806528 23:22:29 INFO - PROCESS | 20009 | 23:22:31 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56552/tests/kraken/driver.html?testName=audio-beat-detection) 23:22:32 INFO - PROCESS | 20009 | RSS: Main: 192995328 23:22:32 INFO - PROCESS | 20009 | 23:22:34 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56552/tests/kraken/driver.html?testName=audio-dft) 23:22:35 INFO - PROCESS | 20009 | RSS: Main: 182444032 23:22:35 INFO - PROCESS | 20009 | 23:22:38 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56552/tests/kraken/driver.html?testName=audio-fft) 23:22:38 INFO - PROCESS | 20009 | RSS: Main: 165863424 23:22:38 INFO - PROCESS | 20009 | 23:22:40 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56552/tests/kraken/driver.html?testName=audio-oscillator) 23:22:41 INFO - PROCESS | 20009 | RSS: Main: 169058304 23:22:41 INFO - PROCESS | 20009 | 23:22:43 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:22:44 INFO - PROCESS | 20009 | RSS: Main: 169705472 23:22:44 INFO - PROCESS | 20009 | 23:22:47 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56552/tests/kraken/driver.html?testName=imaging-darkroom) 23:22:47 INFO - PROCESS | 20009 | RSS: Main: 169234432 23:22:47 INFO - PROCESS | 20009 | 23:22:51 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56552/tests/kraken/driver.html?testName=imaging-desaturate) 23:22:51 INFO - PROCESS | 20009 | RSS: Main: 171057152 23:22:51 INFO - PROCESS | 20009 | 23:22:54 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56552/tests/kraken/driver.html?testName=json-parse-financial) 23:22:55 INFO - PROCESS | 20009 | RSS: Main: 171470848 23:22:55 INFO - PROCESS | 20009 | 23:22:56 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:22:57 INFO - PROCESS | 20009 | RSS: Main: 180129792 23:22:57 INFO - PROCESS | 20009 | 23:22:59 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:22:59 INFO - PROCESS | 20009 | RSS: Main: 177111040 23:22:59 INFO - PROCESS | 20009 | 23:23:02 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:23:02 INFO - PROCESS | 20009 | RSS: Main: 188665856 23:23:02 INFO - PROCESS | 20009 | 23:23:05 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:23:05 INFO - PROCESS | 20009 | RSS: Main: 194027520 23:23:05 INFO - PROCESS | 20009 | 23:23:08 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:23:08 INFO - PROCESS | 20009 | RSS: Main: 194854912 23:23:08 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | Cycle 1(1): loaded http://localhost:56552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56552/tests/kraken/driver.html?testName=ai-astar) 23:23:10 INFO - PROCESS | 20009 | RSS: Main: 255655936 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | __start_tp_report 23:23:10 INFO - PROCESS | 20009 | _x_x_mozilla_page_load 23:23:10 INFO - PROCESS | 20009 | _x_x_mozilla_page_load_details 23:23:10 INFO - PROCESS | 20009 | |i|pagename|runs| 23:23:10 INFO - PROCESS | 20009 | |0;ai-astar;110;113;108;111;112;111;101;111;110;110 23:23:10 INFO - PROCESS | 20009 | |1;audio-beat-detection;161;124;153;165;130;147;157;128;164;127 23:23:10 INFO - PROCESS | 20009 | |2;audio-dft;162;160;162;160;160;161;158;164;159;159 23:23:10 INFO - PROCESS | 20009 | |3;audio-fft;74;73;89;91;73;73;74;126;96;73 23:23:10 INFO - PROCESS | 20009 | |4;audio-oscillator;97;96;138;95;97;95;141;96;96;148 23:23:10 INFO - PROCESS | 20009 | |5;imaging-gaussian-blur;119;116;116;115;114;115;114;115;115;115 23:23:10 INFO - PROCESS | 20009 | |6;imaging-darkroom;146;145;145;145;146;145;147;145;145;145 23:23:10 INFO - PROCESS | 20009 | |7;imaging-desaturate;96;95;96;96;95;96;96;96;95;96 23:23:10 INFO - PROCESS | 20009 | |8;json-parse-financial;58;59;59;67;59;57;61;66;56;57 23:23:10 INFO - PROCESS | 20009 | |9;json-stringify-tinderbox;66;78;67;67;68;67;66;67;73;67 23:23:10 INFO - PROCESS | 20009 | |10;stanford-crypto-aes;93;87;85;93;86;93;85;85;86;85 23:23:10 INFO - PROCESS | 20009 | |11;stanford-crypto-ccm;119;136;124;123;121;119;128;127;120;117 23:23:10 INFO - PROCESS | 20009 | |12;stanford-crypto-pbkdf2;154;143;151;155;152;147;153;152;153;154 23:23:10 INFO - PROCESS | 20009 | |13;stanford-crypto-sha256-iterative;72;71;71;71;69;71;70;69;71;69 23:23:10 INFO - PROCESS | 20009 | __end_tp_report 23:23:10 INFO - PROCESS | 20009 | __start_cc_report 23:23:10 INFO - PROCESS | 20009 | _x_x_mozilla_cycle_collect,974 23:23:10 INFO - PROCESS | 20009 | __end_cc_report 23:23:10 INFO - PROCESS | 20009 | __startTimestamp1454829790748__endTimestamp 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | ------- Summary: start ------- 23:23:10 INFO - PROCESS | 20009 | Number of tests: 14 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.33 (3.0%) stddev-sans-first:3.54 23:23:10 INFO - PROCESS | 20009 | Values: 110.0 113.0 108.0 111.0 112.0 111.0 101.0 111.0 110.0 110.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:155.00 stddev:16.68 (10.8%) stddev-sans-first:16.74 23:23:10 INFO - PROCESS | 20009 | Values: 161.0 124.0 153.0 165.0 130.0 147.0 157.0 128.0 164.0 127.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.78 (1.1%) stddev-sans-first:1.80 23:23:10 INFO - PROCESS | 20009 | Values: 162.0 160.0 162.0 160.0 160.0 161.0 158.0 164.0 159.0 159.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#3] audio-fft Cycles:10 Average:84.20 Median:74.00 stddev:17.21 (23.3%) stddev-sans-first:17.85 23:23:10 INFO - PROCESS | 20009 | Values: 74.0 73.0 89.0 91.0 73.0 73.0 74.0 126.0 96.0 73.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.52 (23.5%) stddev-sans-first:23.40 23:23:10 INFO - PROCESS | 20009 | Values: 97.0 96.0 138.0 95.0 97.0 95.0 141.0 96.0 96.0 148.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.43 (1.2%) stddev-sans-first:0.71 23:23:10 INFO - PROCESS | 20009 | Values: 119.0 116.0 116.0 115.0 114.0 115.0 114.0 115.0 115.0 115.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 23:23:10 INFO - PROCESS | 20009 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:23:10 INFO - PROCESS | 20009 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:59.00 stddev:3.75 (6.4%) stddev-sans-first:3.92 23:23:10 INFO - PROCESS | 20009 | Values: 58.0 59.0 59.0 67.0 59.0 57.0 61.0 66.0 56.0 57.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:67.00 stddev:3.86 (5.8%) stddev-sans-first:3.98 23:23:10 INFO - PROCESS | 20009 | Values: 66.0 78.0 67.0 67.0 68.0 67.0 66.0 67.0 73.0 67.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.50 stddev:3.65 (4.2%) stddev-sans-first:3.35 23:23:10 INFO - PROCESS | 20009 | Values: 93.0 87.0 85.0 93.0 86.0 93.0 85.0 85.0 86.0 85.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:123.50 stddev:5.68 (4.6%) stddev-sans-first:5.80 23:23:10 INFO - PROCESS | 20009 | Values: 119.0 136.0 124.0 123.0 121.0 119.0 128.0 127.0 120.0 117.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:153.00 stddev:3.69 (2.4%) stddev-sans-first:3.79 23:23:10 INFO - PROCESS | 20009 | Values: 154.0 143.0 151.0 155.0 152.0 147.0 153.0 152.0 153.0 154.0 23:23:10 INFO - PROCESS | 20009 | 23:23:10 INFO - PROCESS | 20009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.07 (1.5%) stddev-sans-first:0.97 23:23:10 INFO - PROCESS | 20009 | Values: 72.0 71.0 71.0 71.0 69.0 71.0 70.0 69.0 71.0 69.0 23:23:10 INFO - PROCESS | 20009 | -------- Summary: end -------- 23:23:10 INFO - PROCESS | 20009 | 23:23:11 INFO - TEST-INFO | 20009: exit 0 23:23:11 INFO - TEST-OK | kraken | took 60032ms 23:23:11 INFO - SUITE-END | took 1174s 23:23:11 INFO - Completed test suite (00:19:34) 23:23:11 INFO - Working with test: dromaeo_css 23:23:11 INFO - Generating results file: dromaeo_css 23:23:11 INFO - Working with test: kraken 23:23:11 INFO - Generating results file: kraken 23:23:11 INFO - javascript benchmark 23:23:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:23:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:23:12 INFO - process_Request line: dromaeo_css 6879.84 graph.html#tests=[[72,64,35]] 23:23:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:23:12 INFO - process_Request line: kraken 1527.90 graph.html#tests=[[232,64,35]] 23:23:12 INFO - RETURN: dromaeo_css: 6879.84 23:23:12 INFO - RETURN: kraken: 1527.90 23:23:12 INFO - javascript benchmark 23:23:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3144.2296637323852, 3155.3689262147577, 3188.5057816038493, 3194.3770964661885, 3226.064441312019, 5050.520200580948, 5113.105206588846, 5143.922841157381, 5150.896982060362, 5184.196449550316, 5158.2004789257635, 5160.3033590465275, 5177.689338639684, 5191.948080519193, 5195.714235717034, 4663.860084197479, 4735.573798358147, 4804.567588916997, 4817.22924332107, 4835.0, 4586.082783443308, 4702.083093796711, 4767.237242041274, 4787.0, 4895.36360273164, 4721.787519561593, 4727.621790256771, 4742.573168414825, 4759.61923046159, 4760.309755085511, 4720.575148236675, 4732.952670473285, 4747.786349614275, 4761.714297142183, 4773.952260477386, 4631.328457373662, 4719.4100737407825, 4734.360861283717, 4773.832915847964, 4808.807647694088, 4954.232094025432, 4975.303457515951, 4999.100161970844, 5006.524380183877, 5029.4216165141115, 5416.729163541807, 5520.227168196456, 5524.530414914737, 5528.281323427928, 5536.806211782568, 5519.806806761784, 5527.474889885454, 5543.501084902378, 5551.250581171571, 5604.075327570946, 5209.0, 5211.374635043819, 5212.270282160501, 5212.739363031833, 5213.165893457029, 5576.86057848557, 5661.830145095571, 5665.093585026376, 5672.035753921843, 5674.489295963301, 5433.8369848904595, 5497.45025497455, 5506.889862202734, 5508.228847961289, 5527.806526771544, 5534.501894829485, 5583.0, 5586.245856809279, 5588.720563971785, 5589.161625756169, 5439.728013599304, 5445.210444485528, 5531.363893152258, 5535.225068490415, 5592.944070559323, 5536.058869992111, 5541.113421852484, 5544.528715059185, 5551.3893471718075, 5555.861103472445, 4306.978465107654, 4313.568643135662, 4317.827286908551, 4318.913621727548, 4354.0, 3794.2221844521805, 3861.5366156061455, 3875.4961854958674, 3887.5140607424073, 3920.9413458366653, 5155.625541923741, 5159.458256883048, 5162.92255616166, 5165.638405311667, 5205.193195054772, 5565.443455654402, 5569.916451253234, 5572.219889215513, 5574.498295153456, 5579.38626751057, 5044.545990860766, 5116.386033675983, 5120.385553733576, 5158.74206289684, 5189.481051894856, 4779.545943135397, 4814.15752243356, 4817.349657796222, 4835.6131509479155, 4857.368542089505, 5528.530074943595, 5755.309362876398, 5787.0, 5788.565857560699, 5793.768249269982, 5414.187871819258, 5526.088195447706, 5537.2524709165355, 5541.5289700375915, 5593.804216852391, 5718.22803921482, 5742.598018138858, 5743.827685169452, 5748.6838223898085, 5762.0, 5268.81559145428, 5336.546393556591, 5499.312585926759, 5500.339959204921, 5510.972445137749, 5548.167774833807, 5571.526420254162, 5581.469760372758, 5583.972080139736, 5633.098704207471, 5382.650127741685, 5414.35027796667, 5421.0, 5421.566274697936, 5423.213634023124, 5273.34083239595, 5382.3541175059245, 5399.352077750695, 5404.972975135256, 5449.100898351886, 5371.382291036581, 5371.731413429391, 5379.1662292344745, 5382.596305277041, 5383.407825139153, 5430.891382172414, 5442.8639284016635, 5473.370562385217, 5481.75332110048, 5525.972370138124, 5193.324867767166, 5257.211418287287, 5375.274337964481, 5389.973050134724, 5429.837104886859], "unit": "score", "name": "dojo.html", "value": 5121.140539366774}, {"lowerIsBetter": false, "replicates": [532.6937011218549, 536.2733496112769, 542.6689719271244, 554.6422557450446, 558.416454804729, 28446.857765711167, 29201.85399073007, 39576.604233957616, 39938.20123597526, 40222.396664050066, 43803.561964380344, 44321.0, 44340.3348949766, 44377.55622443774, 44432.3335149973, 8787.297016238701, 8905.198532132106, 8972.282217422591, 8982.64069437225, 8984.910150898506, 8807.339449541278, 8901.554922253894, 8935.106489351045, 8953.955230223872, 8958.0, 8887.422317549372, 8933.330000249975, 8962.86555701665, 8978.23684986777, 9007.639694412215, 8856.247218986395, 8941.418807777474, 8946.329025323063, 8952.14954579314, 8953.910460895373, 8859.867101993475, 9014.819703605892, 9016.504092274923, 9017.098290170996, 9025.41334813235, 39808.0, 40046.799766000986, 40249.798751006354, 40430.0, 40460.79769601133, 3285.8685652573868, 3297.9010629681147, 3413.7098346640564, 3549.361114999299, 4070.0028493019104, 30341.393172136653, 30405.087847364615, 30580.235494112603, 31066.37867242665, 32133.196670083435, 4015.819288132041, 4053.2906741320153, 4056.545789797189, 4107.794610269475, 4150.792460376999, 258060.0, 260816.0, 261920.0, 261963.0, 262020.0, 54013.0, 54697.0, 59250.0, 60059.0, 60733.69633151806, 54261.1860822088, 54265.45734542683, 54385.0, 54457.72771136119, 54497.45502545003, 13756.587302380945, 13921.721565568834, 13931.303434828218, 13983.300834958414, 14029.088109272865, 10941.835872461761, 11252.718682033015, 11253.887461125447, 11264.0, 11283.040941520063, 19375.12811923467, 19394.515137121685, 19397.51506212328, 19399.127039283267, 19562.8043719561, 7149.499535032602, 7338.972543843866, 7382.0, 7462.738804141829, 7499.737509187153, 1035.53400969564, 1051.7107795356337, 1055.4880882772004, 1059.1685526861531, 1080.1628737728324, 28730.281742956176, 28850.0, 29050.27374315659, 29179.0, 29249.707502925125, 1078.396098185019, 1083.5286650307141, 1099.8295264233896, 1110.3781882146025, 1138.317009794117, 14281.500147494995, 14463.204523751085, 14633.952281022788, 14664.266786660837, 14767.778483322758, 311782.0, 316863.0, 317469.0, 317934.0, 318082.0, 45714.54285457103, 51782.48217517852, 51929.48070519322, 52137.0, 52141.0, 1341.9798703019462, 1349.0556610372778, 1350.1898860683707, 1356.4980957045957, 1366.1461586508433, 27287.181384558495, 28362.574561382007, 29184.708152919047, 29247.85376073106, 29750.404991900472, 47446.96700780472, 47953.0, 48061.27908081312, 48132.75933620449, 48148.27777583269, 246513.0, 246559.0, 246602.0, 248199.0, 248218.0, 30527.847360763055, 30637.540436893018, 30888.38223235478, 30904.0728778137, 31219.37561248808, 43365.34951975786, 43455.0, 44047.339289910036, 44249.77875110604, 44486.0, 37103.81448092742, 37225.81387093047, 37941.0, 38035.619643803206, 38202.0, 36434.27131457409, 37111.25777484489, 37312.626873730915, 37682.246355072195, 37753.24493510169, 36927.261454771295, 36967.26065478729, 37724.245515088995, 37755.0, 38014.61985380111, 31783.52324715085, 33170.83414582912, 33258.83370583132, 33416.67789572381, 33868.49197262093, 25398.619020714334, 25755.227343179733, 25779.355516112246, 26005.869970650027, 26146.477070458866], "unit": "score", "name": "ext.html", "value": 18420.88560718047}, {"lowerIsBetter": false, "replicates": [360.5259084304142, 364.61715199041, 365.78235949609973, 366.1012215012145, 366.22360595537464, 13699.041067125305, 13971.720565588683, 16285.185740712961, 17853.285868565257, 18675.346362877302, 11026.44867756611, 11433.942830285858, 16158.515244542654, 16372.0, 16387.180640967934, 4664.486906440289, 4789.0, 4819.807207711688, 4825.662203645747, 4827.058723548909, 3772.735908486407, 4770.2606096055, 5180.300659410969, 5360.624756267063, 5374.0, 5350.143976963686, 5357.4106848246665, 5378.8924221515545, 5382.381026182, 5489.917651235215, 5994.820155395345, 5996.8500787480225, 6000.33996260411, 6001.129836173752, 6009.879802403972, 5123.1546794778815, 5237.711925844077, 5255.264263003144, 5288.444713305124, 5293.020791153611, 13094.279814610192, 13182.274974876378, 16069.758953615705, 20244.089015994316, 20261.594768104704, 2245.4498647831224, 2279.4073540879326, 2387.033251533132, 2622.55416579182, 2832.61759662445, 9565.091316324939, 9656.90343096567, 9785.26610504208, 10445.425501597409, 13306.733865322736, 1828.9817101828944, 1866.0669665167416, 1875.756151700284, 1886.1606585069649, 1895.6682580548486, 59113.704431478, 59121.70439147777, 61882.0, 62138.37861621416, 63581.999999999534, 10188.796224075477, 10351.844722329171, 10363.792724145474, 10430.16558675304, 10511.684649460529, 13753.312334383241, 13832.100913440594, 13838.446462141603, 13853.515126970507, 13864.197654304875, 7324.414046876237, 7382.18795932447, 7736.149023607399, 7886.0, 7891.171427000198, 7570.470067095361, 7608.467407281437, 7614.543127412373, 7615.6953721850505, 7634.541927484369, 4072.124493233969, 4490.887727806766, 4510.21071312519, 4517.41273634432, 4581.748003859753, 1785.4911350265113, 1787.294018862568, 1854.1100271869577, 1858.1173942377263, 1861.7300491428666, 943.7687766497252, 955.3837774635322, 976.2677991506371, 989.1641562879355, 1024.9846252306222, 15648.608784780245, 15950.157622045328, 16550.42073527421, 16708.6658266834, 17030.829691702926, 968.9563969621383, 1004.2668851738126, 1028.6194108179873, 1057.5875408590655, 1074.2050882347164, 6794.286599906938, 9374.437533747998, 9722.75693107678, 9726.36778609388, 9860.556274967643, 366110.0, 370827.0, 372798.0, 373593.0, 505753.0, 71333.0, 72912.63543682247, 73837.0, 74185.0, 77791.0, 1190.743990042145, 1191.0709646475764, 1212.6847019774746, 1236.5981056156786, 1255.152771878978, 15017.098974061591, 15296.617584560476, 15401.768973465183, 15437.459688910834, 15558.222088895283, 33260.0, 33642.0, 33739.49390759091, 33916.49125263074, 34944.126396840285, 47495.525044750495, 48277.0, 48412.0, 49805.75097124636, 49834.25248621346, 7457.0, 7515.098188217449, 7670.961645191738, 7714.190010048864, 7735.303822655988, 7718.0822642903595, 9915.355501892354, 10051.0, 10569.682909512727, 11597.18819682614, 8971.282297416321, 9727.805443891224, 9834.803303933739, 9847.015298470382, 9909.0, 3141.1675905884504, 7405.9629701851145, 9506.621539876542, 9517.571709273238, 10379.169666426818, 7188.712451501881, 7298.525595836254, 7405.074365704287, 10010.849837252592, 10182.083612474913, 9446.480443575394, 10340.431276279876, 10362.4259986754, 10828.18788590843, 10886.856880027482, 10164.89835101669, 10194.490275486345, 10367.896321036693, 10479.266451348638, 10530.57877684884], "unit": "score", "name": "jquery.html", "value": 8204.711380480696}, {"lowerIsBetter": false, "replicates": [1346.2393747532637, 1491.0978857791035, 1520.3918432626951, 1714.528504661218, 1878.3707458001568, 6779.559328643635, 7420.109586849579, 7598.088229412464, 7599.126100498437, 7600.429967752427, 7391.408687305016, 7574.166841647429, 7585.5069420487625, 7585.544867307965, 7595.278448547393, 1964.0965156028244, 2014.2949967511327, 2015.0428546440396, 2254.199759085526, 2298.425393651587, 2003.4390370696228, 2227.9554408911813, 2285.2116019973164, 2288.599495088361, 2289.461976435536, 2194.572058448603, 2204.7684993075654, 2227.9108835646634, 2255.9436014099615, 2257.5372048730055, 2244.7979681828715, 2282.4522114692522, 2285.885705714716, 2286.47411095449, 2290.0267386360815, 2274.6588011798362, 2277.5103352779065, 2278.0659929428853, 2278.9316320510247, 2289.8511596746157, 7768.611569421563, 7823.726169584037, 7824.921750782533, 7837.0, 7866.174051724601, 4774.355462012619, 4871.2206047032305, 4872.439669438025, 4881.511848815126, 4882.048000639877, 3077.8461076946064, 3121.9687803121906, 3141.104785136225, 3149.5590617313596, 3152.4640811062172, 938.8732521109631, 947.9715608531686, 1861.3485280151974, 1915.6073005033934, 1940.9126589303373, 10346.12057975073, 10475.371477711362, 10478.109360704273, 10492.265541412104, 10515.894841051568, 4342.413774140514, 4433.091216300651, 4482.125985432809, 4512.638988880882, 4554.27131658933, 9351.298652601083, 9363.0168832273, 9368.2973776967, 9371.437713737198, 9395.483248421266, 4962.478939711351, 4990.451050384455, 4993.101241776442, 4999.625028122905, 5004.899902001939, 4503.414556107685, 4545.272756358967, 4547.226971414867, 4547.47704014036, 4549.249373853343, 3344.364570731553, 3627.6553727395853, 3669.339518886626, 3717.1636381813873, 3750.8124593770203, 1186.2763714134371, 1225.136278923357, 1226.8037114061885, 1230.7661544306732, 1232.6302109367155, 1307.9934600326937, 1311.7901135818224, 1322.6627210061565, 1323.2920387592592, 1353.9796903046463, 7077.009218709385, 7131.964340178266, 7168.426525877917, 7172.784816455514, 7173.748918787922, 1121.506537123663, 1122.0630773304383, 1124.1793490751797, 1126.4424110065406, 1152.654203738875, 5617.41017193197, 5674.4892959633835, 5689.260396148474, 5695.288088988877, 5699.287589051369, 8934.73195804127, 9073.13805188506, 9307.488088155216, 9331.860022099674, 9382.437053776795, 9127.589258483384, 9191.402558833654, 9214.401063930824, 9258.21305189053, 9260.490673012915, 7149.285071492913, 7280.708771649181, 7292.635368231673, 7355.374793142642, 7371.5945622990175, 7014.5440546364325, 7060.293970602898, 7073.151221853204, 7073.257307982588, 7075.893861591977, 8089.0, 8237.588120593826, 8242.752717418487, 8261.049979252462, 8409.369297302605, 8464.915350846413, 8486.787830304293, 8640.913590864011, 8708.0, 8710.520921349387, 6687.598744075371, 6950.721971121301, 6956.339147780953, 6957.0, 6961.095057642474, 6512.381323774234, 7081.82295442618, 7232.0, 7423.777286681408, 7512.699492020258, 6874.0, 6894.448444124358, 6982.615956122462, 6988.126484189476, 7000.929990700231, 6663.13379260693, 6776.424003959719, 6813.488988325995, 6885.793426197222, 6914.343137401939, 6754.459643228432, 6889.965550172217, 6894.620795856276, 6897.620630865351, 6899.6205208712, 6267.310595834546, 6283.937160628518, 6332.0, 6333.366663333814, 6372.044193370846, 6338.302786693368, 6343.175387199634, 6385.712642931172, 6390.93609063922, 6396.93603063982], "unit": "score", "name": "mootools.html", "value": 4543.276656410657}, {"lowerIsBetter": false, "replicates": [333.1006283035804, 340.86876552527275, 341.73856999395457, 342.6984253856606, 349.8932825488225, 5776.682282474462, 5790.797322093727, 5800.071988481844, 5832.475077243047, 5867.7066146692705, 5495.368032676243, 5610.551155907528, 5647.717614119299, 5690.687012214326, 5781.913271300934, 4481.417415735949, 4494.617957473619, 4512.0, 4512.638988880882, 4532.818687252506, 4303.33298338758, 4513.232750432418, 4516.977415112936, 4530.0, 4534.1158474097565, 4338.58783415575, 4436.511983681792, 4445.933311000337, 4466.776661166945, 4476.395686582318, 4403.735775853459, 4408.030233348658, 4416.492103408117, 4429.977850110745, 4441.089576636782, 3918.4122381642696, 3922.2743792398496, 3928.764274143532, 3931.233409485123, 3931.3120203964477, 5460.044492213887, 5516.117421212587, 5543.916841247385, 5551.056320425538, 5553.944460555424, 5207.323048003773, 5216.58267338612, 5218.582513398919, 5219.399769026572, 5223.895522089537, 6082.8783424331705, 6111.113888486145, 6130.325664176937, 6130.816075517697, 6144.17053697754, 4339.869803905888, 4349.760763158025, 4352.541898464018, 4352.7605981670995, 4356.302991521373, 6294.779682711083, 6418.775342863024, 6428.582142160744, 6433.388828061374, 6446.387593178687, 4527.7509736964785, 4531.84138555149, 4533.9319910201375, 4537.6143027842345, 4538.636909047268, 4594.908101838011, 4598.471175814824, 4601.654875884322, 4601.884952876205, 4602.539746025371, 5211.635185537052, 5222.686638801684, 5223.399309079428, 5224.92162617561, 5231.24146998683, 6091.878162436727, 6194.938050619527, 6200.286966998853, 6205.596636218631, 6208.875822483525, 1581.343742346936, 1581.7152912475865, 1583.2716950202805, 1584.8098228212689, 1586.6588683433117, 1094.4965315954591, 1108.4956344863228, 1109.9223054386116, 1131.971700707489, 1132.1961407400672, 5822.825315240465, 5825.679587622722, 5850.5904586678525, 5862.589618726648, 5871.911921321183, 6370.331115232926, 6372.012338087604, 6380.074889141141, 6387.776427825004, 6393.808185754435, 5678.858028549319, 5726.942730572724, 5826.82519524415, 5910.911336329958, 5915.08316210988, 3426.9314613708084, 3463.5324231228965, 3472.166679996833, 3476.165720227127, 3477.3045390921916, 6641.203055633258, 6643.966780166165, 6663.900041499382, 6670.199576050808, 6676.9666151668935, 6437.2918978912285, 6589.17635295588, 6635.0, 6638.17022872141, 6647.036179754005, 6691.79924602253, 6693.09643198162, 6694.832629184212, 6703.329667033355, 6711.496637752188, 6463.7737679181, 6502.057201705821, 6519.837004074936, 6521.706523206372, 6525.673716314071, 6249.593776404701, 6340.809775706736, 6349.523785716182, 6353.491720662429, 6377.17096777416, 6664.166979127609, 6683.398494135551, 6694.196696396269, 6696.19645642526, 6705.698243579148, 4402.207602631557, 4406.272964960745, 4440.0, 4447.066116115652, 4448.199324121689, 6232.532560057924, 6434.227892652912, 6448.29068802422, 6460.192475940507, 6463.385978332051, 6282.026285925689, 6297.055441683784, 6299.842503937438, 6300.432961033529, 6305.716242769178, 6279.215098112736, 6279.717412716347, 6280.874382512233, 6282.308946016026, 6282.748690052346, 6063.939360606514, 6152.876942461216, 6166.568340216142, 6168.414000669929, 6170.876582468415, 6280.9685951569945, 6285.465735412541, 6291.528135389773, 6292.087647291209, 6302.5588208826775, 6123.510119190365, 6138.9386106140155, 6146.78486252979, 6146.938530614637, 6147.66187859672], "unit": "score", "name": "prototype.html", "value": 4706.953507750163}, {"lowerIsBetter": false, "replicates": [731.6305265840749, 823.0617096509977, 825.9752207433779, 830.6718846055807, 831.7089018843405, 13655.31723413829, 13936.163830170197, 13951.651208719788, 13958.0, 13964.930175349122, 14189.290535473237, 14413.207273599948, 14432.13407195569, 14435.494757683484, 14448.494302699408, 678.3623394009616, 823.1274848660424, 831.9251267385933, 833.5332213960202, 833.6332013913858, 687.8933765266391, 816.8366326734647, 824.6948629007246, 829.4194064155085, 833.8457385383693, 854.7563944275882, 862.3360012790148, 862.6678728689437, 864.006392648453, 864.0150228739242, 700.5586480517267, 833.4124442268186, 853.2235665544356, 853.3770347646222, 865.0830120072743, 638.1034646321879, 638.3233772201481, 638.86903184847, 639.4085470939362, 639.5970538560723, 12994.28531430771, 13231.867681323256, 13232.338383080903, 13247.735045299136, 13265.071444998854, 12646.620601381974, 12956.157849739737, 13035.0, 13289.534866279633, 13488.5279015234, 10569.894301056967, 10700.357978521313, 10731.302465339728, 11794.410279486077, 11995.64013079609, 4353.869383918487, 4430.446194225722, 4439.644828413751, 4555.04344087742, 4561.475430325522, 44974.55025449769, 45245.321320180556, 45322.32016519755, 45523.77238113822, 45821.0, 9978.850317245247, 10284.845727314096, 10580.0, 10813.513391897384, 10927.617533386452, 18885.43343699691, 18956.715649265272, 18960.905195473933, 18964.905175474036, 18979.145938432805, 7820.178881217504, 7960.84078318442, 7965.8805117923275, 7971.123176450702, 7985.640646170937, 4349.608535231844, 4390.165868484977, 4573.108243892476, 4675.392199014106, 4684.1334353144775, 3144.0410674743966, 3148.0870547541413, 3148.480500717402, 3155.8422078896424, 3227.4190645684002, 596.0939372154388, 602.0698021556706, 604.5133667397787, 615.5783288447428, 619.8171539395889, 554.814137264021, 626.9122322874802, 667.7762949411904, 697.3514631392752, 705.1925545250659, 7700.268474494914, 8223.465474744242, 8324.0, 8499.532525711145, 8560.657573696983, 564.1903867949505, 623.9438450539474, 653.7417720000573, 657.7303305644663, 709.51752808091, 3937.704672149543, 4083.270579842236, 4226.788660566959, 4283.828646854091, 4297.957020429818, 56780.148297775566, 57216.0, 57679.0, 57735.71132144312, 57867.0, 49011.50988490141, 49491.50508494869, 49792.50207497951, 49847.50152498428, 50436.0, 45561.54438455639, 45752.771236144275, 45900.0, 45971.540284596726, 46378.76810615925, 8309.95845020771, 8492.363072769444, 8657.567121644019, 8712.607932642919, 9079.727608171765, 33811.83094084514, 34210.31579368449, 35024.47463288002, 35412.29175416426, 35824.64175358213, 43899.34150987802, 44104.7794761037, 44673.63563262548, 44793.552064478936, 45104.548954511345, 10886.129109671048, 10997.725056873642, 11074.778504430027, 11210.0, 11371.601993930173, 12102.394880255775, 12160.0, 12342.938285308515, 12745.219920933188, 12770.61688149357, 11476.598319058792, 11510.136739744385, 11553.884461155618, 12057.216280941711, 12444.564440244549, 9789.951050244703, 10193.23550733683, 10237.129843963347, 10393.0, 10438.843417348899, 11538.307701537935, 11544.19190656646, 11574.6527604172, 11665.24175928562, 11892.940535297268, 9203.263738900738, 9368.531573421165, 9439.811203776024, 9549.856752148862, 9635.710928672152, 8836.513991730517, 9249.30630202724, 9333.0, 9417.952910235404, 9532.571034303612], "unit": "score", "name": "yui.html", "value": 6405.936084504002}], "name": "dromaeo_css", "value": 6879.840985862436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 108.0, 111.0, 112.0, 111.0, 101.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [161.0, 124.0, 153.0, 165.0, 130.0, 147.0, 157.0, 128.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 160.0, 160.0, 161.0, 158.0, 164.0, 159.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 89.0, 91.0, 73.0, 73.0, 74.0, 126.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 95.0, 97.0, 95.0, 141.0, 96.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 59.0, 67.0, 59.0, 57.0, 61.0, 66.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [66.0, 78.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 73.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 85.0, 93.0, 86.0, 93.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [119.0, 136.0, 124.0, 123.0, 121.0, 119.0, 128.0, 127.0, 120.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [154.0, 143.0, 151.0, 155.0, 152.0, 147.0, 153.0, 152.0, 153.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 71.0, 69.0, 71.0, 70.0, 69.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1527.9}]} 23:23:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1527.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6879.84"}}} 23:23:12 INFO - Return code: 0 23:23:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:23:12 INFO - # TBPL SUCCESS # 23:23:12 INFO - Running post-action listener: _resource_record_post_action 23:23:12 INFO - Running post-run listener: _resource_record_post_run 23:23:13 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 81920; Write bytes: 538710016; Read time: 476; Write time: 938892 23:23:13 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 77824; Write bytes: 241324032; Read time: 452; Write time: 536072 23:23:13 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297385984; Read time: 24; Write time: 402820 23:23:13 INFO - Running post-run listener: _upload_blobber_files 23:23:13 INFO - Blob upload gear active. 23:23:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:23:13 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 23:23:13 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:23:13 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:23:13 INFO - (blobuploader) - INFO - Open directory for files ... 23:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:14 INFO - (blobuploader) - INFO - Done attempting. 23:23:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:23:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:23:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:23:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:23:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:23:15 INFO - (blobuploader) - INFO - Done attempting. 23:23:15 INFO - (blobuploader) - INFO - Iteration through files over. 23:23:15 INFO - Return code: 0 23:23:15 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:23:15 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:23:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bbd63b8bb7dbf5ed8c9d84097ab3696b3aec0c40737d649ee5ba5e6e66eba3a75e5ed2325c329c226ac20dff22de81066a9faa75d8341f26d8d3b2cb3849f4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3950cf03d093ca96d1b497179c0b5d3c746f7405edafc3edeba7140606f1cea61630788dbf2f71d753b445ca1267c7394781154ba3c46a4a5380b63071e2c520"} 23:23:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:23:15 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:23:15 INFO - Contents: 23:23:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bbd63b8bb7dbf5ed8c9d84097ab3696b3aec0c40737d649ee5ba5e6e66eba3a75e5ed2325c329c226ac20dff22de81066a9faa75d8341f26d8d3b2cb3849f4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3950cf03d093ca96d1b497179c0b5d3c746f7405edafc3edeba7140606f1cea61630788dbf2f71d753b445ca1267c7394781154ba3c46a4a5380b63071e2c520"} 23:23:15 INFO - Running post-run listener: copy_logs_to_upload_dir 23:23:15 INFO - Copying logs to upload dir... 23:23:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:23:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.115561 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-06 23:23:14.390397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 23:23:14.393841) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bbd63b8bb7dbf5ed8c9d84097ab3696b3aec0c40737d649ee5ba5e6e66eba3a75e5ed2325c329c226ac20dff22de81066a9faa75d8341f26d8d3b2cb3849f4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3950cf03d093ca96d1b497179c0b5d3c746f7405edafc3edeba7140606f1cea61630788dbf2f71d753b445ca1267c7394781154ba3c46a4a5380b63071e2c520"} build_url:https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/eOgETzmzSIS_7Z1mFu851Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bbd63b8bb7dbf5ed8c9d84097ab3696b3aec0c40737d649ee5ba5e6e66eba3a75e5ed2325c329c226ac20dff22de81066a9faa75d8341f26d8d3b2cb3849f4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3950cf03d093ca96d1b497179c0b5d3c746f7405edafc3edeba7140606f1cea61630788dbf2f71d753b445ca1267c7394781154ba3c46a4a5380b63071e2c520"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 23:23:14.418304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:23:14.418644) ========= 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=1861a34ebfea852630dec091000001fa-1454826195.230966-1839299605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 23:23:14.503263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 23:23:14.503583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 23:23:14.503864) ========= ========= Total master_lag: 2.44 =========