builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1456166202.73 results: success (0) buildid: 20160222074056 builduid: 06497c86f9434c54b23a669515c0a181 revision: 50c4fc9d5813 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:42.734891) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:42.735319) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:42.735601) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008799 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.59 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.338999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.339309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.353733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.354083) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.405123) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.405519) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.405965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.406392) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 10:36:43-- 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% 77.8M=0s 2016-02-22 10:36:43 (77.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.571401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.571732) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.621334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:43.621738) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 50c4fc9d5813 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 50c4fc9d5813 --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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 10:36:44,000 Setting DEBUG logging. 2016-02-22 10:36:44,000 attempt 1/10 2016-02-22 10:36:44,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/50c4fc9d5813?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 10:36:44,387 unpacking tar archive at: mozilla-beta-50c4fc9d5813/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:44.361132) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:44.361482) ========= echo 50c4fc9d5813 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'50c4fc9d5813'] 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 50c4fc9d5813 program finished with exit code 0 elapsedTime=0.003801 script_repo_revision: '50c4fc9d5813' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:44.411493) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:44.411792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 10:36:44.421610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-22 10:36:44.421947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:36:44 INFO - MultiFileLogger online at 20160222 10:36:44 in /builds/slave/test-pgo 10:36:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:36:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:36:44 INFO - {'append_to_log': False, 10:36:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:36:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:36:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:36:44 INFO - 'branch': 'Mozilla-Beta', 10:36:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:36:44 INFO - 'config_files': ('talos/linux_config.py',), 10:36:44 INFO - 'default_actions': ('clobber', 10:36:44 INFO - 'read-buildbot-config', 10:36:44 INFO - 'download-and-extract', 10:36:44 INFO - 'populate-webroot', 10:36:44 INFO - 'create-virtualenv', 10:36:44 INFO - 'install', 10:36:44 INFO - 'run-tests'), 10:36:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:36:44 INFO - 'download_minidump_stackwalk': True, 10:36:44 INFO - 'download_symbols': 'ondemand', 10:36:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:36:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:36:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:36:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:36:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:36:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:36:44 INFO - 'installer_path': 'installer.exe', 10:36:44 INFO - 'log_level': 'info', 10:36:44 INFO - 'log_name': 'talos', 10:36:44 INFO - 'log_to_console': True, 10:36:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:36:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:36:44 INFO - 'opt_config_files': (), 10:36:44 INFO - 'pip_index': False, 10:36:44 INFO - 'sps_profile': False, 10:36:44 INFO - 'sps_profile_interval': 0, 10:36:44 INFO - 'suite': 'dromaeojs', 10:36:44 INFO - 'system_bits': '32', 10:36:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:36:44 INFO - 'title': 'talos-linux64-ix-030', 10:36:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:36:44 INFO - 'use_talos_json': True, 10:36:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:36:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:36:44 INFO - 'work_dir': 'build'} 10:36:44 INFO - ##### 10:36:44 INFO - ##### Running clobber step. 10:36:44 INFO - ##### 10:36:44 INFO - Running pre-action listener: _resource_record_pre_action 10:36:44 INFO - Running main action method: clobber 10:36:44 INFO - rmtree: /builds/slave/test-pgo/build 10:36:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:36:45 INFO - Running post-action listener: _resource_record_post_action 10:36:45 INFO - ##### 10:36:45 INFO - ##### Running read-buildbot-config step. 10:36:45 INFO - ##### 10:36:45 INFO - Running pre-action listener: _resource_record_pre_action 10:36:45 INFO - Running main action method: read_buildbot_config 10:36:45 INFO - Using buildbot properties: 10:36:45 INFO - { 10:36:45 INFO - "properties": { 10:36:45 INFO - "buildnumber": 119, 10:36:45 INFO - "product": "firefox", 10:36:45 INFO - "script_repo_revision": "production", 10:36:45 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:36:45 INFO - "repository": "", 10:36:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:36:45 INFO - "buildid": "20160222074056", 10:36:45 INFO - "slavename": "talos-linux64-ix-030", 10:36:45 INFO - "pgo_build": "True", 10:36:45 INFO - "basedir": "/builds/slave/test-pgo", 10:36:45 INFO - "project": "", 10:36:45 INFO - "platform": "ubuntu64_hw", 10:36:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:36:45 INFO - "slavebuilddir": "test", 10:36:45 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:36:45 INFO - "branch": "mozilla-beta", 10:36:45 INFO - "repo_path": "releases/mozilla-beta", 10:36:45 INFO - "stage_platform": "linux64-pgo", 10:36:45 INFO - "builduid": "06497c86f9434c54b23a669515c0a181", 10:36:45 INFO - "revision": "50c4fc9d5813" 10:36:45 INFO - }, 10:36:45 INFO - "sourcestamp": { 10:36:45 INFO - "repository": "", 10:36:45 INFO - "hasPatch": false, 10:36:45 INFO - "project": "", 10:36:45 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:45 INFO - "changes": [ 10:36:45 INFO - { 10:36:45 INFO - "category": null, 10:36:45 INFO - "files": [ 10:36:45 INFO - { 10:36:45 INFO - "url": null, 10:36:45 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456154596/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:36:45 INFO - } 10:36:45 INFO - ], 10:36:45 INFO - "repository": "", 10:36:45 INFO - "rev": "8441fa1a493b", 10:36:45 INFO - "who": "sendchange", 10:36:45 INFO - "when": 1456164071, 10:36:45 INFO - "number": 7636190, 10:36:45 INFO - "comments": "Bug 1248851 - r=sicking, a=sylvestre", 10:36:45 INFO - "project": "", 10:36:45 INFO - "at": "Mon 22 Feb 2016 10:01:11", 10:36:45 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:45 INFO - "revlink": "", 10:36:45 INFO - "properties": [ 10:36:45 INFO - [ 10:36:45 INFO - "buildid", 10:36:45 INFO - "20160222072316", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "builduid", 10:36:45 INFO - "f21393d8e2de4e3eb6e5d76e4278a487", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "pgo_build", 10:36:45 INFO - "True", 10:36:45 INFO - "Change" 10:36:45 INFO - ] 10:36:45 INFO - ], 10:36:45 INFO - "revision": "8441fa1a493b" 10:36:45 INFO - }, 10:36:45 INFO - { 10:36:45 INFO - "category": null, 10:36:45 INFO - "files": [ 10:36:45 INFO - { 10:36:45 INFO - "url": null, 10:36:45 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456154941/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:36:45 INFO - } 10:36:45 INFO - ], 10:36:45 INFO - "repository": "", 10:36:45 INFO - "rev": "5e9ddb2825ac", 10:36:45 INFO - "who": "sendchange", 10:36:45 INFO - "when": 1456163954, 10:36:45 INFO - "number": 7636177, 10:36:45 INFO - "comments": "Bug 1248794 - Clean up observer on WindowsGamepadService shutdown_ r=ted r=smaug a=sylvestre", 10:36:45 INFO - "project": "", 10:36:45 INFO - "at": "Mon 22 Feb 2016 09:59:14", 10:36:45 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:45 INFO - "revlink": "", 10:36:45 INFO - "properties": [ 10:36:45 INFO - [ 10:36:45 INFO - "buildid", 10:36:45 INFO - "20160222072901", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "builduid", 10:36:45 INFO - "859d76755f4048c5abf77921f914808a", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "pgo_build", 10:36:45 INFO - "True", 10:36:45 INFO - "Change" 10:36:45 INFO - ] 10:36:45 INFO - ], 10:36:45 INFO - "revision": "5e9ddb2825ac" 10:36:45 INFO - }, 10:36:45 INFO - { 10:36:45 INFO - "category": null, 10:36:45 INFO - "files": [ 10:36:45 INFO - { 10:36:45 INFO - "url": null, 10:36:45 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:36:45 INFO - } 10:36:45 INFO - ], 10:36:45 INFO - "repository": "", 10:36:45 INFO - "rev": "50c4fc9d5813", 10:36:45 INFO - "who": "sendchange", 10:36:45 INFO - "when": 1456164153, 10:36:45 INFO - "number": 7636208, 10:36:45 INFO - "comments": "Bug 1249452 part 1: If nsReferencedElement URI (e.g. for _use_) doesn_t seem to match document URI, check if our document URI has the wrong mDefaultPort, and correct for that. r=bz a=sylvestre", 10:36:45 INFO - "project": "", 10:36:45 INFO - "at": "Mon 22 Feb 2016 10:02:33", 10:36:45 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:36:45 INFO - "revlink": "", 10:36:45 INFO - "properties": [ 10:36:45 INFO - [ 10:36:45 INFO - "buildid", 10:36:45 INFO - "20160222074056", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "builduid", 10:36:45 INFO - "06497c86f9434c54b23a669515c0a181", 10:36:45 INFO - "Change" 10:36:45 INFO - ], 10:36:45 INFO - [ 10:36:45 INFO - "pgo_build", 10:36:45 INFO - "True", 10:36:45 INFO - "Change" 10:36:45 INFO - ] 10:36:45 INFO - ], 10:36:45 INFO - "revision": "50c4fc9d5813" 10:36:45 INFO - } 10:36:45 INFO - ], 10:36:45 INFO - "revision": "50c4fc9d5813" 10:36:45 INFO - } 10:36:45 INFO - } 10:36:45 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:36:45 INFO - Running post-action listener: _resource_record_post_action 10:36:45 INFO - ##### 10:36:45 INFO - ##### Running download-and-extract step. 10:36:45 INFO - ##### 10:36:45 INFO - Running pre-action listener: _resource_record_pre_action 10:36:45 INFO - Running main action method: download_and_extract 10:36:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:36: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')]} 10:36:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/test_packages.json 10:36:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:36:45 INFO - Downloaded 1270 bytes. 10:36:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:36:45 INFO - Using the following test package requirements: 10:36:45 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:45 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:36:45 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'jsshell-linux-x86_64.zip'], 10:36:45 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:36:45 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:45 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:36:45 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:36:45 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:36:45 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:36:45 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:36:45 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:36:45 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:36: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')]} 10:36:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:45 INFO - Downloaded 21581697 bytes. 10:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:36:46 INFO - Return code: 0 10:36:46 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:46 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:46 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:36:47 INFO - Downloaded 21581697 bytes. 10:36:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:36:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:36:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:36:48 INFO - Return code: 0 10:36:48 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')]} 10:36:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:36:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:36:48 INFO - Downloaded 11132038 bytes. 10:36:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:36:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:36:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:36:49 INFO - Return code: 0 10:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:36:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:36:53 INFO - Downloaded 57951874 bytes. 10:36:53 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:36:53 INFO - mkdir: /builds/slave/test-pgo/properties 10:36:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:36:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:36:53 INFO - Contents: 10:36:53 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:36:53 INFO - Running post-action listener: _resource_record_post_action 10:36:53 INFO - Running post-action listener: set_extra_try_arguments 10:36:53 INFO - ##### 10:36:53 INFO - ##### Running populate-webroot step. 10:36:53 INFO - ##### 10:36:53 INFO - Running pre-action listener: _resource_record_pre_action 10:36:53 INFO - Running main action method: populate_webroot 10:36:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:53 INFO - '--tppagecycles', 10:36:53 INFO - '7'], 10:36:53 INFO - 'tests': ['tsvgm']}}, 10:36:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:36:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:36:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:36:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'tests': ['damp', 'tps']}, 10:36:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['damp', 'tps']}, 10:36:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:36:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:53 INFO - 'other': {'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'other_l64': {'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'other_nol64': {'tests': ['a11yr', 10:36:53 INFO - 'ts_paint', 10:36:53 INFO - 'tpaint', 10:36:53 INFO - 'sessionrestore', 10:36:53 INFO - 'sessionrestore_no_auto_restore']}, 10:36:53 INFO - 'svgr': {'tests': ['tsvgx', 10:36:53 INFO - 'tsvgr_opacity', 10:36:53 INFO - 'tart', 10:36:53 INFO - 'tscrollx', 10:36:53 INFO - 'cart']}, 10:36:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['tsvgx', 10:36:53 INFO - 'tsvgr_opacity', 10:36:53 INFO - 'tart', 10:36:53 INFO - 'tscrollx', 10:36:53 INFO - 'cart']}, 10:36:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'tests': ['tp5o']}, 10:36:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'talos_options': ['--e10s'], 10:36:53 INFO - 'tests': ['tp5o']}, 10:36:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'talos_options': ['--xperf_path', 10:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:53 INFO - 'tests': ['tp5n']}, 10:36:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:53 INFO - 'talos_options': ['--e10s', 10:36:53 INFO - '--xperf_path', 10:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:53 INFO - 'tests': ['tp5n']}}, 10:36:53 INFO - 'talos.zip': {'path': '', 10:36:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:53 INFO - Running post-action listener: _resource_record_post_action 10:36:53 INFO - ##### 10:36:53 INFO - ##### Running create-virtualenv step. 10:36:53 INFO - ##### 10:36:53 INFO - Running pre-action listener: _resource_record_pre_action 10:36:53 INFO - Running main action method: create_virtualenv 10:36:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:36:53 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 10:36:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:36:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:53 INFO - Using real prefix '/usr' 10:36:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:36:54 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:56 INFO - Installing pip.................done. 10:36:56 INFO - Return code: 0 10:36:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:36:56 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 10:36:56 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 10:36:56 INFO - Using env: {'DISPLAY': ':0', 10:36:56 INFO - 'HOME': '/home/cltbld', 10:36:56 INFO - 'LANG': 'en_US.UTF-8', 10:36:56 INFO - 'LANGUAGE': 'en_US:en', 10:36:56 INFO - 'LOGNAME': 'cltbld', 10:36:56 INFO - 'MAIL': '/var/mail/cltbld', 10:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:56 INFO - 'MOZ_NO_REMOTE': '1', 10:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:56 INFO - 'NO_EM_RESTART': '1', 10:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:36:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:36:56 INFO - 'SHELL': '/bin/bash', 10:36:56 INFO - 'SHLVL': '1', 10:36:56 INFO - 'TERM': 'linux', 10:36:56 INFO - 'TMOUT': '86400', 10:36:56 INFO - 'USER': 'cltbld', 10:36:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:56 INFO - '_': '/tools/buildbot/bin/python'} 10:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:56 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 10:36:56 INFO - Cleaning up... 10:36:56 INFO - Return code: 0 10:36:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:56 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:36:56 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 10:36:56 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 10:36:56 INFO - Using env: {'DISPLAY': ':0', 10:36:56 INFO - 'HOME': '/home/cltbld', 10:36:56 INFO - 'LANG': 'en_US.UTF-8', 10:36:56 INFO - 'LANGUAGE': 'en_US:en', 10:36:56 INFO - 'LOGNAME': 'cltbld', 10:36:56 INFO - 'MAIL': '/var/mail/cltbld', 10:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:56 INFO - 'MOZ_NO_REMOTE': '1', 10:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:56 INFO - 'NO_EM_RESTART': '1', 10:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:36:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:36:56 INFO - 'SHELL': '/bin/bash', 10:36:56 INFO - 'SHLVL': '1', 10:36:56 INFO - 'TERM': 'linux', 10:36:56 INFO - 'TMOUT': '86400', 10:36:56 INFO - 'USER': 'cltbld', 10:36:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:56 INFO - '_': '/tools/buildbot/bin/python'} 10:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:56 INFO - Downloading/unpacking psutil>=0.7.1 10:36:56 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 10:36:56 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 10:36:56 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 10:36:56 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 10:36:56 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 10:36:56 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 10:36:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:58 INFO - Installing collected packages: psutil 10:36:58 INFO - Running setup.py install for psutil 10:36:58 INFO - building 'psutil._psutil_linux' extension 10:36:58 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 10:36:58 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 10:36:58 INFO - building 'psutil._psutil_posix' extension 10:36:58 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 10:36:58 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 10:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:58 INFO - Successfully installed psutil 10:36:58 INFO - Cleaning up... 10:36:59 INFO - Return code: 0 10:36:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:36: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')]} 10:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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', '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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:36: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:36: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 mozsystemmonitor==0.0.0 10:36:59 INFO - Using env: {'DISPLAY': ':0', 10:36:59 INFO - 'HOME': '/home/cltbld', 10:36:59 INFO - 'LANG': 'en_US.UTF-8', 10:36:59 INFO - 'LANGUAGE': 'en_US:en', 10:36:59 INFO - 'LOGNAME': 'cltbld', 10:36:59 INFO - 'MAIL': '/var/mail/cltbld', 10:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:59 INFO - 'MOZ_NO_REMOTE': '1', 10:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:59 INFO - 'NO_EM_RESTART': '1', 10:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:36:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:36:59 INFO - 'SHELL': '/bin/bash', 10:36:59 INFO - 'SHLVL': '1', 10:36:59 INFO - 'TERM': 'linux', 10:36:59 INFO - 'TMOUT': '86400', 10:36:59 INFO - 'USER': 'cltbld', 10:36:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:59 INFO - '_': '/tools/buildbot/bin/python'} 10:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:37:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:37:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:37:01 INFO - Installing collected packages: mozsystemmonitor 10:37:01 INFO - Running setup.py install for mozsystemmonitor 10:37:01 INFO - Successfully installed mozsystemmonitor 10:37:01 INFO - Cleaning up... 10:37:01 INFO - Return code: 0 10:37:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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', '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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:37: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 blobuploader==1.2.4 10:37:01 INFO - Using env: {'DISPLAY': ':0', 10:37:01 INFO - 'HOME': '/home/cltbld', 10:37:01 INFO - 'LANG': 'en_US.UTF-8', 10:37:01 INFO - 'LANGUAGE': 'en_US:en', 10:37:01 INFO - 'LOGNAME': 'cltbld', 10:37:01 INFO - 'MAIL': '/var/mail/cltbld', 10:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:01 INFO - 'MOZ_NO_REMOTE': '1', 10:37:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:01 INFO - 'NO_EM_RESTART': '1', 10:37:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:01 INFO - 'SHELL': '/bin/bash', 10:37:01 INFO - 'SHLVL': '1', 10:37:01 INFO - 'TERM': 'linux', 10:37:01 INFO - 'TMOUT': '86400', 10:37:01 INFO - 'USER': 'cltbld', 10:37:01 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:01 INFO - '_': '/tools/buildbot/bin/python'} 10:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:01 INFO - Downloading/unpacking blobuploader==1.2.4 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:03 INFO - Downloading blobuploader-1.2.4.tar.gz 10:37:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:37:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:37:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:03 INFO - Downloading docopt-0.6.1.tar.gz 10:37:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:37:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:37:03 INFO - Running setup.py install for blobuploader 10:37:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:37:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:37:04 INFO - Running setup.py install for requests 10:37:04 INFO - Running setup.py install for docopt 10:37:04 INFO - Successfully installed blobuploader requests docopt 10:37:04 INFO - Cleaning up... 10:37:04 INFO - Return code: 0 10:37:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:04 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37:04 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 10:37:04 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 10:37:04 INFO - Using env: {'DISPLAY': ':0', 10:37:04 INFO - 'HOME': '/home/cltbld', 10:37:04 INFO - 'LANG': 'en_US.UTF-8', 10:37:04 INFO - 'LANGUAGE': 'en_US:en', 10:37:04 INFO - 'LOGNAME': 'cltbld', 10:37:04 INFO - 'MAIL': '/var/mail/cltbld', 10:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:04 INFO - 'MOZ_NO_REMOTE': '1', 10:37:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:04 INFO - 'NO_EM_RESTART': '1', 10:37:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:04 INFO - 'SHELL': '/bin/bash', 10:37:04 INFO - 'SHLVL': '1', 10:37:04 INFO - 'TERM': 'linux', 10:37:04 INFO - 'TMOUT': '86400', 10:37:04 INFO - 'USER': 'cltbld', 10:37:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:04 INFO - '_': '/tools/buildbot/bin/python'} 10:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:04 INFO - Running setup.py (path:/tmp/pip-PxvELf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:04 INFO - Running setup.py (path:/tmp/pip-trnt7E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:04 INFO - Running setup.py (path:/tmp/pip-2l0o9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:05 INFO - Running setup.py (path:/tmp/pip-A7wW9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:05 INFO - Running setup.py (path:/tmp/pip-a4BdsV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:05 INFO - Running setup.py (path:/tmp/pip-xKdit_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:05 INFO - Running setup.py (path:/tmp/pip-pOJyRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:05 INFO - Running setup.py (path:/tmp/pip-ym9Y1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:05 INFO - Running setup.py (path:/tmp/pip-eTCvyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:05 INFO - Running setup.py (path:/tmp/pip-YcSgZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:05 INFO - Running setup.py (path:/tmp/pip-yZ874O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:05 INFO - Running setup.py (path:/tmp/pip-PQuXKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:05 INFO - Running setup.py (path:/tmp/pip-j1uWfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:05 INFO - Running setup.py (path:/tmp/pip-FcrxCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:05 INFO - Running setup.py (path:/tmp/pip-rJkk6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:05 INFO - Running setup.py (path:/tmp/pip-muAxfL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:05 INFO - Running setup.py (path:/tmp/pip-Mqp8XX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:37:06 INFO - Running setup.py install for manifestparser 10:37:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Running setup.py install for mozcrash 10:37:06 INFO - Running setup.py install for mozdebug 10:37:06 INFO - Running setup.py install for mozdevice 10:37:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Running setup.py install for mozfile 10:37:06 INFO - Running setup.py install for mozhttpd 10:37:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Running setup.py install for mozinfo 10:37:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Running setup.py install for mozInstall 10:37:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:37:06 INFO - Running setup.py install for mozleak 10:37:06 INFO - Running setup.py install for mozlog 10:37:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Running setup.py install for moznetwork 10:37:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Running setup.py install for mozprocess 10:37:07 INFO - Running setup.py install for mozprofile 10:37:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Running setup.py install for mozrunner 10:37:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Running setup.py install for mozscreenshot 10:37:07 INFO - Running setup.py install for moztest 10:37:07 INFO - Running setup.py install for mozversion 10:37:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:37:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:37:07 INFO - Cleaning up... 10:37:07 INFO - Return code: 0 10:37:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:07 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37:07 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 10:37:07 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 10:37:07 INFO - Using env: {'DISPLAY': ':0', 10:37:07 INFO - 'HOME': '/home/cltbld', 10:37:07 INFO - 'LANG': 'en_US.UTF-8', 10:37:07 INFO - 'LANGUAGE': 'en_US:en', 10:37:07 INFO - 'LOGNAME': 'cltbld', 10:37:07 INFO - 'MAIL': '/var/mail/cltbld', 10:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:07 INFO - 'MOZ_NO_REMOTE': '1', 10:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:07 INFO - 'NO_EM_RESTART': '1', 10:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:07 INFO - 'SHELL': '/bin/bash', 10:37:07 INFO - 'SHLVL': '1', 10:37:07 INFO - 'TERM': 'linux', 10:37:07 INFO - 'TMOUT': '86400', 10:37:07 INFO - 'USER': 'cltbld', 10:37:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:07 INFO - '_': '/tools/buildbot/bin/python'} 10:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:08 INFO - Running setup.py (path:/tmp/pip-WM0wnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:08 INFO - Running setup.py (path:/tmp/pip-ReFqOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:08 INFO - Running setup.py (path:/tmp/pip-q5tnyO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:08 INFO - Running setup.py (path:/tmp/pip-yNjluA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:08 INFO - Running setup.py (path:/tmp/pip-1dWER8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:08 INFO - Running setup.py (path:/tmp/pip-xWFAvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:08 INFO - Running setup.py (path:/tmp/pip-9PuGZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:08 INFO - Running setup.py (path:/tmp/pip-rxCg25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:08 INFO - Running setup.py (path:/tmp/pip-1T_sKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:08 INFO - Running setup.py (path:/tmp/pip-7416iA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:08 INFO - Running setup.py (path:/tmp/pip-2IPBJh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:08 INFO - Running setup.py (path:/tmp/pip-sK39V6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:37:08 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:08 INFO - Running setup.py (path:/tmp/pip-hnLQYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 10:37:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:08 INFO - Running setup.py (path:/tmp/pip-Qwurbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:37:09 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)) 10:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:09 INFO - Running setup.py (path:/tmp/pip-HJkY8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:37:09 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)) 10:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:09 INFO - Running setup.py (path:/tmp/pip-R7RyqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:37:09 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)) 10:37:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:09 INFO - Running setup.py (path:/tmp/pip-nDxpEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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)) 10:37:09 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:37:09 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:37:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:11 INFO - Downloading blessings-1.6.tar.gz 10:37:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:37:11 INFO - Installing collected packages: blessings 10:37:11 INFO - Running setup.py install for blessings 10:37:11 INFO - Successfully installed blessings 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:37:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:37:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:37:11 INFO - Reading from file tmpfile_stdout 10:37:11 INFO - Current package versions: 10:37:11 INFO - argparse == 1.2.1 10:37:11 INFO - blessings == 1.6 10:37:11 INFO - blobuploader == 1.2.4 10:37:11 INFO - docopt == 0.6.1 10:37:11 INFO - manifestparser == 1.1 10:37:11 INFO - mozInstall == 1.12 10:37:11 INFO - mozcrash == 0.16 10:37:11 INFO - mozdebug == 0.1 10:37:11 INFO - mozdevice == 0.47 10:37:11 INFO - mozfile == 1.2 10:37:11 INFO - mozhttpd == 0.7 10:37:11 INFO - mozinfo == 0.9 10:37:11 INFO - mozleak == 0.1 10:37:11 INFO - mozlog == 3.1 10:37:11 INFO - moznetwork == 0.27 10:37:11 INFO - mozprocess == 0.22 10:37:11 INFO - mozprofile == 0.27 10:37:11 INFO - mozrunner == 6.11 10:37:11 INFO - mozscreenshot == 0.1 10:37:11 INFO - mozsystemmonitor == 0.0 10:37:11 INFO - moztest == 0.7 10:37:11 INFO - mozversion == 1.4 10:37:11 INFO - psutil == 3.1.1 10:37:11 INFO - requests == 1.2.3 10:37:11 INFO - wsgiref == 0.1.2 10:37:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:37:11 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')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37:11 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 10:37:11 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 10:37:11 INFO - Using env: {'DISPLAY': ':0', 10:37:11 INFO - 'HOME': '/home/cltbld', 10:37:11 INFO - 'LANG': 'en_US.UTF-8', 10:37:11 INFO - 'LANGUAGE': 'en_US:en', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MAIL': '/var/mail/cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SHLVL': '1', 10:37:11 INFO - 'TERM': 'linux', 10:37:11 INFO - 'TMOUT': '86400', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - '_': '/tools/buildbot/bin/python'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 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 1)) 10:37:11 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 2)) 10:37:11 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 3)) 10:37:11 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 4)) 10:37:11 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 5)) 10:37:11 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 6)) 10:37:11 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 7)) 10:37:11 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 8)) 10:37: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:37: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:37:11 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:37:11 INFO - Cleaning up... 10:37:11 INFO - Return code: 0 10:37:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:37:11 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')]} 10:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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')]} 10:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:11 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 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37:11 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 10:37:11 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 10:37:11 INFO - Using env: {'DISPLAY': ':0', 10:37:11 INFO - 'HOME': '/home/cltbld', 10:37:11 INFO - 'LANG': 'en_US.UTF-8', 10:37:11 INFO - 'LANGUAGE': 'en_US:en', 10:37:11 INFO - 'LOGNAME': 'cltbld', 10:37:11 INFO - 'MAIL': '/var/mail/cltbld', 10:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:11 INFO - 'MOZ_NO_REMOTE': '1', 10:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:11 INFO - 'NO_EM_RESTART': '1', 10:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:11 INFO - 'SHELL': '/bin/bash', 10:37:11 INFO - 'SHLVL': '1', 10:37:11 INFO - 'TERM': 'linux', 10:37:11 INFO - 'TMOUT': '86400', 10:37:11 INFO - 'USER': 'cltbld', 10:37:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:11 INFO - '_': '/tools/buildbot/bin/python'} 10:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:11 INFO - Downloading/unpacking jsonschema 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:37:13 INFO - Downloading/unpacking functools32 (from jsonschema) 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 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 10:37:13 INFO - Downloading functools32-3.2.3-2.tar.gz 10:37:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:37:14 INFO - warning: no files found matching '*.txt' 10:37:14 INFO - no previously-included directories found matching 'build' 10:37:14 INFO - no previously-included directories found matching 'dist' 10:37:14 INFO - no previously-included directories found matching '.git*' 10:37:14 INFO - Installing collected packages: jsonschema, functools32 10:37:14 INFO - Running setup.py install for functools32 10:37:14 INFO - warning: no files found matching '*.txt' 10:37:14 INFO - no previously-included directories found matching 'build' 10:37:14 INFO - no previously-included directories found matching 'dist' 10:37:14 INFO - no previously-included directories found matching '.git*' 10:37:14 INFO - Successfully installed jsonschema functools32 10:37:14 INFO - Cleaning up... 10:37:14 INFO - Return code: 0 10:37:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff03afb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c94600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, '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': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', '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 10:37: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', 'flake8'] in /builds/slave/test-pgo/build 10:37: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 flake8 10:37:14 INFO - Using env: {'DISPLAY': ':0', 10:37:14 INFO - 'HOME': '/home/cltbld', 10:37:14 INFO - 'LANG': 'en_US.UTF-8', 10:37:14 INFO - 'LANGUAGE': 'en_US:en', 10:37:14 INFO - 'LOGNAME': 'cltbld', 10:37:14 INFO - 'MAIL': '/var/mail/cltbld', 10:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:14 INFO - 'MOZ_NO_REMOTE': '1', 10:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:14 INFO - 'NO_EM_RESTART': '1', 10:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:14 INFO - 'SHELL': '/bin/bash', 10:37:14 INFO - 'SHLVL': '1', 10:37:14 INFO - 'TERM': 'linux', 10:37:14 INFO - 'TMOUT': '86400', 10:37:14 INFO - 'USER': 'cltbld', 10:37:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:14 INFO - '_': '/tools/buildbot/bin/python'} 10:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:14 INFO - Downloading/unpacking flake8 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:37:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:37:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37: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 10:37:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:37:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:16 INFO - no previously-included directories found matching 'docs/_build' 10:37:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:37:16 INFO - Running setup.py install for pep8 10:37:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:37:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:37:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:37:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:37:17 INFO - no previously-included directories found matching 'docs/_build' 10:37:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:37:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:37:17 INFO - Cleaning up... 10:37:17 INFO - Return code: 0 10:37:17 INFO - Running post-action listener: _resource_record_post_action 10:37:17 INFO - Running post-action listener: _start_resource_monitoring 10:37:17 INFO - Starting resource monitoring. 10:37:17 INFO - ##### 10:37:17 INFO - ##### Running install step. 10:37:17 INFO - ##### 10:37:17 INFO - Running pre-action listener: _resource_record_pre_action 10:37:17 INFO - Running main action method: install 10:37:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:37:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:37:17 INFO - Reading from file tmpfile_stdout 10:37:17 INFO - Detecting whether we're running mozinstall >=1.0... 10:37:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:37:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:37:17 INFO - Reading from file tmpfile_stdout 10:37:17 INFO - Output received: 10:37:17 INFO - Usage: mozinstall [options] installer 10:37:17 INFO - Options: 10:37:17 INFO - -h, --help show this help message and exit 10:37:17 INFO - -d DEST, --destination=DEST 10:37:17 INFO - Directory to install application into. [default: 10:37:17 INFO - "/builds/slave/test-pgo"] 10:37:17 INFO - --app=APP Application being installed. [default: firefox] 10:37:17 INFO - mkdir: /builds/slave/test-pgo/build/application 10:37:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:37:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:37:32 INFO - Reading from file tmpfile_stdout 10:37:32 INFO - Output received: 10:37:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:37:32 INFO - Running post-action listener: _resource_record_post_action 10:37:32 INFO - ##### 10:37:32 INFO - ##### Running run-tests step. 10:37:32 INFO - ##### 10:37:32 INFO - Running pre-action listener: _resource_record_pre_action 10:37:32 INFO - Running main action method: run_tests 10:37:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:37:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:37:32 INFO - Python 2.7.3 10:37:32 INFO - Return code: 0 10:37:32 INFO - grabbing minidump binary from tooltool 10:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:32 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 0x1d23350>, '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 0x1d24250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d246e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:37:32 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 10:37:32 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 10:37:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:32 INFO - Return code: 0 10:37:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:37:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:37:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:37:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:37:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:37:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:37:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:37:33 INFO - Return code: 0 10:37:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:37:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 10:37:33 INFO - Using env: {'DISPLAY': ':0', 10:37:33 INFO - 'HOME': '/home/cltbld', 10:37:33 INFO - 'LANG': 'en_US.UTF-8', 10:37:33 INFO - 'LANGUAGE': 'en_US:en', 10:37:33 INFO - 'LOGNAME': 'cltbld', 10:37:33 INFO - 'MAIL': '/var/mail/cltbld', 10:37:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:37:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:33 INFO - 'MOZ_NO_REMOTE': '1', 10:37:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:33 INFO - 'NO_EM_RESTART': '1', 10:37:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:37:33 INFO - 'PWD': '/builds/slave/test-pgo', 10:37:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:37:33 INFO - 'SHELL': '/bin/bash', 10:37:33 INFO - 'SHLVL': '1', 10:37:33 INFO - 'TERM': 'linux', 10:37:33 INFO - 'TMOUT': '86400', 10:37:33 INFO - 'USER': 'cltbld', 10:37:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598', 10:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:33 INFO - '_': '/tools/buildbot/bin/python'} 10:37:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 10:37:33 INFO - mozversion INFO | application_buildid: 20160222074056 10:37:33 INFO - mozversion INFO | application_changeset: 50c4fc9d581323275a1035d522e9ac3dddcc97b8 10:37:33 INFO - mozversion INFO | application_display_name: Nightly 10:37:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:33 INFO - mozversion INFO | application_name: Firefox 10:37:33 INFO - mozversion INFO | application_remotingname: firefox 10:37:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:33 INFO - mozversion INFO | application_vendor: Mozilla 10:37:33 INFO - mozversion INFO | application_version: 45.0 10:37:33 INFO - mozversion INFO | platform_buildid: 20160222074056 10:37:33 INFO - mozversion INFO | platform_changeset: 50c4fc9d581323275a1035d522e9ac3dddcc97b8 10:37:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:37:33 INFO - mozversion INFO | platform_version: 45.0 10:37:33 INFO - 2016-02-22 10:37:33,390 DEBUG : using testdate: 1456166253 10:37:33 INFO - 2016-02-22 10:37:33,390 DEBUG : actual date: 1456166253 10:37:33 INFO - 2016-02-22 10:37:33,398 INFO : starting webserver on 'localhost:44641' 10:37:33 INFO - 2016-02-22 10:37:33,399 INFO : Starting test suite talos-linux64-ix-030 10:37:33 INFO - 2016-02-22 10:37:33,399 INFO : Starting test dromaeo_css 10:37:33 INFO - 2016-02-22 10:37:33,400 DEBUG : operating with platform_type : linux_ 10:37:33 INFO - 2016-02-22 10:37:33,400 INFO : Initialising browser for dromaeo_css test... 10:37:33 INFO - 2016-02-22 10:37:33,417 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp166XUu/profile http://localhost:44641/getInfo.html 10:37:36 INFO - 2016-02-22 10:37:36,857 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:37:36 INFO - 2016-02-22 10:37:36,858 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:37:36 INFO - 2016-02-22 10:37:36,858 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:37:36 INFO - 2016-02-22 10:37:36,858 DEBUG : BROWSER_OUTPUT: __metrics 10:37:37 INFO - 2016-02-22 10:37:37,019 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:38 INFO - 2016-02-22 10:37:38,029 INFO : Browser initialized. 10:37:38 INFO - 2016-02-22 10:37:38,030 INFO : Running cycle 1/1 for dromaeo_css test... 10:37:38 INFO - 2016-02-22 10:37:38,031 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp166XUu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:37:49 INFO - 2016-02-22 10:37:49,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 134561792 10:37:49 INFO - 2016-02-22 10:37:49,656 DEBUG : BROWSER_OUTPUT: 10:38:40 INFO - 2016-02-22 10:38:40,514 DEBUG : BROWSER_OUTPUT: 1456166320513 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] 10:40:48 INFO - 2016-02-22 10:40:48,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44641/tests/dromaeo/cssquery-ext.html) 10:40:49 INFO - 2016-02-22 10:40:49,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 249442304 10:40:49 INFO - 2016-02-22 10:40:49,794 DEBUG : BROWSER_OUTPUT: 10:43:51 INFO - 2016-02-22 10:43:51,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-ext.html (next: http://localhost:44641/tests/dromaeo/cssquery-jquery.html) 10:43:52 INFO - 2016-02-22 10:43:52,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 216092672 10:43:52 INFO - 2016-02-22 10:43:52,508 DEBUG : BROWSER_OUTPUT: 10:46:54 INFO - 2016-02-22 10:46:54,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44641/tests/dromaeo/cssquery-mootools.html) 10:46:54 INFO - 2016-02-22 10:46:54,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 208613376 10:46:54 INFO - 2016-02-22 10:46:54,749 DEBUG : BROWSER_OUTPUT: 10:49:56 INFO - 2016-02-22 10:49:56,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44641/tests/dromaeo/cssquery-prototype.html) 10:49:57 INFO - 2016-02-22 10:49:57,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 194760704 10:49:57 INFO - 2016-02-22 10:49:57,005 DEBUG : BROWSER_OUTPUT: 10:52:59 INFO - 2016-02-22 10:52:59,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44641/tests/dromaeo/cssquery-yui.html) 10:52:59 INFO - 2016-02-22 10:52:59,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 196460544 10:52:59 INFO - 2016-02-22 10:52:59,954 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/dromaeo/cssquery-yui.html (next: http://localhost:44641/tests/dromaeo/cssquery-dojo.html) 10:56:02 INFO - 2016-02-22 10:56:02,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 239689728 10:56:02 INFO - 2016-02-22 10:56:02,301 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,302 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:56:02 INFO - 2016-02-22 10:56:02,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:56:02 INFO - 2016-02-22 10:56:02,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:56:02 INFO - 2016-02-22 10:56:02,302 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:56:02 INFO - 2016-02-22 10:56:02,303 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3304.818234997075;3370.6460821613746;3389.762716609838;3399.745019123566;3416.4362880124772;5564.443555644439;5571.621265137298;5587.720613969305;5588.804391846286;5603.887922241558;5580.135079062752;5581;5589.580781441398;5590.413006634306;5606.579506537006;4836.347093142434;5050.898982020367;5072.51811077947;5127.9230811537855;5189.792408303663;5006.374203224597;5039.974800125994;5070.847874563769;5072.594192464594;5075.593952483792;4985.277134815449;5000.524950129732;5062.164742817431;5062.594992400599;5063.316452278932;4997.925031124536;5035.84892453227;5077.873053173664;5107.233914912756;5115.897682046339;4998;5056.974715126437;5073.188289873639;5100.617453690988;5111.284420181178;5267.552258058031;5286.233496143076;5400.946815371004;5402.054640437907;5409.053415652245;5904.616199947032;5905.143754155666;5908.734106965154;5912.704364781786;5930.733117009745;5926.2295901532525;5945.435183657545;5948.97025514874;5955.464008239279;5957.6127551709;5412.431694672042;5480;5488.121900495901;5508.173773933902;5549.19536667181;6000.759969601254;6010.909836352458;6022.728977196037;6027.21646185993;6040.395960404012;5829.09649004405;5840.707964601838;5842.912356314659;5844.620099693507;5848.736806843703;5828.504577110993;5829.242198514251;5932.7330270137945;5939.287285525765;5971.880562388728;5830.883382332329;5871.706414679249;5875.177475153482;5878.735456904364;5896.675682837399;5870.911936320958;5873.647581145145;5888.941110588839;5894.145348924382;5895.115732640138;4387.012922092567;4462.665300102505;4482.125985432875;4483.50681425043;4540.886477838015;3975.920481590352;3979.2837289288204;3991.1618560102124;4007.579204183577;4014.9397759033636;5643.40744221859;5660.745266463019;5664.037113690682;5666.943330566724;5676.063449530781;5772.913406298909;5907.616004959664;5918.408159184047;6031.306399763996;6058.333583305833;5618.775248990077;5655.688937108499;5656.943430565641;5659.603827732101;5661.2923384576925;4996.800127994912;5221.477852214824;5222.112240918977;5223.973880130575;5249.763760630781;5946.524278057745;6044.516438684895;6104.511639068953;6107.835087457426;6130.50136427355;5928.170056192051;5972.402759723993;5973.55198360116;5979.2824861015215;5993.31076926159;5850.356460789395;6129.325774164928;6136.417040381157;6137.1101190328045;6140.140380346666;5800.709964501673;5863.589548731547;5870.853228669317;5895.793647222326;5901.409859014064;5964.433378829004;6007.399260074132;6008.639481631116;6010.909836352371;6020.518358531394;5633.549316054788;5854.795082172103;5857.824265272048;5865.296164460292;5867.090600956859;5732.484076433141;5767;5812.796552120655;5815.3893841147765;5826.970865145647;5772.336181339199;5794.82615521535;5796.59423840344;5811.651300921958;5816.360200377871;5643.181738647791;5825.50483208932;5898.498627616701;5898.997170481114;5901.114832775118;5730.111832665943;5746.569007324384;5750.5112065474905;5751.827445176651;5795.188673585786 10:56:02 INFO - 2016-02-22 10:56:02,305 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.3434456442477;621.4903778901297;637.3721883944314;639.3606393606393;648.4002297874465;32313.838430807842;40364.394534082014;40376.39435408471;40475;40501.39247911284;46520.76739616306;46995.765021174935;47066.76466617671;47092.529074709244;47094.0581188376;8152.796180095515;8209.466384685005;8218.958905205465;9149.359544831865;9356.906430935705;8220.383471239651;8326.417150799447;11106.888931110707;11337.603183888565;11372.715682107972;11045.061169800576;11125.833112503318;11129.777404451906;11133.554657813718;11134.49894754738;10884.891151088466;10946.835797463045;10989.780204395867;10992.780144397148;10996.505157267942;10785.5685772569;10911.181661375349;10930.234883558154;10930.672079837617;10936.726581835439;42504.3624345635;42861.571384286384;43059.35410968838;43162.35256471155;43211.35182972258;3727.2172843702583;3894.6494815466463;4178.582141785797;4256.978325201929;4440.755758433284;32726.509102363485;33010.17474563131;33131.33737325264;33286.50070248924;33373;3923.2545816295096;3934.595286021684;3942.64516193544;3943.1325108476376;3946.2304850554156;306118;307999;309214;309988;310952;58580;59973.99999999913;66951.66524167349;67473.32526674769;68101.65949170223;66735;67107.32892671108;67386.66306668436;67403.66298168477;67498.66250668715;14390.352434140488;14430.567082987527;14535.636609084646;14550.781738273934;14588.197649129399;10897.182711296684;10963.177761667906;10971.725706857393;10975.121990240761;10987.285826421257;22121.889390552944;22605.321840344815;22621.547569048525;22630.66054009191;22683.886580566992;8287.709930152416;8546.145385461528;8630.741077767678;8649.308055355556;8710.956445217733;1027.8817935937313;1051.3324039234988;1062.516554967488;1144.9599264025885;1154.099802154321;30433.23916902095;30481.542776858365;30831.383372332428;33919.32161356759;34680.65319346825;1087.456271864068;1113.799516087096;1136.6419577832955;1156.3582211872492;1217.34263497712;14913.776293355608;15868.20658967047;17084.82915170857;17821.287148513915;17887.910560447115;422617;427452;428502;429050;429063;62892;63228;63283;63347.36652633507;63394.68302658457;1455.1778245291378;1461.875740562043;1461.8976671633097;1462.6782107936237;1475.837657857635;31254.843725781226;31261;31499;31810.840945796048;31913.202169945936;51802.22296665478;51968.22047669212;52293.7385313071;52300.47699523108;52312.21531677104;320428;323829;324677;324841.63054292987;324982;30578.388432230786;31378.372432551678;33933.66066339305;34805.65194348024;36359.81820090883;39116.41325380179;39410.605893940694;39600.80199598984;39996.40005399863;40763.1847363057;37179.814100929325;37870.8106459477;38076.23847523089;38179.23641527209;38700.22599547937;35136;38130.237395252494;42945.570544294154;43950.560494394646;44907.326390103524;37921.43117853179;38550.61449385582;39520.40719389154;39581.40627890641;39603.80198098991;35324.470132947514;36208.09479763027;36349.27301454009;38827;39814.40278395768;26894.596581050908;26912.730872691023;26934.32664183411;26993.595096073183;27100.593491097254 10:56:02 INFO - 2016-02-22 10:56:02,308 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.951986721859;343.84011434682867;349.1742030098817;352.1829355894325;358.9784612923224;15242.847571524282;15419.460318888841;17580.73628895566;18094.638107237864;19676.704849427253;18243.543911402223;18258.908705456488;18278.908605456953;18413.631727365446;18709.158087886044;5546.639468434559;5668.744906479218;5671.2060311556415;5674.404187560309;5681.23303354046;4263.339182426714;4400;5621.269234999444;6033.27600687918;6235.251769787632;6113.6943152842405;6249.937500625004;6284.622922624634;6314.14759007535;6323.367663233663;6106.755729770804;6168.105624684418;6188.628682279078;6193.535484838655;6193.659348735818;4905.8773530661665;5377.516023557899;5381.461853814626;5385.219143224211;5385.515303622693;11804.173707840455;11985.64043078709;12092.39538023104;12178.75642487154;12202.755944881053;2251.954960900789;2257.8645281283175;2267.7505474397803;2267.9886600566892;2336.941576460585;9106.86339704905;9211.078892110801;9300.906990930072;9961.75095622608;13837;1862.6367858267643;1874.240932422371;1927.6626590346773;1959.4121763471044;1977.2684106880401;61577.384226157614;63412;63695;65255;65763.67118164379;9904.55429505674;10108.191344692406;10143;10201.183905287558;10210.948945255226;13176.275304858325;13294.20234785916;13298.534551290659;13302;13334.26661533625;7047.647617619201;7164.856702866018;7172.46206534512;7188.964055179691;7244;6812.420944219698;6821.21556021054;6832.829179270558;6845.794626161223;6854.5201835872;3933.331333673282;4079.63283304504;4103.548609652936;4197.202531519063;4251.44731184944;1604.478544473051;1701.2854601067581;1711.7090094683933;1748.1958299182263;1755.5698853780905;410.860307495447;413.991720165595;415.262908337703;423.658954541597;1002.8094662014194;8965.596548155218;9089;9655.662051828152;10105;10340.069393754598;413.50379544546064;424.0607055372303;431.9481662200556;433.7484259129697;438.8705331927025;5487.725613719298;5544.750486228048;5549.139883318092;5606.85982850432;5667.773289068391;627980;638613.3434306774;646646;663048;667243;84481.15518844733;85655.57172214099;87674;87967.56016219877;88933;1162.273579013117;1195.2111606339774;1198.2271434924598;1204.313541281461;1212.248405988293;15943.20283985773;15988.600284992968;16110.758338624695;16118;16390.344386224417;37202.627973721;37777.433338499395;37779.43330850094;38636.6136338633;38913.2217355657;49902.750486247336;50741;51221.97556048784;51415.97168056693;53322.73338633282;9045;9439.150476457151;9528.904710952802;9530.094641009093;9568.95215523918;10868.18488613373;14052;17912.462626121236;18271.26914923388;18700.81299186991;15610;15750.133742644264;15777.053376797428;15779.28993195286;15861.603459913595;11011.504482298476;13641.727165456437;14867.479638212611;15098.245087745789;15463.613409664847;14469.131852088909;14831.33259003369;14907;15070.623234419227;15206.08763474195;8864.512451815212;9016;9304.72085837426;9369.25045996305;9385.483798391155;14325.64185895361;14409.279536023367;14542.563723088324;14624.634384140481;15018.324175411914 10:56:02 INFO - 2016-02-22 10:56:02,309 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1552.4721594657815;1600.807903051634;1612.0252690454192;1774.254812978549;1861.7579714637104;7595.696172153114;7958.32354249888;7966.641501132449;7976.322012628933;7990.121086680468;6782.559133656321;6929.411000065001;7415.666295016724;7571.053618297713;7837.373010159188;2256.548690261946;2274.624686926655;2298.4139044543704;2301;2303.6890019847274;1997.1212666426798;2299.7700229977036;2329.9767002329927;2367.3134790910617;2370.668106465096;1998.7601487821482;2216.2021672198;2279.3731723776013;2279.418748219202;2279.7036385269894;2218.4232099654205;2243.9663405048937;2251.189571754167;2254.7294324681143;2255.154317131076;2256.9548609027893;2259.0399080390766;2280.749117597063;2283.566122436732;2285.2001799370087;7833.334166595846;7898.960505197495;7916.168802275735;7919.683212671486;7920.089189743138;4656.161890859644;4709.905801883978;4723;4746.074515469485;4751.95248047522;3128.5307203919365;3142.0785370720646;3163.984180079085;3177.0468859342104;3247.7888937219004;1012.5899010900597;1017.7252141921714;1021.9080282774586;1057.9523921423554;1064.2018486135398;10685.679429617125;10701.304415212986;10733.83899241512;10733.83899241512;10737.946310268399;4048.4332193492933;4048.4534587830854;4112.91774164515;4144.834206631761;4146.253674338588;9150.084991500797;9154.72535823913;9166.358354915092;9178.724638260863;9190.770230744285;4657.0918670858855;4699.506551812011;4702.059588082398;4709.175894218498;4720.88197795051;4250.744955302692;4252.681048921343;4298.032942587893;4307.870763877088;4308.9569104309185;3712.350338690718;3752.380857158593;3763.3790424580184;3779.168582911755;3810.48558444612;1076.3703233608271;1093.8960798724108;1187.4122309456875;1193.2899924544881;1200.447794014763;1209.3348658237935;1217.2209785737136;1242.9931755278253;1303.791393377055;1308.8691130887025;7372.152202496782;7450.2549745026145;7461.664225109883;7464.70141194357;7477.027986361738;1166.8133098704336;1168.7720894425674;1199.064729510983;1200.765850659113;1200.903927685783;5808.738606762706;5867.559933005042;5872.0898260769645;5874.295084589877;5883.2057672213705;9005.234555062892;9379.577918993662;9479.905200947902;9495.335326527076;9500;9406.623735050658;9409.764755881159;9414.811703765887;9417.434953902788;9422.199113075465;7312.780616581511;7411.4070874328845;7484.738034168778;7514.812129696801;7524.699012039567;7230.824415615505;7275.745348912763;7291.781246562611;7308.30571095745;7315;8274.917250827415;8400.369972251983;8475.067742548192;8478.91521084806;8480.448770829877;8478.830423391375;8646.783830404038;8659.826803464022;8670.609822557873;8683.261922736638;7007.929920700728;7058.611776352144;7059;7062.329078737512;7063.117110361205;7591.051118610174;7626.809329766578;7686.846263074819;7692.576908270099;7695.115061767744;6264.843378915563;6543;7225.313595208447;7259.891101633374;7335.523190992782;6852.349026842442;6919.411849992807;6944.687489063105;6997.265287144776;7017.193022802443;6884.277150899284;6915.446764258747;6932.896006559805;6940.652967351713;6947.131608548932;6504.934950650433;6606.900896486461;6721.395074443323;6733.494987875831;6738.124043874265;6769.255381907888;6810.897836532356;6812.523123381316;6813.863722725617;6820.249772524919 10:56:02 INFO - 2016-02-22 10:56:02,312 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.87212986935083;330.99834500827495;335.4180496837986;335.71631970984527;337.99831000844983;6006.369331220214;6056.3943605639415;6143.969280153604;6151.723172457239;6156.353582873795;5906.88186236275;5979.760809567623;6063.969680151593;6071.028635418334;6073.240844894388;4687.71873687579;4694.741789201593;4696.295555666643;4697.953020469803;4701.294805779126;4500.257457519506;4558.179527685015;4567.246404343279;4595.816167353302;4710.458297295821;4637.188492013884;4657.06858628274;4666.673332866701;4677.13473007493;4683.812647494096;4650.325702773112;4662.836800711976;4667.626589872836;4667.766611669403;4686.20334543125;4102.794860257005;4105.466289382391;4106.67146628269;4109.2808758467445;4109.445224894631;5689.431056894319;5771.336296325934;5774.16274640179;5788.623739456964;5790.04464263396;5417.6478528895495;5427;5428.45715428458;5431.266778984826;5438.782448702047;6172.567920245585;6427.260865000538;6436.002419624966;6437.1631687880745;6438.678066096723;4346.1090476452255;4358.302671572565;4407.955920440787;4417.845375411845;4426.845060422902;6617.569857959265;6621.70202340891;6642.966785166043;6652.301508341603;6657.567258128206;4472.932906006413;4506;4509.188346097734;4516.096780643885;4518.728876267434;4466.173757854743;4558.0655965526985;4561.566651168134;4571.26859702446;4580.106879158532;5300.443453437333;5310.575153987672;5313.335833020872;5315.734213289397;5320.547753440924;6457.870842583122;6458.903116453257;6462.838429039311;6465.77369792055;6466.644334561644;1635.9856888728825;1641.622426841809;1642.2445674989638;1643.2441077104666;1646.4484397726656;1094.7372630568607;1097.4457898761075;1121.3664279682116;1122.141561705296;1125.954961801535;6230.127782110508;6237.96881015592;6241.251049874044;6247;6248.750049997949;6647.202335719745;6670.232923213795;6673.566218195899;6686.297938716462;6688.097106890605;6086.878262434727;6214.4407003369915;6242.09489624002;6246.250449946036;6248.156498872685;3582.1044738815294;3610.548681414823;3610.9277814443562;3617.6744093031225;3620.656037676469;6832.180138383425;6856.725730970805;6865.622390768456;6877.6217308047535;6880.793576192722;6678.49911256648;6830.214525329551;6839.350261725128;6839.384455399038;6845.726170953106;6846.110005699326;6850.691718872663;6858.142732158481;6869.553479023847;6872.656367181721;6452.9677351612945;6617;6651.900221496585;6655.667216639245;6658.600483970978;6510.31641677636;6515.0553169791065;6643.800685979429;6644.335566443317;6662.034005069335;6895.310468953065;6896.034555162381;6908.5509441886115;6909.2745261748805;6912.308769123048;4565.840195593139;4661.557152070548;4663.510331415153;4671.43942726875;4674.953250467588;6722.596644201363;6730.629815360202;6732.192136943598;6737.326267373223;6739.629320387426;6534.1178940844275;6544.574602650812;6549.083128362128;6551.836204094936;6554.049662798963;6358.586691865014;6529.902051469327;6536.411722944958;6538.607683539003;6542.901856472252;6415.711292991733;6417;6422.486201103994;6436.806895793134;6444.420002199637;6553.4101930826455;6558.672066396756;6558.704858281293;6564.737410503717;6573.112629794917;6242.3133455320785;6403.903941440975;6406.455451286693;6434.581752186093;6448.45188158993 10:56:02 INFO - 2016-02-22 10:56:02,313 DEBUG : BROWSER_OUTPUT: |5;yui.html;811.7321283976285;834.6828205281992;900.6172376739886;913.4473643445715;947.1002547579801;12757.681057973543;13081.934590327048;13542.72914541711;13575.660608484794;13623.863761362383;12958.157719748233;13018.414171362288;13065;13101.213927164377;13111.409986550605;723.0636325957871;732.1031736123259;874.514644372373;882.6513527156769;902.7291812456269;883.6730409748402;885.0353115104534;885.3758100539137;888.5424006636588;890.1009979920294;919.8298314811781;925.0887875442684;933.0296491648677;935.4574346878794;936.1247233836351;748.8352562436255;758.7761610324967;910.1626503616656;923.2567782934735;923.7136487688771;691.816668582826;693.19935474527;693.2789898505548;695.2144077192739;698.0053423870963;13242;13426;13452.32738363078;13463.528776492776;13478.19130852152;12026.759464810742;12444.440000200013;12478.75042499145;12552.497900083985;12902.225866447949;10562.735931601695;10574.524146413352;10599.523021464052;10620.787584248272;10638.255322127454;3797.487339209199;3834.654881060718;3838.8848334550007;3842.9423558646645;3844.192719528902;46095;46711.76644116758;46978.060438791035;47127.29309060333;47792.76103619529;9883.30816842814;9955.850662240073;10082.24383171265;10101.292909496411;10231.386116833013;18068.819311806976;18202.817971820114;18205.36281230177;18229.63540729178;18291.268349266145;7588.165301816795;7641.541507509567;7707;7751.651175697107;7789.571573563395;4387.605115539553;4451.132029254264;4482.46210454741;4491.416115904912;4535.047639995638;3134.5298205268937;3140.4347217501067;3141.937161256762;3144.795588286754;3155.889543865954;539.6654074473773;549.4560385218605;550.1939658400463;553.7120697237414;562.4403718300317;699.2133849419403;700.3024033105213;718.576040136322;742.6212631557944;756.6216891554222;10044.648437304659;10199.38803671782;10204.183665306758;10267.691969240936;10312;544.4936209325286;576.4869266352949;600.0609046841679;610.331686802959;701.6281370873445;4348.826046958149;4433.933490997638;4438.178936896685;4515.75163366018;4561.543845615478;58294.7085264571;58497;58594.4140558589;58781.118283225784;58912.70543647254;51355.48644513507;52907;53516.197257040396;54202.728986354814;54282.72858635682;45216.77391613021;47819;48053.51946480491;48113.278300825514;48762;9085.682001129928;9094.499802510925;9145.954270228607;9316.254699623878;9355.625774969198;34400.65599344075;35037.299254015285;35062;35377;35878.64121358858;41316.79341603273;45476.09047819091;47052.7647361761;47088.35190768306;47604.28593571168;11888.167828251939;11921.34432606215;12287.078469115031;12420.378981051092;12498.312592807119;13087;13180.670483237996;13301.600951971457;13386.866131338951;13539.59381218565;12049.81925271104;12107.576234831738;12344.321062341658;12580.748385032066;12621.558245461365;12798.16811907223;12831.486740530274;12838.358082096045;13482.662933426744;13492;11371.658850234506;11408.600698975495;11787.823182652095;11822.40887955616;11914.940425297818;10146.188304935735;10380.273380863267;10732.678019659423;10769.869163737694;10825.079868210974;10323.535440905327;10677.033946520058;10688.465576720977;10691.572337106429;10769.192310576582 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,953 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167362299__endTimestamp 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5512.72 Median:5767.00 stddev:610.04 (10.6%) stddev-sans-first:586.81 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: Values: 3304.8 3370.6 3389.8 3399.7 3416.4 5564.4 5571.6 5587.7 5588.8 5603.9 5580.1 5581.0 5589.6 5590.4 5606.6 4836.3 5050.9 5072.5 5127.9 5189.8 5006.4 5040.0 5070.8 5072.6 5075.6 4985.3 5000.5 5062.2 5062.6 5063.3 4997.9 5035.8 5077.9 5107.2 5115.9 4998.0 5057.0 5073.2 5100.6 5111.3 5267.6 5286.2 5400.9 5402.1 5409.1 5904.6 5905.1 5908.7 5912.7 5930.7 5926.2 5945.4 5949.0 5955.5 5957.6 5412.4 5480.0 5488.1 5508.2 5549.2 6000.8 6010.9 6022.7 6027.2 6040.4 5829.1 5840.7 5842.9 5844.6 5848.7 5828.5 5829.2 5932.7 5939.3 5971.9 5830.9 5871.7 5875.2 5878.7 5896.7 5870.9 5873.6 5888.9 5894.1 5895.1 4387.0 4462.7 4482.1 4483.5 4540.9 3975.9 3979.3 3991.2 4007.6 4014.9 5643.4 5660.7 5664.0 5666.9 5676.1 5772.9 5907.6 5918.4 6031.3 6058.3 5618.8 5655.7 5656.9 5659.6 5661.3 4996.8 5221.5 5222.1 5224.0 5249.8 5946.5 6044.5 6104.5 6107.8 6130.5 5928.2 5972.4 5973.6 5979.3 5993.3 5850.4 6129.3 6136.4 6137.1 6140.1 5800.7 5863.6 5870.9 5895.8 5901.4 5964.4 6007.4 6008.6 6010.9 6020.5 5633.5 5854.8 5857.8 5865.3 5867.1 5732.5 5767.0 5812.8 5815.4 5827.0 5772.3 5794.8 5796.6 5811.7 5816.4 5643.2 5825.5 5898.5 5899.0 5901.1 5730.1 5746.6 5750.5 5751.8 5795.2 10:56:02 INFO - 2016-02-22 10:56:02,314 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,315 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53472.23 Median:36278.68 stddev:93836.07 (258.7%) stddev-sans-first:94015.34 10:56:02 INFO - 2016-02-22 10:56:02,315 DEBUG : BROWSER_OUTPUT: Values: 602.3 621.5 637.4 639.4 648.4 32313.8 40364.4 40376.4 40475.0 40501.4 46520.8 46995.8 47066.8 47092.5 47094.1 8152.8 8209.5 8219.0 9149.4 9356.9 8220.4 8326.4 11106.9 11337.6 11372.7 11045.1 11125.8 11129.8 11133.6 11134.5 10884.9 10946.8 10989.8 10992.8 10996.5 10785.6 10911.2 10930.2 10930.7 10936.7 42504.4 42861.6 43059.4 43162.4 43211.4 3727.2 3894.6 4178.6 4257.0 4440.8 32726.5 33010.2 33131.3 33286.5 33373.0 3923.3 3934.6 3942.6 3943.1 3946.2 306118.0 307999.0 309214.0 309988.0 310952.0 58580.0 59974.0 66951.7 67473.3 68101.7 66735.0 67107.3 67386.7 67403.7 67498.7 14390.4 14430.6 14535.6 14550.8 14588.2 10897.2 10963.2 10971.7 10975.1 10987.3 22121.9 22605.3 22621.5 22630.7 22683.9 8287.7 8546.1 8630.7 8649.3 8711.0 1027.9 1051.3 1062.5 1145.0 1154.1 30433.2 30481.5 30831.4 33919.3 34680.7 1087.5 1113.8 1136.6 1156.4 1217.3 14913.8 15868.2 17084.8 17821.3 17887.9 422617.0 427452.0 428502.0 429050.0 429063.0 62892.0 63228.0 63283.0 63347.4 63394.7 1455.2 1461.9 1461.9 1462.7 1475.8 31254.8 31261.0 31499.0 31810.8 31913.2 51802.2 51968.2 52293.7 52300.5 52312.2 320428.0 323829.0 324677.0 324841.6 324982.0 30578.4 31378.4 33933.7 34805.7 36359.8 39116.4 39410.6 39600.8 39996.4 40763.2 37179.8 37870.8 38076.2 38179.2 38700.2 35136.0 38130.2 42945.6 43950.6 44907.3 37921.4 38550.6 39520.4 39581.4 39603.8 35324.5 36208.1 36349.3 38827.0 39814.4 26894.6 26912.7 26934.3 26993.6 27100.6 10:56:02 INFO - 2016-02-22 10:56:02,315 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,315 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31961.48 Median:2257.20 stddev:106120.66 (4701.4%) stddev-sans-first:106391.80 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: Values: 343.0 343.8 349.2 352.2 359.0 15242.8 15419.5 17580.7 18094.6 19676.7 18243.5 18258.9 18278.9 18413.6 18709.2 5546.6 5668.7 5671.2 5674.4 5681.2 4263.3 4400.0 5621.3 6033.3 6235.3 6113.7 6249.9 6284.6 6314.1 6323.4 6106.8 6168.1 6188.6 6193.5 6193.7 4905.9 5377.5 5381.5 5385.2 5385.5 11804.2 11985.6 12092.4 12178.8 12202.8 2252.0 2257.9 2267.8 2268.0 2336.9 9106.9 9211.1 9300.9 9961.8 13837.0 1862.6 1874.2 1927.7 1959.4 1977.3 61577.4 63412.0 63695.0 65255.0 65763.7 9904.6 10108.2 10143.0 10201.2 10210.9 13176.3 13294.2 13298.5 13302.0 13334.3 7047.6 7164.9 7172.5 7189.0 7244.0 6812.4 6821.2 6832.8 6845.8 6854.5 3933.3 4079.6 4103.5 4197.2 4251.4 1604.5 1701.3 1711.7 1748.2 1755.6 410.9 414.0 415.3 423.7 1002.8 8965.6 9089.0 9655.7 10105.0 10340.1 413.5 424.1 431.9 433.7 438.9 5487.7 5544.8 5549.1 5606.9 5667.8 627980.0 638613.3 646646.0 663048.0 667243.0 84481.2 85655.6 87674.0 87967.6 88933.0 1162.3 1195.2 1198.2 1204.3 1212.2 15943.2 15988.6 16110.8 16118.0 16390.3 37202.6 37777.4 37779.4 38636.6 38913.2 49902.8 50741.0 51222.0 51416.0 53322.7 9045.0 9439.2 9528.9 9530.1 9569.0 10868.2 14052.0 17912.5 18271.3 18700.8 15610.0 15750.1 15777.1 15779.3 15861.6 11011.5 13641.7 14867.5 15098.2 15463.6 14469.1 14831.3 14907.0 15070.6 15206.1 8864.5 9016.0 9304.7 9369.3 9385.5 14325.6 14409.3 14542.6 14624.6 15018.3 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5504.67 Median:6384.89 stddev:2833.87 (44.4%) stddev-sans-first:2826.25 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: Values: 1552.5 1600.8 1612.0 1774.3 1861.8 7595.7 7958.3 7966.6 7976.3 7990.1 6782.6 6929.4 7415.7 7571.1 7837.4 2256.5 2274.6 2298.4 2301.0 2303.7 1997.1 2299.8 2330.0 2367.3 2370.7 1998.8 2216.2 2279.4 2279.4 2279.7 2218.4 2244.0 2251.2 2254.7 2255.2 2257.0 2259.0 2280.7 2283.6 2285.2 7833.3 7899.0 7916.2 7919.7 7920.1 4656.2 4709.9 4723.0 4746.1 4752.0 3128.5 3142.1 3164.0 3177.0 3247.8 1012.6 1017.7 1021.9 1058.0 1064.2 10685.7 10701.3 10733.8 10733.8 10737.9 4048.4 4048.5 4112.9 4144.8 4146.3 9150.1 9154.7 9166.4 9178.7 9190.8 4657.1 4699.5 4702.1 4709.2 4720.9 4250.7 4252.7 4298.0 4307.9 4309.0 3712.4 3752.4 3763.4 3779.2 3810.5 1076.4 1093.9 1187.4 1193.3 1200.4 1209.3 1217.2 1243.0 1303.8 1308.9 7372.2 7450.3 7461.7 7464.7 7477.0 1166.8 1168.8 1199.1 1200.8 1200.9 5808.7 5867.6 5872.1 5874.3 5883.2 9005.2 9379.6 9479.9 9495.3 9500.0 9406.6 9409.8 9414.8 9417.4 9422.2 7312.8 7411.4 7484.7 7514.8 7524.7 7230.8 7275.7 7291.8 7308.3 7315.0 8274.9 8400.4 8475.1 8478.9 8480.4 8478.8 8646.8 8659.8 8670.6 8683.3 7007.9 7058.6 7059.0 7062.3 7063.1 7591.1 7626.8 7686.8 7692.6 7695.1 6264.8 6543.0 7225.3 7259.9 7335.5 6852.3 6919.4 6944.7 6997.3 7017.2 6884.3 6915.4 6932.9 6940.7 6947.1 6504.9 6606.9 6721.4 6733.5 6738.1 6769.3 6810.9 6812.5 6813.9 6820.2 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,316 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5403.59 Median:6164.46 stddev:1630.47 (26.4%) stddev-sans-first:1589.91 10:56:02 INFO - 2016-02-22 10:56:02,317 DEBUG : BROWSER_OUTPUT: Values: 327.9 331.0 335.4 335.7 338.0 6006.4 6056.4 6144.0 6151.7 6156.4 5906.9 5979.8 6064.0 6071.0 6073.2 4687.7 4694.7 4696.3 4698.0 4701.3 4500.3 4558.2 4567.2 4595.8 4710.5 4637.2 4657.1 4666.7 4677.1 4683.8 4650.3 4662.8 4667.6 4667.8 4686.2 4102.8 4105.5 4106.7 4109.3 4109.4 5689.4 5771.3 5774.2 5788.6 5790.0 5417.6 5427.0 5428.5 5431.3 5438.8 6172.6 6427.3 6436.0 6437.2 6438.7 4346.1 4358.3 4408.0 4417.8 4426.8 6617.6 6621.7 6643.0 6652.3 6657.6 4472.9 4506.0 4509.2 4516.1 4518.7 4466.2 4558.1 4561.6 4571.3 4580.1 5300.4 5310.6 5313.3 5315.7 5320.5 6457.9 6458.9 6462.8 6465.8 6466.6 1636.0 1641.6 1642.2 1643.2 1646.4 1094.7 1097.4 1121.4 1122.1 1126.0 6230.1 6238.0 6241.3 6247.0 6248.8 6647.2 6670.2 6673.6 6686.3 6688.1 6086.9 6214.4 6242.1 6246.3 6248.2 3582.1 3610.5 3610.9 3617.7 3620.7 6832.2 6856.7 6865.6 6877.6 6880.8 6678.5 6830.2 6839.4 6839.4 6845.7 6846.1 6850.7 6858.1 6869.6 6872.7 6453.0 6617.0 6651.9 6655.7 6658.6 6510.3 6515.1 6643.8 6644.3 6662.0 6895.3 6896.0 6908.6 6909.3 6912.3 4565.8 4661.6 4663.5 4671.4 4675.0 6722.6 6730.6 6732.2 6737.3 6739.6 6534.1 6544.6 6549.1 6551.8 6554.0 6358.6 6529.9 6536.4 6538.6 6542.9 6415.7 6417.0 6422.5 6436.8 6444.4 6553.4 6558.7 6558.7 6564.7 6573.1 6242.3 6403.9 6406.5 6434.6 6448.5 10:56:02 INFO - 2016-02-22 10:56:02,317 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,317 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14225.54 Median:4410.77 stddev:16156.58 (366.3%) stddev-sans-first:16170.50 10:56:02 INFO - 2016-02-22 10:56:02,318 DEBUG : BROWSER_OUTPUT: Values: 811.7 834.7 900.6 913.4 947.1 12757.7 13081.9 13542.7 13575.7 13623.9 12958.2 13018.4 13065.0 13101.2 13111.4 723.1 732.1 874.5 882.7 902.7 883.7 885.0 885.4 888.5 890.1 919.8 925.1 933.0 935.5 936.1 748.8 758.8 910.2 923.3 923.7 691.8 693.2 693.3 695.2 698.0 13242.0 13426.0 13452.3 13463.5 13478.2 12026.8 12444.4 12478.8 12552.5 12902.2 10562.7 10574.5 10599.5 10620.8 10638.3 3797.5 3834.7 3838.9 3842.9 3844.2 46095.0 46711.8 46978.1 47127.3 47792.8 9883.3 9955.9 10082.2 10101.3 10231.4 18068.8 18202.8 18205.4 18229.6 18291.3 7588.2 7641.5 7707.0 7751.7 7789.6 4387.6 4451.1 4482.5 4491.4 4535.0 3134.5 3140.4 3141.9 3144.8 3155.9 539.7 549.5 550.2 553.7 562.4 699.2 700.3 718.6 742.6 756.6 10044.6 10199.4 10204.2 10267.7 10312.0 544.5 576.5 600.1 610.3 701.6 4348.8 4433.9 4438.2 4515.8 4561.5 58294.7 58497.0 58594.4 58781.1 58912.7 51355.5 52907.0 53516.2 54202.7 54282.7 45216.8 47819.0 48053.5 48113.3 48762.0 9085.7 9094.5 9146.0 9316.3 9355.6 34400.7 35037.3 35062.0 35377.0 35878.6 41316.8 45476.1 47052.8 47088.4 47604.3 11888.2 11921.3 12287.1 12420.4 12498.3 13087.0 13180.7 13301.6 13386.9 13539.6 12049.8 12107.6 12344.3 12580.7 12621.6 12798.2 12831.5 12838.4 13482.7 13492.0 11371.7 11408.6 11787.8 11822.4 11914.9 10146.2 10380.3 10732.7 10769.9 10825.1 10323.5 10677.0 10688.5 10691.6 10769.2 10:56:02 INFO - 2016-02-22 10:56:02,318 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:56:02 INFO - 2016-02-22 10:56:02,318 DEBUG : BROWSER_OUTPUT: 10:56:02 INFO - 2016-02-22 10:56:02,873 INFO : Browser exited with error code: 0 10:56:02 INFO - 2016-02-22 10:56:02,891 INFO : Completed test dromaeo_css (00:18:29) 10:56:02 INFO - 2016-02-22 10:56:02,891 INFO : Starting test kraken 10:56:02 INFO - 2016-02-22 10:56:02,891 DEBUG : operating with platform_type : linux_ 10:56:02 INFO - 2016-02-22 10:56:02,891 INFO : Initialising browser for kraken test... 10:56:02 INFO - 2016-02-22 10:56:02,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJxDgnD/profile http://localhost:44641/getInfo.html 10:56:06 INFO - 2016-02-22 10:56:06,652 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:56:06 INFO - 2016-02-22 10:56:06,652 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:56:06 INFO - 2016-02-22 10:56:06,652 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:56:06 INFO - 2016-02-22 10:56:06,652 DEBUG : BROWSER_OUTPUT: __metrics 10:56:06 INFO - 2016-02-22 10:56:06,801 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:56:07 INFO - 2016-02-22 10:56:07,549 INFO : Browser initialized. 10:56:07 INFO - 2016-02-22 10:56:07,550 INFO : Running cycle 1/1 for kraken test... 10:56:07 INFO - 2016-02-22 10:56:07,550 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJxDgnD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:56:19 INFO - 2016-02-22 10:56:19,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 132841472 10:56:19 INFO - 2016-02-22 10:56:19,149 DEBUG : BROWSER_OUTPUT: 10:56:21 INFO - 2016-02-22 10:56:21,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44641/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:22 INFO - 2016-02-22 10:56:22,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 166367232 10:56:22 INFO - 2016-02-22 10:56:22,150 DEBUG : BROWSER_OUTPUT: 10:56:24 INFO - 2016-02-22 10:56:24,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44641/tests/kraken/driver.html?testName=audio-dft) 10:56:25 INFO - 2016-02-22 10:56:25,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 164941824 10:56:25 INFO - 2016-02-22 10:56:25,300 DEBUG : BROWSER_OUTPUT: 10:56:28 INFO - 2016-02-22 10:56:28,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44641/tests/kraken/driver.html?testName=audio-fft) 10:56:28 INFO - 2016-02-22 10:56:28,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 161378304 10:56:28 INFO - 2016-02-22 10:56:28,634 DEBUG : BROWSER_OUTPUT: 10:56:30 INFO - 2016-02-22 10:56:30,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44641/tests/kraken/driver.html?testName=audio-oscillator) 10:56:31 INFO - 2016-02-22 10:56:31,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 160882688 10:56:31 INFO - 2016-02-22 10:56:31,196 DEBUG : BROWSER_OUTPUT: 10:56:33 INFO - 2016-02-22 10:56:33,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:33 INFO - 2016-02-22 10:56:33,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 160231424 10:56:33 INFO - 2016-02-22 10:56:33,919 DEBUG : BROWSER_OUTPUT: 10:56:36 INFO - 2016-02-22 10:56:36,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44641/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:37 INFO - 2016-02-22 10:56:37,343 DEBUG : BROWSER_OUTPUT: RSS: Main: 160731136 10:56:37 INFO - 2016-02-22 10:56:37,343 DEBUG : BROWSER_OUTPUT: 10:56:40 INFO - 2016-02-22 10:56:40,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44641/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:41 INFO - 2016-02-22 10:56:41,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 159383552 10:56:41 INFO - 2016-02-22 10:56:41,267 DEBUG : BROWSER_OUTPUT: 10:56:43 INFO - 2016-02-22 10:56:43,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44641/tests/kraken/driver.html?testName=json-parse-financial) 10:56:44 INFO - 2016-02-22 10:56:44,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 158806016 10:56:44 INFO - 2016-02-22 10:56:44,537 DEBUG : BROWSER_OUTPUT: 10:56:46 INFO - 2016-02-22 10:56:46,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:46 INFO - 2016-02-22 10:56:46,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 163885056 10:56:46 INFO - 2016-02-22 10:56:46,665 DEBUG : BROWSER_OUTPUT: 10:56:48 INFO - 2016-02-22 10:56:48,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:56:49 INFO - 2016-02-22 10:56:49,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 162951168 10:56:49 INFO - 2016-02-22 10:56:49,026 DEBUG : BROWSER_OUTPUT: 10:56:50 INFO - 2016-02-22 10:56:50,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:56:51 INFO - 2016-02-22 10:56:51,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 169619456 10:56:51 INFO - 2016-02-22 10:56:51,544 DEBUG : BROWSER_OUTPUT: 10:56:53 INFO - 2016-02-22 10:56:53,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:54 INFO - 2016-02-22 10:56:54,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 175988736 10:56:54 INFO - 2016-02-22 10:56:54,472 DEBUG : BROWSER_OUTPUT: 10:56:56 INFO - 2016-02-22 10:56:56,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:56:57 INFO - 2016-02-22 10:56:57,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 173240320 10:56:57 INFO - 2016-02-22 10:56:57,486 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44641/tests/kraken/driver.html?testName=ai-astar) 10:56:59 INFO - 2016-02-22 10:56:59,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 232423424 10:56:59 INFO - 2016-02-22 10:56:59,394 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,394 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:56:59 INFO - 2016-02-22 10:56:59,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:56:59 INFO - 2016-02-22 10:56:59,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:56:59 INFO - 2016-02-22 10:56:59,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:56:59 INFO - 2016-02-22 10:56:59,395 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;108;109;108;98;109;110;109 10:56:59 INFO - 2016-02-22 10:56:59,395 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;123;152;169;122;144;154;124;160;121 10:56:59 INFO - 2016-02-22 10:56:59,395 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;163;160;160;159;159;160;159;160 10:56:59 INFO - 2016-02-22 10:56:59,395 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;71;162;77;71;73;71;160;73 10:56:59 INFO - 2016-02-22 10:56:59,396 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;135;92;92;92;133;93;93;131 10:56:59 INFO - 2016-02-22 10:56:59,396 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;108;110;109;108;109 10:56:59 INFO - 2016-02-22 10:56:59,396 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;145;145;145;147;145;146 10:56:59 INFO - 2016-02-22 10:56:59,396 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;95;95;95;95;95;95;94;95 10:56:59 INFO - 2016-02-22 10:56:59,396 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;62;70;57;57;56;56;57;55;57 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;65;65;65;64;65;65;65 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;75;77;77;78;77;79;78;77;77;77 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;107;108;123;117;117;126;114;120;112 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;133;138;142;139;140;139;140;140;137 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;66;64;65;62;68;63;63;62;62 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:56:59 INFO - 2016-02-22 10:56:59,397 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167419388__endTimestamp 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:3.89 (3.6%) stddev-sans-first:4.12 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 108.0 109.0 108.0 98.0 109.0 110.0 109.0 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,398 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.10 Median:152.00 stddev:18.03 (11.9%) stddev-sans-first:18.77 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: Values: 152.0 123.0 152.0 169.0 122.0 144.0 154.0 124.0 160.0 121.0 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 163.0 160.0 160.0 159.0 159.0 160.0 159.0 160.0 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.00 Median:71.00 stddev:37.47 (52.8%) stddev-sans-first:39.11 10:56:59 INFO - 2016-02-22 10:56:59,399 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 162.0 77.0 71.0 73.0 71.0 160.0 73.0 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:92.00 stddev:19.63 (21.3%) stddev-sans-first:20.28 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 135.0 92.0 92.0 92.0 133.0 93.0 93.0 131.0 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 108.0 110.0 109.0 108.0 109.0 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 147.0 145.0 146.0 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 10:56:59 INFO - 2016-02-22 10:56:59,400 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:4.52 (7.9%) stddev-sans-first:4.72 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: Values: 56.0 62.0 70.0 57.0 57.0 56.0 56.0 57.0 55.0 57.0 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:1.03 (1.3%) stddev-sans-first:0.73 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: Values: 75.0 77.0 77.0 78.0 77.0 79.0 78.0 77.0 77.0 77.0 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,401 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:118.50 stddev:6.36 (5.4%) stddev-sans-first:6.44 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: Values: 122.0 107.0 108.0 123.0 117.0 117.0 126.0 114.0 120.0 112.0 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.00 stddev:2.44 (1.7%) stddev-sans-first:2.55 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: Values: 140.0 133.0 138.0 142.0 139.0 140.0 139.0 140.0 140.0 137.0 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.99 (3.1%) stddev-sans-first:2.09 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 64.0 65.0 62.0 68.0 63.0 63.0 62.0 62.0 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:56:59 INFO - 2016-02-22 10:56:59,402 DEBUG : BROWSER_OUTPUT: 10:57:00 INFO - 2016-02-22 10:57:00,105 INFO : Browser exited with error code: 0 10:57:00 INFO - 2016-02-22 10:57:00,156 INFO : Completed test kraken (00:00:57) 10:57:00 INFO - 2016-02-22 10:57:00,156 INFO : Starting test v8_7 10:57:00 INFO - 2016-02-22 10:57:00,156 DEBUG : operating with platform_type : linux_ 10:57:00 INFO - 2016-02-22 10:57:00,156 INFO : Initialising browser for v8_7 test... 10:57:00 INFO - 2016-02-22 10:57:00,162 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBXszHi/profile http://localhost:44641/getInfo.html 10:57:03 INFO - 2016-02-22 10:57:03,889 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:03 INFO - 2016-02-22 10:57:03,889 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:03 INFO - 2016-02-22 10:57:03,889 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:03 INFO - 2016-02-22 10:57:03,889 DEBUG : BROWSER_OUTPUT: __metrics 10:57:04 INFO - 2016-02-22 10:57:04,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:04 INFO - 2016-02-22 10:57:04,917 INFO : Browser initialized. 10:57:04 INFO - 2016-02-22 10:57:04,918 INFO : Running cycle 1/1 for v8_7 test... 10:57:04 INFO - 2016-02-22 10:57:04,918 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBXszHi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:57:16 INFO - 2016-02-22 10:57:16,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 132923392 10:57:16 INFO - 2016-02-22 10:57:16,568 DEBUG : BROWSER_OUTPUT: 10:57:37 INFO - 2016-02-22 10:57:37,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44641/tests/v8_7/run.html (next: http://localhost:44641/tests/v8_7/run.html) 10:57:38 INFO - 2016-02-22 10:57:38,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 425062400 10:57:38 INFO - 2016-02-22 10:57:38,148 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,148 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: |0;Richards;168.15200941651253 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.6090534979424 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 10:57:38 INFO - 2016-02-22 10:57:38,149 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:57:38 INFO - 2016-02-22 10:57:38,150 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 10:57:38 INFO - 2016-02-22 10:57:38,151 DEBUG : BROWSER_OUTPUT: |5;Earley;540.8328826392644 10:57:38 INFO - 2016-02-22 10:57:38,151 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 10:57:38 INFO - 2016-02-22 10:57:38,151 DEBUG : BROWSER_OUTPUT: |7;RegExp;24536.585365853658 10:57:38 INFO - 2016-02-22 10:57:38,151 DEBUG : BROWSER_OUTPUT: |8;Splay;524.504692387904 10:57:38 INFO - 2016-02-22 10:57:38,151 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: __startTimestamp1456167458147__endTimestamp 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,152 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: Values: 168.2 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.61 Median:164.61 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: Values: 164.6 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,153 DEBUG : BROWSER_OUTPUT: Values: 278.4 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: Values: 949.7 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,154 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.83 Median:540.83 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: Values: 540.8 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: Values: 10526.3 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24536.59 Median:24536.59 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,155 DEBUG : BROWSER_OUTPUT: Values: 24536.6 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.50 Median:524.50 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: Values: 524.5 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:38 INFO - 2016-02-22 10:57:38,156 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2016-02-22 10:57:38,821 INFO : Browser exited with error code: 0 10:57:38 INFO - 2016-02-22 10:57:38,839 INFO : Completed test v8_7 (00:00:38) 10:57:39 INFO - 2016-02-22 10:57:39,194 INFO : Completed test suite (00:20:05) 10:57:39 INFO - 2016-02-22 10:57:39,194 DEBUG : Working with test: dromaeo_css 10:57:39 INFO - 2016-02-22 10:57:39,194 DEBUG : Generating results file: dromaeo_css 10:57:39 INFO - 2016-02-22 10:57:39,196 DEBUG : Working with test: kraken 10:57:39 INFO - 2016-02-22 10:57:39,196 DEBUG : Generating results file: kraken 10:57:39 INFO - 2016-02-22 10:57:39,196 INFO : javascript benchmark 10:57:39 INFO - 2016-02-22 10:57:39,196 DEBUG : Working with test: v8_7 10:57:39 INFO - 2016-02-22 10:57:39,197 DEBUG : Generating results file: v8_7 10:57:39 INFO - 2016-02-22 10:57:39,197 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:39 INFO - 2016-02-22 10:57:39,269 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:57:39 INFO - 2016-02-22 10:57:39,269 DEBUG : process_Request line: dromaeo_css 7180.44 graph.html#tests=[[72,53,35]] 10:57:39 INFO - 2016-02-22 10:57:39,269 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:39 INFO - 2016-02-22 10:57:39,309 DEBUG : process_Request line: kraken 1473.30 graph.html#tests=[[232,53,35]] 10:57:39 INFO - 2016-02-22 10:57:39,309 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:57:39 INFO - 2016-02-22 10:57:39,352 DEBUG : process_Request line: v8_7 23263.23 graph.html#tests=[[230,53,35]] 10:57:39 INFO - 2016-02-22 10:57:39,353 INFO : javascript benchmark 10:57:39 INFO - 2016-02-22 10:57:39,357 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3304.818234997075, 3370.6460821613746, 3389.762716609838, 3399.745019123566, 3416.4362880124772, 5564.443555644439, 5571.621265137298, 5587.720613969305, 5588.804391846286, 5603.887922241558, 5580.135079062752, 5581.0, 5589.580781441398, 5590.413006634306, 5606.579506537006, 4836.347093142434, 5050.898982020367, 5072.51811077947, 5127.9230811537855, 5189.792408303663, 5006.374203224597, 5039.974800125994, 5070.847874563769, 5072.594192464594, 5075.593952483792, 4985.277134815449, 5000.524950129732, 5062.164742817431, 5062.594992400599, 5063.316452278932, 4997.925031124536, 5035.84892453227, 5077.873053173664, 5107.233914912756, 5115.897682046339, 4998.0, 5056.974715126437, 5073.188289873639, 5100.617453690988, 5111.284420181178, 5267.552258058031, 5286.233496143076, 5400.946815371004, 5402.054640437907, 5409.053415652245, 5904.616199947032, 5905.143754155666, 5908.734106965154, 5912.704364781786, 5930.733117009745, 5926.2295901532525, 5945.435183657545, 5948.97025514874, 5955.464008239279, 5957.6127551709, 5412.431694672042, 5480.0, 5488.121900495901, 5508.173773933902, 5549.19536667181, 6000.759969601254, 6010.909836352458, 6022.728977196037, 6027.21646185993, 6040.395960404012, 5829.09649004405, 5840.707964601838, 5842.912356314659, 5844.620099693507, 5848.736806843703, 5828.504577110993, 5829.242198514251, 5932.7330270137945, 5939.287285525765, 5971.880562388728, 5830.883382332329, 5871.706414679249, 5875.177475153482, 5878.735456904364, 5896.675682837399, 5870.911936320958, 5873.647581145145, 5888.941110588839, 5894.145348924382, 5895.115732640138, 4387.012922092567, 4462.665300102505, 4482.125985432875, 4483.50681425043, 4540.886477838015, 3975.920481590352, 3979.2837289288204, 3991.1618560102124, 4007.579204183577, 4014.9397759033636, 5643.40744221859, 5660.745266463019, 5664.037113690682, 5666.943330566724, 5676.063449530781, 5772.913406298909, 5907.616004959664, 5918.408159184047, 6031.306399763996, 6058.333583305833, 5618.775248990077, 5655.688937108499, 5656.943430565641, 5659.603827732101, 5661.2923384576925, 4996.800127994912, 5221.477852214824, 5222.112240918977, 5223.973880130575, 5249.763760630781, 5946.524278057745, 6044.516438684895, 6104.511639068953, 6107.835087457426, 6130.50136427355, 5928.170056192051, 5972.402759723993, 5973.55198360116, 5979.2824861015215, 5993.31076926159, 5850.356460789395, 6129.325774164928, 6136.417040381157, 6137.1101190328045, 6140.140380346666, 5800.709964501673, 5863.589548731547, 5870.853228669317, 5895.793647222326, 5901.409859014064, 5964.433378829004, 6007.399260074132, 6008.639481631116, 6010.909836352371, 6020.518358531394, 5633.549316054788, 5854.795082172103, 5857.824265272048, 5865.296164460292, 5867.090600956859, 5732.484076433141, 5767.0, 5812.796552120655, 5815.3893841147765, 5826.970865145647, 5772.336181339199, 5794.82615521535, 5796.59423840344, 5811.651300921958, 5816.360200377871, 5643.181738647791, 5825.50483208932, 5898.498627616701, 5898.997170481114, 5901.114832775118, 5730.111832665943, 5746.569007324384, 5750.5112065474905, 5751.827445176651, 5795.188673585786], "unit": "ms", "name": "dojo.html", "value": 5473.2632684165765}, {"lowerIsBetter": false, "replicates": [602.3434456442477, 621.4903778901297, 637.3721883944314, 639.3606393606393, 648.4002297874465, 32313.838430807842, 40364.394534082014, 40376.39435408471, 40475.0, 40501.39247911284, 46520.76739616306, 46995.765021174935, 47066.76466617671, 47092.529074709244, 47094.0581188376, 8152.796180095515, 8209.466384685005, 8218.958905205465, 9149.359544831865, 9356.906430935705, 8220.383471239651, 8326.417150799447, 11106.888931110707, 11337.603183888565, 11372.715682107972, 11045.061169800576, 11125.833112503318, 11129.777404451906, 11133.554657813718, 11134.49894754738, 10884.891151088466, 10946.835797463045, 10989.780204395867, 10992.780144397148, 10996.505157267942, 10785.5685772569, 10911.181661375349, 10930.234883558154, 10930.672079837617, 10936.726581835439, 42504.3624345635, 42861.571384286384, 43059.35410968838, 43162.35256471155, 43211.35182972258, 3727.2172843702583, 3894.6494815466463, 4178.582141785797, 4256.978325201929, 4440.755758433284, 32726.509102363485, 33010.17474563131, 33131.33737325264, 33286.50070248924, 33373.0, 3923.2545816295096, 3934.595286021684, 3942.64516193544, 3943.1325108476376, 3946.2304850554156, 306118.0, 307999.0, 309214.0, 309988.0, 310952.0, 58580.0, 59973.99999999913, 66951.66524167349, 67473.32526674769, 68101.65949170223, 66735.0, 67107.32892671108, 67386.66306668436, 67403.66298168477, 67498.66250668715, 14390.352434140488, 14430.567082987527, 14535.636609084646, 14550.781738273934, 14588.197649129399, 10897.182711296684, 10963.177761667906, 10971.725706857393, 10975.121990240761, 10987.285826421257, 22121.889390552944, 22605.321840344815, 22621.547569048525, 22630.66054009191, 22683.886580566992, 8287.709930152416, 8546.145385461528, 8630.741077767678, 8649.308055355556, 8710.956445217733, 1027.8817935937313, 1051.3324039234988, 1062.516554967488, 1144.9599264025885, 1154.099802154321, 30433.23916902095, 30481.542776858365, 30831.383372332428, 33919.32161356759, 34680.65319346825, 1087.456271864068, 1113.799516087096, 1136.6419577832955, 1156.3582211872492, 1217.34263497712, 14913.776293355608, 15868.20658967047, 17084.82915170857, 17821.287148513915, 17887.910560447115, 422617.0, 427452.0, 428502.0, 429050.0, 429063.0, 62892.0, 63228.0, 63283.0, 63347.36652633507, 63394.68302658457, 1455.1778245291378, 1461.875740562043, 1461.8976671633097, 1462.6782107936237, 1475.837657857635, 31254.843725781226, 31261.0, 31499.0, 31810.840945796048, 31913.202169945936, 51802.22296665478, 51968.22047669212, 52293.7385313071, 52300.47699523108, 52312.21531677104, 320428.0, 323829.0, 324677.0, 324841.63054292987, 324982.0, 30578.388432230786, 31378.372432551678, 33933.66066339305, 34805.65194348024, 36359.81820090883, 39116.41325380179, 39410.605893940694, 39600.80199598984, 39996.40005399863, 40763.1847363057, 37179.814100929325, 37870.8106459477, 38076.23847523089, 38179.23641527209, 38700.22599547937, 35136.0, 38130.237395252494, 42945.570544294154, 43950.560494394646, 44907.326390103524, 37921.43117853179, 38550.61449385582, 39520.40719389154, 39581.40627890641, 39603.80198098991, 35324.470132947514, 36208.09479763027, 36349.27301454009, 38827.0, 39814.40278395768, 26894.596581050908, 26912.730872691023, 26934.32664183411, 26993.595096073183, 27100.593491097254], "unit": "ms", "name": "ext.html", "value": 20408.465440139233}, {"lowerIsBetter": false, "replicates": [342.951986721859, 343.84011434682867, 349.1742030098817, 352.1829355894325, 358.9784612923224, 15242.847571524282, 15419.460318888841, 17580.73628895566, 18094.638107237864, 19676.704849427253, 18243.543911402223, 18258.908705456488, 18278.908605456953, 18413.631727365446, 18709.158087886044, 5546.639468434559, 5668.744906479218, 5671.2060311556415, 5674.404187560309, 5681.23303354046, 4263.339182426714, 4400.0, 5621.269234999444, 6033.27600687918, 6235.251769787632, 6113.6943152842405, 6249.937500625004, 6284.622922624634, 6314.14759007535, 6323.367663233663, 6106.755729770804, 6168.105624684418, 6188.628682279078, 6193.535484838655, 6193.659348735818, 4905.8773530661665, 5377.516023557899, 5381.461853814626, 5385.219143224211, 5385.515303622693, 11804.173707840455, 11985.64043078709, 12092.39538023104, 12178.75642487154, 12202.755944881053, 2251.954960900789, 2257.8645281283175, 2267.7505474397803, 2267.9886600566892, 2336.941576460585, 9106.86339704905, 9211.078892110801, 9300.906990930072, 9961.75095622608, 13837.0, 1862.6367858267643, 1874.240932422371, 1927.6626590346773, 1959.4121763471044, 1977.2684106880401, 61577.384226157614, 63412.0, 63695.0, 65255.0, 65763.67118164379, 9904.55429505674, 10108.191344692406, 10143.0, 10201.183905287558, 10210.948945255226, 13176.275304858325, 13294.20234785916, 13298.534551290659, 13302.0, 13334.26661533625, 7047.647617619201, 7164.856702866018, 7172.46206534512, 7188.964055179691, 7244.0, 6812.420944219698, 6821.21556021054, 6832.829179270558, 6845.794626161223, 6854.5201835872, 3933.331333673282, 4079.63283304504, 4103.548609652936, 4197.202531519063, 4251.44731184944, 1604.478544473051, 1701.2854601067581, 1711.7090094683933, 1748.1958299182263, 1755.5698853780905, 410.860307495447, 413.991720165595, 415.262908337703, 423.658954541597, 1002.8094662014194, 8965.596548155218, 9089.0, 9655.662051828152, 10105.0, 10340.069393754598, 413.50379544546064, 424.0607055372303, 431.9481662200556, 433.7484259129697, 438.8705331927025, 5487.725613719298, 5544.750486228048, 5549.139883318092, 5606.85982850432, 5667.773289068391, 627980.0, 638613.3434306774, 646646.0, 663048.0, 667243.0, 84481.15518844733, 85655.57172214099, 87674.0, 87967.56016219877, 88933.0, 1162.273579013117, 1195.2111606339774, 1198.2271434924598, 1204.313541281461, 1212.248405988293, 15943.20283985773, 15988.600284992968, 16110.758338624695, 16118.0, 16390.344386224417, 37202.627973721, 37777.433338499395, 37779.43330850094, 38636.6136338633, 38913.2217355657, 49902.750486247336, 50741.0, 51221.97556048784, 51415.97168056693, 53322.73338633282, 9045.0, 9439.150476457151, 9528.904710952802, 9530.094641009093, 9568.95215523918, 10868.18488613373, 14052.0, 17912.462626121236, 18271.26914923388, 18700.81299186991, 15610.0, 15750.133742644264, 15777.053376797428, 15779.28993195286, 15861.603459913595, 11011.504482298476, 13641.727165456437, 14867.479638212611, 15098.245087745789, 15463.613409664847, 14469.131852088909, 14831.33259003369, 14907.0, 15070.623234419227, 15206.08763474195, 8864.512451815212, 9016.0, 9304.72085837426, 9369.25045996305, 9385.483798391155, 14325.64185895361, 14409.279536023367, 14542.563723088324, 14624.634384140481, 15018.324175411914], "unit": "ms", "name": "jquery.html", "value": 8399.593729208811}, {"lowerIsBetter": false, "replicates": [1552.4721594657815, 1600.807903051634, 1612.0252690454192, 1774.254812978549, 1861.7579714637104, 7595.696172153114, 7958.32354249888, 7966.641501132449, 7976.322012628933, 7990.121086680468, 6782.559133656321, 6929.411000065001, 7415.666295016724, 7571.053618297713, 7837.373010159188, 2256.548690261946, 2274.624686926655, 2298.4139044543704, 2301.0, 2303.6890019847274, 1997.1212666426798, 2299.7700229977036, 2329.9767002329927, 2367.3134790910617, 2370.668106465096, 1998.7601487821482, 2216.2021672198, 2279.3731723776013, 2279.418748219202, 2279.7036385269894, 2218.4232099654205, 2243.9663405048937, 2251.189571754167, 2254.7294324681143, 2255.154317131076, 2256.9548609027893, 2259.0399080390766, 2280.749117597063, 2283.566122436732, 2285.2001799370087, 7833.334166595846, 7898.960505197495, 7916.168802275735, 7919.683212671486, 7920.089189743138, 4656.161890859644, 4709.905801883978, 4723.0, 4746.074515469485, 4751.95248047522, 3128.5307203919365, 3142.0785370720646, 3163.984180079085, 3177.0468859342104, 3247.7888937219004, 1012.5899010900597, 1017.7252141921714, 1021.9080282774586, 1057.9523921423554, 1064.2018486135398, 10685.679429617125, 10701.304415212986, 10733.83899241512, 10733.83899241512, 10737.946310268399, 4048.4332193492933, 4048.4534587830854, 4112.91774164515, 4144.834206631761, 4146.253674338588, 9150.084991500797, 9154.72535823913, 9166.358354915092, 9178.724638260863, 9190.770230744285, 4657.0918670858855, 4699.506551812011, 4702.059588082398, 4709.175894218498, 4720.88197795051, 4250.744955302692, 4252.681048921343, 4298.032942587893, 4307.870763877088, 4308.9569104309185, 3712.350338690718, 3752.380857158593, 3763.3790424580184, 3779.168582911755, 3810.48558444612, 1076.3703233608271, 1093.8960798724108, 1187.4122309456875, 1193.2899924544881, 1200.447794014763, 1209.3348658237935, 1217.2209785737136, 1242.9931755278253, 1303.791393377055, 1308.8691130887025, 7372.152202496782, 7450.2549745026145, 7461.664225109883, 7464.70141194357, 7477.027986361738, 1166.8133098704336, 1168.7720894425674, 1199.064729510983, 1200.765850659113, 1200.903927685783, 5808.738606762706, 5867.559933005042, 5872.0898260769645, 5874.295084589877, 5883.2057672213705, 9005.234555062892, 9379.577918993662, 9479.905200947902, 9495.335326527076, 9500.0, 9406.623735050658, 9409.764755881159, 9414.811703765887, 9417.434953902788, 9422.199113075465, 7312.780616581511, 7411.4070874328845, 7484.738034168778, 7514.812129696801, 7524.699012039567, 7230.824415615505, 7275.745348912763, 7291.781246562611, 7308.30571095745, 7315.0, 8274.917250827415, 8400.369972251983, 8475.067742548192, 8478.91521084806, 8480.448770829877, 8478.830423391375, 8646.783830404038, 8659.826803464022, 8670.609822557873, 8683.261922736638, 7007.929920700728, 7058.611776352144, 7059.0, 7062.329078737512, 7063.117110361205, 7591.051118610174, 7626.809329766578, 7686.846263074819, 7692.576908270099, 7695.115061767744, 6264.843378915563, 6543.0, 7225.313595208447, 7259.891101633374, 7335.523190992782, 6852.349026842442, 6919.411849992807, 6944.687489063105, 6997.265287144776, 7017.193022802443, 6884.277150899284, 6915.446764258747, 6932.896006559805, 6940.652967351713, 6947.131608548932, 6504.934950650433, 6606.900896486461, 6721.395074443323, 6733.494987875831, 6738.124043874265, 6769.255381907888, 6810.897836532356, 6812.523123381316, 6813.863722725617, 6820.249772524919], "unit": "ms", "name": "mootools.html", "value": 4540.247188314163}, {"lowerIsBetter": false, "replicates": [327.87212986935083, 330.99834500827495, 335.4180496837986, 335.71631970984527, 337.99831000844983, 6006.369331220214, 6056.3943605639415, 6143.969280153604, 6151.723172457239, 6156.353582873795, 5906.88186236275, 5979.760809567623, 6063.969680151593, 6071.028635418334, 6073.240844894388, 4687.71873687579, 4694.741789201593, 4696.295555666643, 4697.953020469803, 4701.294805779126, 4500.257457519506, 4558.179527685015, 4567.246404343279, 4595.816167353302, 4710.458297295821, 4637.188492013884, 4657.06858628274, 4666.673332866701, 4677.13473007493, 4683.812647494096, 4650.325702773112, 4662.836800711976, 4667.626589872836, 4667.766611669403, 4686.20334543125, 4102.794860257005, 4105.466289382391, 4106.67146628269, 4109.2808758467445, 4109.445224894631, 5689.431056894319, 5771.336296325934, 5774.16274640179, 5788.623739456964, 5790.04464263396, 5417.6478528895495, 5427.0, 5428.45715428458, 5431.266778984826, 5438.782448702047, 6172.567920245585, 6427.260865000538, 6436.002419624966, 6437.1631687880745, 6438.678066096723, 4346.1090476452255, 4358.302671572565, 4407.955920440787, 4417.845375411845, 4426.845060422902, 6617.569857959265, 6621.70202340891, 6642.966785166043, 6652.301508341603, 6657.567258128206, 4472.932906006413, 4506.0, 4509.188346097734, 4516.096780643885, 4518.728876267434, 4466.173757854743, 4558.0655965526985, 4561.566651168134, 4571.26859702446, 4580.106879158532, 5300.443453437333, 5310.575153987672, 5313.335833020872, 5315.734213289397, 5320.547753440924, 6457.870842583122, 6458.903116453257, 6462.838429039311, 6465.77369792055, 6466.644334561644, 1635.9856888728825, 1641.622426841809, 1642.2445674989638, 1643.2441077104666, 1646.4484397726656, 1094.7372630568607, 1097.4457898761075, 1121.3664279682116, 1122.141561705296, 1125.954961801535, 6230.127782110508, 6237.96881015592, 6241.251049874044, 6247.0, 6248.750049997949, 6647.202335719745, 6670.232923213795, 6673.566218195899, 6686.297938716462, 6688.097106890605, 6086.878262434727, 6214.4407003369915, 6242.09489624002, 6246.250449946036, 6248.156498872685, 3582.1044738815294, 3610.548681414823, 3610.9277814443562, 3617.6744093031225, 3620.656037676469, 6832.180138383425, 6856.725730970805, 6865.622390768456, 6877.6217308047535, 6880.793576192722, 6678.49911256648, 6830.214525329551, 6839.350261725128, 6839.384455399038, 6845.726170953106, 6846.110005699326, 6850.691718872663, 6858.142732158481, 6869.553479023847, 6872.656367181721, 6452.9677351612945, 6617.0, 6651.900221496585, 6655.667216639245, 6658.600483970978, 6510.31641677636, 6515.0553169791065, 6643.800685979429, 6644.335566443317, 6662.034005069335, 6895.310468953065, 6896.034555162381, 6908.5509441886115, 6909.2745261748805, 6912.308769123048, 4565.840195593139, 4661.557152070548, 4663.510331415153, 4671.43942726875, 4674.953250467588, 6722.596644201363, 6730.629815360202, 6732.192136943598, 6737.326267373223, 6739.629320387426, 6534.1178940844275, 6544.574602650812, 6549.083128362128, 6551.836204094936, 6554.049662798963, 6358.586691865014, 6529.902051469327, 6536.411722944958, 6538.607683539003, 6542.901856472252, 6415.711292991733, 6417.0, 6422.486201103994, 6436.806895793134, 6444.420002199637, 6553.4101930826455, 6558.672066396756, 6558.704858281293, 6564.737410503717, 6573.112629794917, 6242.3133455320785, 6403.903941440975, 6406.455451286693, 6434.581752186093, 6448.45188158993], "unit": "ms", "name": "prototype.html", "value": 4871.656268337416}, {"lowerIsBetter": false, "replicates": [811.7321283976285, 834.6828205281992, 900.6172376739886, 913.4473643445715, 947.1002547579801, 12757.681057973543, 13081.934590327048, 13542.72914541711, 13575.660608484794, 13623.863761362383, 12958.157719748233, 13018.414171362288, 13065.0, 13101.213927164377, 13111.409986550605, 723.0636325957871, 732.1031736123259, 874.514644372373, 882.6513527156769, 902.7291812456269, 883.6730409748402, 885.0353115104534, 885.3758100539137, 888.5424006636588, 890.1009979920294, 919.8298314811781, 925.0887875442684, 933.0296491648677, 935.4574346878794, 936.1247233836351, 748.8352562436255, 758.7761610324967, 910.1626503616656, 923.2567782934735, 923.7136487688771, 691.816668582826, 693.19935474527, 693.2789898505548, 695.2144077192739, 698.0053423870963, 13242.0, 13426.0, 13452.32738363078, 13463.528776492776, 13478.19130852152, 12026.759464810742, 12444.440000200013, 12478.75042499145, 12552.497900083985, 12902.225866447949, 10562.735931601695, 10574.524146413352, 10599.523021464052, 10620.787584248272, 10638.255322127454, 3797.487339209199, 3834.654881060718, 3838.8848334550007, 3842.9423558646645, 3844.192719528902, 46095.0, 46711.76644116758, 46978.060438791035, 47127.29309060333, 47792.76103619529, 9883.30816842814, 9955.850662240073, 10082.24383171265, 10101.292909496411, 10231.386116833013, 18068.819311806976, 18202.817971820114, 18205.36281230177, 18229.63540729178, 18291.268349266145, 7588.165301816795, 7641.541507509567, 7707.0, 7751.651175697107, 7789.571573563395, 4387.605115539553, 4451.132029254264, 4482.46210454741, 4491.416115904912, 4535.047639995638, 3134.5298205268937, 3140.4347217501067, 3141.937161256762, 3144.795588286754, 3155.889543865954, 539.6654074473773, 549.4560385218605, 550.1939658400463, 553.7120697237414, 562.4403718300317, 699.2133849419403, 700.3024033105213, 718.576040136322, 742.6212631557944, 756.6216891554222, 10044.648437304659, 10199.38803671782, 10204.183665306758, 10267.691969240936, 10312.0, 544.4936209325286, 576.4869266352949, 600.0609046841679, 610.331686802959, 701.6281370873445, 4348.826046958149, 4433.933490997638, 4438.178936896685, 4515.75163366018, 4561.543845615478, 58294.7085264571, 58497.0, 58594.4140558589, 58781.118283225784, 58912.70543647254, 51355.48644513507, 52907.0, 53516.197257040396, 54202.728986354814, 54282.72858635682, 45216.77391613021, 47819.0, 48053.51946480491, 48113.278300825514, 48762.0, 9085.682001129928, 9094.499802510925, 9145.954270228607, 9316.254699623878, 9355.625774969198, 34400.65599344075, 35037.299254015285, 35062.0, 35377.0, 35878.64121358858, 41316.79341603273, 45476.09047819091, 47052.7647361761, 47088.35190768306, 47604.28593571168, 11888.167828251939, 11921.34432606215, 12287.078469115031, 12420.378981051092, 12498.312592807119, 13087.0, 13180.670483237996, 13301.600951971457, 13386.866131338951, 13539.59381218565, 12049.81925271104, 12107.576234831738, 12344.321062341658, 12580.748385032066, 12621.558245461365, 12798.16811907223, 12831.486740530274, 12838.358082096045, 13482.662933426744, 13492.0, 11371.658850234506, 11408.600698975495, 11787.823182652095, 11822.40887955616, 11914.940425297818, 10146.188304935735, 10380.273380863267, 10732.678019659423, 10769.869163737694, 10825.079868210974, 10323.535440905327, 10677.033946520058, 10688.465576720977, 10691.572337106429, 10769.192310576582], "unit": "ms", "name": "yui.html", "value": 6603.8066414351015}], "name": "dromaeo_css", "value": 7180.437517658365}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 108.0, 109.0, 108.0, 98.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 152.0, 169.0, 122.0, 144.0, 154.0, 124.0, 160.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 163.0, 160.0, 160.0, 159.0, 159.0, 160.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 162.0, 77.0, 71.0, 73.0, 71.0, 160.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 135.0, 92.0, 92.0, 92.0, 133.0, 93.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 62.0, 70.0, 57.0, 57.0, 56.0, 56.0, 57.0, 55.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 77.0, 78.0, 77.0, 79.0, 78.0, 77.0, 77.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.2}, {"lowerIsBetter": true, "replicates": [122.0, 107.0, 108.0, 123.0, 117.0, 117.0, 126.0, 114.0, 120.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [140.0, 133.0, 138.0, 142.0, 139.0, 140.0, 139.0, 140.0, 140.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 64.0, 65.0, 62.0, 68.0, 63.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1473.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [164.6090534979424], "unit": "score", "name": "DeltaBlue", "value": 401.66685000000007}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [540.8328826392644], "unit": "score", "name": "Earley", "value": 1232.290087}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [24536.585365853658], "unit": "score", "name": "RegExp", "value": 37.12761928429422}, {"lowerIsBetter": false, "replicates": [524.504692387904], "unit": "score", "name": "Splay", "value": 155.3675328031809}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23263.226112582695}]} 10:57:39 INFO - RETURN: dromaeo_css: 7180.44 10:57:39 INFO - RETURN: kraken: 1473.30 10:57:39 INFO - RETURN: v8_7: 23263.23 10:57:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23263.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7180.44"}}} 10:57:39 INFO - Return code: 0 10:57:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:57:39 INFO - # TBPL SUCCESS # 10:57:39 INFO - Running post-action listener: _resource_record_post_action 10:57:39 INFO - Running post-run listener: _resource_record_post_run 10:57:40 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 315392; Write bytes: 509136896; Read time: 68; Write time: 598092 10:57:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243707904; Read time: 0; Write time: 365160 10:57:40 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 315392; Write bytes: 265428992; Read time: 68; Write time: 232932 10:57:40 INFO - Running post-run listener: _upload_blobber_files 10:57:40 INFO - Blob upload gear active. 10:57:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:57:40 INFO - Copying logs to upload dir... 10:57:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.823395 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-02-22 10:57:40.272697) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:40.276549) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009899 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1456155656/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:40.330009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:40.330385) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456166188.150063-1729959598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 10:57:40.381112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 10:57:40.381458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 10:57:40.381773) ========= ========= Total master_lag: 0.86 =========