builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1453403397.44 results: success (0) buildid: 20160121084622 builduid: ee8132ddca664ba6ae16769ae49bcf78 revision: 737f3b6e93c64099d651f7805dc61121250c73c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.440488) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.441798) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.442560) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006280 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.471203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.471552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.487316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.488021) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.539422) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.540043) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.540872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.541481) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:09:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-01-21 11:09:57 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.671728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.672115) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:57.724620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 11:09:57.725386) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 737f3b6e93c64099d651f7805dc61121250c73c0 --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-aurora --rev 737f3b6e93c64099d651f7805dc61121250c73c0 --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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:09:58,100 truncating revision to first 12 chars 2016-01-21 11:09:58,100 Setting DEBUG logging. 2016-01-21 11:09:58,100 attempt 1/10 2016-01-21 11:09:58,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/737f3b6e93c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:09:58,810 unpacking tar archive at: mozilla-aurora-737f3b6e93c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.021431 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 11:09:58.782733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:58.783152) ========= echo 737f3b6e93c64099d651f7805dc61121250c73c0 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'737f3b6e93c64099d651f7805dc61121250c73c0'] 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 737f3b6e93c64099d651f7805dc61121250c73c0 program finished with exit code 0 elapsedTime=0.004723 script_repo_revision: '737f3b6e93c64099d651f7805dc61121250c73c0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:58.837634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:58.837993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:09:58.851983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-21 11:09:58.852323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:09:59 INFO - MultiFileLogger online at 20160121 11:09:59 in /builds/slave/test-pgo 11:09:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:09:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:09:59 INFO - {'append_to_log': False, 11:09:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:09:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:09:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:09:59 INFO - 'branch': 'Mozilla-Aurora', 11:09:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:59 INFO - 'config_files': ('talos/linux_config.py',), 11:09:59 INFO - 'default_actions': ('clobber', 11:09:59 INFO - 'read-buildbot-config', 11:09:59 INFO - 'download-and-extract', 11:09:59 INFO - 'populate-webroot', 11:09:59 INFO - 'create-virtualenv', 11:09:59 INFO - 'install', 11:09:59 INFO - 'run-tests'), 11:09:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:59 INFO - 'download_minidump_stackwalk': True, 11:09:59 INFO - 'download_symbols': 'ondemand', 11:09:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:59 INFO - 'installer_path': 'installer.exe', 11:09:59 INFO - 'log_level': 'info', 11:09:59 INFO - 'log_name': 'talos', 11:09:59 INFO - 'log_to_console': True, 11:09:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:09:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:09:59 INFO - 'opt_config_files': (), 11:09:59 INFO - 'pip_index': False, 11:09:59 INFO - 'sps_profile': False, 11:09:59 INFO - 'sps_profile_interval': 0, 11:09:59 INFO - 'suite': 'dromaeojs', 11:09:59 INFO - 'system_bits': '32', 11:09:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:59 INFO - 'title': 'talos-linux64-ix-023', 11:09:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:59 INFO - 'use_talos_json': True, 11:09:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:09:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:59 INFO - 'work_dir': 'build'} 11:09:59 INFO - ##### 11:09:59 INFO - ##### Running clobber step. 11:09:59 INFO - ##### 11:09:59 INFO - Running pre-action listener: _resource_record_pre_action 11:09:59 INFO - Running main action method: clobber 11:09:59 INFO - rmtree: /builds/slave/test-pgo/build 11:09:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:09:59 INFO - Running post-action listener: _resource_record_post_action 11:09:59 INFO - ##### 11:09:59 INFO - ##### Running read-buildbot-config step. 11:09:59 INFO - ##### 11:09:59 INFO - Running pre-action listener: _resource_record_pre_action 11:09:59 INFO - Running main action method: read_buildbot_config 11:09:59 INFO - Using buildbot properties: 11:09:59 INFO - { 11:09:59 INFO - "properties": { 11:09:59 INFO - "buildnumber": 102, 11:09:59 INFO - "product": "firefox", 11:09:59 INFO - "script_repo_revision": "production", 11:09:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:09:59 INFO - "repository": "", 11:09:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:09:59 INFO - "buildid": "20160121084622", 11:09:59 INFO - "slavename": "talos-linux64-ix-023", 11:09:59 INFO - "pgo_build": "True", 11:09:59 INFO - "basedir": "/builds/slave/test-pgo", 11:09:59 INFO - "project": "", 11:09:59 INFO - "platform": "ubuntu64_hw", 11:09:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:09:59 INFO - "slavebuilddir": "test", 11:09:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:09:59 INFO - "branch": "mozilla-aurora", 11:09:59 INFO - "repo_path": "releases/mozilla-aurora", 11:09:59 INFO - "stage_platform": "linux64-pgo", 11:09:59 INFO - "builduid": "ee8132ddca664ba6ae16769ae49bcf78", 11:09:59 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:09:59 INFO - }, 11:09:59 INFO - "sourcestamp": { 11:09:59 INFO - "repository": "", 11:09:59 INFO - "hasPatch": false, 11:09:59 INFO - "project": "", 11:09:59 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:09:59 INFO - "changes": [ 11:09:59 INFO - { 11:09:59 INFO - "category": null, 11:09:59 INFO - "files": [ 11:09:59 INFO - { 11:09:59 INFO - "url": null, 11:09:59 INFO - "name": "https://queue.taskcluster.net/v1/task/sBIPRMg6RXqj3KEOyYOEFg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:09:59 INFO - } 11:09:59 INFO - ], 11:09:59 INFO - "repository": "", 11:09:59 INFO - "rev": "8d81327764e1cf434e2847ed4b92117db5d43842", 11:09:59 INFO - "who": "mconley@mozilla.com", 11:09:59 INFO - "when": 1453403174, 11:09:59 INFO - "number": 7494749, 11:09:59 INFO - "comments": "Bug 1233803 - Add sessionHistory shim for gBrowser and remote browsers. r=krizsa, a=sylvestre", 11:09:59 INFO - "project": "", 11:09:59 INFO - "at": "Thu 21 Jan 2016 11:06:14", 11:09:59 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:09:59 INFO - "revlink": "", 11:09:59 INFO - "properties": [ 11:09:59 INFO - [ 11:09:59 INFO - "buildid", 11:09:59 INFO - "20160121083822", 11:09:59 INFO - "Change" 11:09:59 INFO - ], 11:09:59 INFO - [ 11:09:59 INFO - "builduid", 11:09:59 INFO - "b9c400e214f54a5f83c330a60471df34", 11:09:59 INFO - "Change" 11:09:59 INFO - ], 11:09:59 INFO - [ 11:09:59 INFO - "pgo_build", 11:09:59 INFO - "True", 11:09:59 INFO - "Change" 11:09:59 INFO - ] 11:09:59 INFO - ], 11:09:59 INFO - "revision": "8d81327764e1cf434e2847ed4b92117db5d43842" 11:09:59 INFO - }, 11:09:59 INFO - { 11:09:59 INFO - "category": null, 11:09:59 INFO - "files": [ 11:09:59 INFO - { 11:09:59 INFO - "url": null, 11:09:59 INFO - "name": "https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:09:59 INFO - } 11:09:59 INFO - ], 11:09:59 INFO - "repository": "", 11:09:59 INFO - "rev": "737f3b6e93c64099d651f7805dc61121250c73c0", 11:09:59 INFO - "who": "kcambridge@mozilla.com", 11:09:59 INFO - "when": 1453403237, 11:09:59 INFO - "number": 7494755, 11:09:59 INFO - "comments": "Bug 1234054 - Only enable service worker notifications on Desktop and non-release B2G/Android. r=ehsan; a=sylvestre", 11:09:59 INFO - "project": "", 11:09:59 INFO - "at": "Thu 21 Jan 2016 11:07:17", 11:09:59 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:09:59 INFO - "revlink": "", 11:09:59 INFO - "properties": [ 11:09:59 INFO - [ 11:09:59 INFO - "buildid", 11:09:59 INFO - "20160121084622", 11:09:59 INFO - "Change" 11:09:59 INFO - ], 11:09:59 INFO - [ 11:09:59 INFO - "builduid", 11:09:59 INFO - "ee8132ddca664ba6ae16769ae49bcf78", 11:09:59 INFO - "Change" 11:09:59 INFO - ], 11:09:59 INFO - [ 11:09:59 INFO - "pgo_build", 11:09:59 INFO - "True", 11:09:59 INFO - "Change" 11:09:59 INFO - ] 11:09:59 INFO - ], 11:09:59 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:09:59 INFO - } 11:09:59 INFO - ], 11:09:59 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:09:59 INFO - } 11:09:59 INFO - } 11:09:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:09:59 INFO - Running post-action listener: _resource_record_post_action 11:09:59 INFO - ##### 11:09:59 INFO - ##### Running download-and-extract step. 11:09:59 INFO - ##### 11:09:59 INFO - Running pre-action listener: _resource_record_pre_action 11:09:59 INFO - Running main action method: download_and_extract 11:09:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:09: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')]} 11:09:59 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json 11:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json 11:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:10:00 INFO - Downloaded 1302 bytes. 11:10:00 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:10:00 INFO - Using the following test package requirements: 11:10:00 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:10:00 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:10:00 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'jsshell-linux-x86_64.zip'], 11:10:00 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:10:00 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:10:00 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:10:00 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:10:00 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:10:00 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:10:00 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:10:00 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:10:00 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:10:00 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:01 INFO - Downloaded 23159508 bytes. 11:10:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:10:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:10:02 INFO - Return code: 0 11:10:02 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:10:02 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')]} 11:10:02 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:03 INFO - Downloaded 23159508 bytes. 11:10:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:10:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:10:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:10:05 INFO - Return code: 0 11:10:05 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')]} 11:10:05 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:10:06 INFO - Downloaded 11132038 bytes. 11:10:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:10:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:10:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:10:06 INFO - Return code: 0 11:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:10:06 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:10:07 INFO - Downloaded 58140726 bytes. 11:10:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:10:07 INFO - mkdir: /builds/slave/test-pgo/properties 11:10:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:10:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:10:07 INFO - Contents: 11:10:07 INFO - build_url:https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:10:07 INFO - Running post-action listener: _resource_record_post_action 11:10:07 INFO - Running post-action listener: set_extra_try_arguments 11:10:07 INFO - ##### 11:10:07 INFO - ##### Running populate-webroot step. 11:10:07 INFO - ##### 11:10:07 INFO - Running pre-action listener: _resource_record_pre_action 11:10:07 INFO - Running main action method: populate_webroot 11:10:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:10:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:10:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:10:07 INFO - '--tppagecycles', 11:10:07 INFO - '7'], 11:10:07 INFO - 'tests': ['tsvgm']}}, 11:10:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:10:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:10:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:10:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:10:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:10:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'tests': ['damp', 'tps']}, 11:10:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['damp', 'tps']}, 11:10:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:10:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:10:07 INFO - 'other': {'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'other_l64': {'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'other_nol64': {'tests': ['a11yr', 11:10:07 INFO - 'ts_paint', 11:10:07 INFO - 'tpaint', 11:10:07 INFO - 'sessionrestore', 11:10:07 INFO - 'sessionrestore_no_auto_restore']}, 11:10:07 INFO - 'svgr': {'tests': ['tsvgx', 11:10:07 INFO - 'tsvgr_opacity', 11:10:07 INFO - 'tart', 11:10:07 INFO - 'tscrollx', 11:10:07 INFO - 'cart']}, 11:10:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['tsvgx', 11:10:07 INFO - 'tsvgr_opacity', 11:10:07 INFO - 'tart', 11:10:07 INFO - 'tscrollx', 11:10:07 INFO - 'cart']}, 11:10:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'tests': ['tp5o']}, 11:10:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'talos_options': ['--e10s'], 11:10:07 INFO - 'tests': ['tp5o']}, 11:10:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'talos_options': ['--xperf_path', 11:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:07 INFO - 'tests': ['tp5n']}, 11:10:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:10:07 INFO - 'talos_options': ['--e10s', 11:10:07 INFO - '--xperf_path', 11:10:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:10:07 INFO - 'tests': ['tp5n']}}, 11:10:07 INFO - 'talos.zip': {'path': '', 11:10:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:10:07 INFO - Running post-action listener: _resource_record_post_action 11:10:07 INFO - ##### 11:10:07 INFO - ##### Running create-virtualenv step. 11:10:07 INFO - ##### 11:10:07 INFO - Running pre-action listener: _resource_record_pre_action 11:10:07 INFO - Running main action method: create_virtualenv 11:10:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:10:07 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 11:10:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:10:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:10:07 INFO - Using real prefix '/usr' 11:10:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:10:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:10:10 INFO - Installing pip.................done. 11:10:10 INFO - Return code: 0 11:10:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:10 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:10 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 11:10:10 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 11:10:10 INFO - Using env: {'DISPLAY': ':0', 11:10:10 INFO - 'HOME': '/home/cltbld', 11:10:10 INFO - 'LANG': 'en_US.UTF-8', 11:10:10 INFO - 'LANGUAGE': 'en_US:en', 11:10:10 INFO - 'LOGNAME': 'cltbld', 11:10:10 INFO - 'MAIL': '/var/mail/cltbld', 11:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:10 INFO - 'MOZ_NO_REMOTE': '1', 11:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:10 INFO - 'NO_EM_RESTART': '1', 11:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:10 INFO - 'SHELL': '/bin/bash', 11:10:10 INFO - 'SHLVL': '1', 11:10:10 INFO - 'TERM': 'linux', 11:10:10 INFO - 'TMOUT': '86400', 11:10:10 INFO - 'USER': 'cltbld', 11:10:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:10 INFO - '_': '/tools/buildbot/bin/python'} 11:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:10 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 11:10:10 INFO - Cleaning up... 11:10:10 INFO - Return code: 0 11:10:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:10 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:10 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 11:10:10 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 11:10:10 INFO - Using env: {'DISPLAY': ':0', 11:10:10 INFO - 'HOME': '/home/cltbld', 11:10:10 INFO - 'LANG': 'en_US.UTF-8', 11:10:10 INFO - 'LANGUAGE': 'en_US:en', 11:10:10 INFO - 'LOGNAME': 'cltbld', 11:10:10 INFO - 'MAIL': '/var/mail/cltbld', 11:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:10 INFO - 'MOZ_NO_REMOTE': '1', 11:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:10 INFO - 'NO_EM_RESTART': '1', 11:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:10 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:10 INFO - 'SHELL': '/bin/bash', 11:10:10 INFO - 'SHLVL': '1', 11:10:10 INFO - 'TERM': 'linux', 11:10:10 INFO - 'TMOUT': '86400', 11:10:10 INFO - 'USER': 'cltbld', 11:10:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:10 INFO - '_': '/tools/buildbot/bin/python'} 11:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:10 INFO - Downloading/unpacking psutil>=0.7.1 11:10:10 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 11:10:10 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 11:10:10 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 11:10:10 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 11:10:10 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 11:10:10 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 11:10:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:10:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:12 INFO - Installing collected packages: psutil 11:10:12 INFO - Running setup.py install for psutil 11:10:12 INFO - building 'psutil._psutil_linux' extension 11:10:12 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 11:10:12 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 11:10:12 INFO - building 'psutil._psutil_posix' extension 11:10:12 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 11:10:12 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 11:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:10:13 INFO - Successfully installed psutil 11:10:13 INFO - Cleaning up... 11:10:13 INFO - Return code: 0 11:10:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:13 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:13 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 11:10:13 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 11:10:13 INFO - Using env: {'DISPLAY': ':0', 11:10:13 INFO - 'HOME': '/home/cltbld', 11:10:13 INFO - 'LANG': 'en_US.UTF-8', 11:10:13 INFO - 'LANGUAGE': 'en_US:en', 11:10:13 INFO - 'LOGNAME': 'cltbld', 11:10:13 INFO - 'MAIL': '/var/mail/cltbld', 11:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:13 INFO - 'MOZ_NO_REMOTE': '1', 11:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:13 INFO - 'NO_EM_RESTART': '1', 11:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:13 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:13 INFO - 'SHELL': '/bin/bash', 11:10:13 INFO - 'SHLVL': '1', 11:10:13 INFO - 'TERM': 'linux', 11:10:13 INFO - 'TMOUT': '86400', 11:10:13 INFO - 'USER': 'cltbld', 11:10:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:13 INFO - '_': '/tools/buildbot/bin/python'} 11:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:10: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 11:10: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 11:10: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 11:10: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 11:10: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 11:10: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 11:10:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:10:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:10:15 INFO - Installing collected packages: mozsystemmonitor 11:10:15 INFO - Running setup.py install for mozsystemmonitor 11:10:15 INFO - Successfully installed mozsystemmonitor 11:10:15 INFO - Cleaning up... 11:10:15 INFO - Return code: 0 11:10:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:15 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 11:10:15 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 11:10:15 INFO - Using env: {'DISPLAY': ':0', 11:10:15 INFO - 'HOME': '/home/cltbld', 11:10:15 INFO - 'LANG': 'en_US.UTF-8', 11:10:15 INFO - 'LANGUAGE': 'en_US:en', 11:10:15 INFO - 'LOGNAME': 'cltbld', 11:10:15 INFO - 'MAIL': '/var/mail/cltbld', 11:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:15 INFO - 'MOZ_NO_REMOTE': '1', 11:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:15 INFO - 'NO_EM_RESTART': '1', 11:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:15 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:15 INFO - 'SHELL': '/bin/bash', 11:10:15 INFO - 'SHLVL': '1', 11:10:15 INFO - 'TERM': 'linux', 11:10:15 INFO - 'TMOUT': '86400', 11:10:15 INFO - 'USER': 'cltbld', 11:10:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:15 INFO - '_': '/tools/buildbot/bin/python'} 11:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:10:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:10:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:10:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:17 INFO - Downloading docopt-0.6.1.tar.gz 11:10:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:10:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:10:18 INFO - Running setup.py install for blobuploader 11:10:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:10:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:10:18 INFO - Running setup.py install for requests 11:10:18 INFO - Running setup.py install for docopt 11:10:18 INFO - Successfully installed blobuploader requests docopt 11:10:18 INFO - Cleaning up... 11:10:18 INFO - Return code: 0 11:10:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:18 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:18 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 11:10:18 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 11:10:18 INFO - Using env: {'DISPLAY': ':0', 11:10:18 INFO - 'HOME': '/home/cltbld', 11:10:18 INFO - 'LANG': 'en_US.UTF-8', 11:10:18 INFO - 'LANGUAGE': 'en_US:en', 11:10:18 INFO - 'LOGNAME': 'cltbld', 11:10:18 INFO - 'MAIL': '/var/mail/cltbld', 11:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:18 INFO - 'MOZ_NO_REMOTE': '1', 11:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:18 INFO - 'NO_EM_RESTART': '1', 11:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:18 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:18 INFO - 'SHELL': '/bin/bash', 11:10:18 INFO - 'SHLVL': '1', 11:10:18 INFO - 'TERM': 'linux', 11:10:18 INFO - 'TMOUT': '86400', 11:10:18 INFO - 'USER': 'cltbld', 11:10:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:18 INFO - '_': '/tools/buildbot/bin/python'} 11:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:10:18 INFO - Running setup.py (path:/tmp/pip-mghMmf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:10:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:10:18 INFO - Running setup.py (path:/tmp/pip-3gMKD2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:10:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:10:18 INFO - Running setup.py (path:/tmp/pip-tQLCdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:10:19 INFO - Running setup.py (path:/tmp/pip-AxqJK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:10:19 INFO - Running setup.py (path:/tmp/pip-nV3YOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:10:19 INFO - Running setup.py (path:/tmp/pip-NFUbig-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:10:19 INFO - Running setup.py (path:/tmp/pip-MyY18I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:10:19 INFO - Running setup.py (path:/tmp/pip-CdAor7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:10:19 INFO - Running setup.py (path:/tmp/pip-DngfsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:10:19 INFO - Running setup.py (path:/tmp/pip-EOxtHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:10:19 INFO - Running setup.py (path:/tmp/pip-tbT8nE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:10:19 INFO - Running setup.py (path:/tmp/pip-EGoHfh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:10:19 INFO - Running setup.py (path:/tmp/pip-ZuVoVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:10:19 INFO - Running setup.py (path:/tmp/pip-RQApaV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:10:19 INFO - Running setup.py (path:/tmp/pip-43fzxI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:10:19 INFO - Running setup.py (path:/tmp/pip-ibar_7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:10:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:10:19 INFO - Running setup.py (path:/tmp/pip-xbQ9kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:10:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:10:20 INFO - Running setup.py install for manifestparser 11:10:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Running setup.py install for mozcrash 11:10:20 INFO - Running setup.py install for mozdebug 11:10:20 INFO - Running setup.py install for mozdevice 11:10:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Running setup.py install for mozfile 11:10:20 INFO - Running setup.py install for mozhttpd 11:10:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Running setup.py install for mozinfo 11:10:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Running setup.py install for mozInstall 11:10:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:10:20 INFO - Running setup.py install for mozleak 11:10:20 INFO - Running setup.py install for mozlog 11:10:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Running setup.py install for moznetwork 11:10:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Running setup.py install for mozprocess 11:10:21 INFO - Running setup.py install for mozprofile 11:10:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Running setup.py install for mozrunner 11:10:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Running setup.py install for mozscreenshot 11:10:21 INFO - Running setup.py install for moztest 11:10:21 INFO - Running setup.py install for mozversion 11:10:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:10:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:10:21 INFO - Cleaning up... 11:10:21 INFO - Return code: 0 11:10:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:21 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:21 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 11:10:21 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 11:10:21 INFO - Using env: {'DISPLAY': ':0', 11:10:21 INFO - 'HOME': '/home/cltbld', 11:10:21 INFO - 'LANG': 'en_US.UTF-8', 11:10:21 INFO - 'LANGUAGE': 'en_US:en', 11:10:21 INFO - 'LOGNAME': 'cltbld', 11:10:21 INFO - 'MAIL': '/var/mail/cltbld', 11:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:21 INFO - 'MOZ_NO_REMOTE': '1', 11:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:21 INFO - 'NO_EM_RESTART': '1', 11:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:21 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:21 INFO - 'SHELL': '/bin/bash', 11:10:21 INFO - 'SHLVL': '1', 11:10:21 INFO - 'TERM': 'linux', 11:10:21 INFO - 'TMOUT': '86400', 11:10:21 INFO - 'USER': 'cltbld', 11:10:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:21 INFO - '_': '/tools/buildbot/bin/python'} 11:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:10:22 INFO - Running setup.py (path:/tmp/pip-TZwo3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:10:22 INFO - Running setup.py (path:/tmp/pip-ptpPb2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:10:22 INFO - Running setup.py (path:/tmp/pip-5iqEP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:10:22 INFO - Running setup.py (path:/tmp/pip-f6y56L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:10:22 INFO - Running setup.py (path:/tmp/pip-ee46om-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:10:22 INFO - Running setup.py (path:/tmp/pip-KOtcwZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:10:22 INFO - Running setup.py (path:/tmp/pip-fDTybl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:10:22 INFO - Running setup.py (path:/tmp/pip-w9e6eQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:10:22 INFO - Running setup.py (path:/tmp/pip-sz513J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:10:22 INFO - Running setup.py (path:/tmp/pip-EkSK4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:10:22 INFO - Running setup.py (path:/tmp/pip-QP7496-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:10:22 INFO - Running setup.py (path:/tmp/pip-qqt7fG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:10:22 INFO - Running setup.py (path:/tmp/pip-UdxKrV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:10:22 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)) 11:10:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:10:22 INFO - Running setup.py (path:/tmp/pip-2vCCWt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:10:23 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)) 11:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:10:23 INFO - Running setup.py (path:/tmp/pip-cgfDj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:10:23 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)) 11:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:10:23 INFO - Running setup.py (path:/tmp/pip-AOkCpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:10:23 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)) 11:10:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:10:23 INFO - Running setup.py (path:/tmp/pip-ebcwC5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:10:23 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)) 11:10:23 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)) 11:10:23 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)) 11:10:23 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)) 11:10:23 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)) 11:10:23 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)) 11:10:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:10:23 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 11:10:23 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 11:10:23 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 11:10:23 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 11:10:23 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 11:10:23 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 11:10:25 INFO - Downloading blessings-1.6.tar.gz 11:10:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:10:25 INFO - Installing collected packages: blessings 11:10:25 INFO - Running setup.py install for blessings 11:10:25 INFO - Successfully installed blessings 11:10:25 INFO - Cleaning up... 11:10:25 INFO - Return code: 0 11:10:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:10:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:10:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:10:25 INFO - Reading from file tmpfile_stdout 11:10:25 INFO - Current package versions: 11:10:25 INFO - argparse == 1.2.1 11:10:25 INFO - blessings == 1.6 11:10:25 INFO - blobuploader == 1.2.4 11:10:25 INFO - docopt == 0.6.1 11:10:25 INFO - manifestparser == 1.1 11:10:25 INFO - mozInstall == 1.12 11:10:25 INFO - mozcrash == 0.16 11:10:25 INFO - mozdebug == 0.1 11:10:25 INFO - mozdevice == 0.47 11:10:25 INFO - mozfile == 1.2 11:10:25 INFO - mozhttpd == 0.7 11:10:25 INFO - mozinfo == 0.9 11:10:25 INFO - mozleak == 0.1 11:10:25 INFO - mozlog == 3.1 11:10:25 INFO - moznetwork == 0.27 11:10:25 INFO - mozprocess == 0.22 11:10:25 INFO - mozprofile == 0.27 11:10:25 INFO - mozrunner == 6.11 11:10:25 INFO - mozscreenshot == 0.1 11:10:25 INFO - mozsystemmonitor == 0.0 11:10:25 INFO - moztest == 0.7 11:10:25 INFO - mozversion == 1.4 11:10:25 INFO - psutil == 3.1.1 11:10:25 INFO - requests == 1.2.3 11:10:25 INFO - wsgiref == 0.1.2 11:10:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:10:25 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')]} 11:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:25 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')]} 11:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:25 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:25 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 11:10:25 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 11:10:25 INFO - Using env: {'DISPLAY': ':0', 11:10:25 INFO - 'HOME': '/home/cltbld', 11:10:25 INFO - 'LANG': 'en_US.UTF-8', 11:10:25 INFO - 'LANGUAGE': 'en_US:en', 11:10:25 INFO - 'LOGNAME': 'cltbld', 11:10:25 INFO - 'MAIL': '/var/mail/cltbld', 11:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:25 INFO - 'MOZ_NO_REMOTE': '1', 11:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:25 INFO - 'NO_EM_RESTART': '1', 11:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:25 INFO - 'SHELL': '/bin/bash', 11:10:25 INFO - 'SHLVL': '1', 11:10:25 INFO - 'TERM': 'linux', 11:10:25 INFO - 'TMOUT': '86400', 11:10:25 INFO - 'USER': 'cltbld', 11:10:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:25 INFO - '_': '/tools/buildbot/bin/python'} 11:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 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)) 11:10:25 INFO - Cleaning up... 11:10:25 INFO - Return code: 0 11:10:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:10:25 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')]} 11:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:25 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')]} 11:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:25 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:25 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 11:10:25 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 11:10:25 INFO - Using env: {'DISPLAY': ':0', 11:10:25 INFO - 'HOME': '/home/cltbld', 11:10:25 INFO - 'LANG': 'en_US.UTF-8', 11:10:25 INFO - 'LANGUAGE': 'en_US:en', 11:10:25 INFO - 'LOGNAME': 'cltbld', 11:10:25 INFO - 'MAIL': '/var/mail/cltbld', 11:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:25 INFO - 'MOZ_NO_REMOTE': '1', 11:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:25 INFO - 'NO_EM_RESTART': '1', 11:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:25 INFO - 'SHELL': '/bin/bash', 11:10:25 INFO - 'SHLVL': '1', 11:10:25 INFO - 'TERM': 'linux', 11:10:25 INFO - 'TMOUT': '86400', 11:10:25 INFO - 'USER': 'cltbld', 11:10:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:25 INFO - '_': '/tools/buildbot/bin/python'} 11:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:25 INFO - Downloading/unpacking jsonschema 11:10:25 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 11:10:25 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 11:10:25 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 11:10:25 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 11:10:25 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 11:10:25 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 11:10:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:10:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:10:27 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 11:10:27 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 11:10:27 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 11:10:27 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 11:10:27 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 11:10:27 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 11:10:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:10:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:10:27 INFO - warning: no files found matching '*.txt' 11:10:27 INFO - no previously-included directories found matching 'build' 11:10:27 INFO - no previously-included directories found matching 'dist' 11:10:27 INFO - no previously-included directories found matching '.git*' 11:10:27 INFO - Installing collected packages: jsonschema, functools32 11:10:28 INFO - Running setup.py install for functools32 11:10:28 INFO - warning: no files found matching '*.txt' 11:10:28 INFO - no previously-included directories found matching 'build' 11:10:28 INFO - no previously-included directories found matching 'dist' 11:10:28 INFO - no previously-included directories found matching '.git*' 11:10:28 INFO - Successfully installed jsonschema functools32 11:10:28 INFO - Cleaning up... 11:10:28 INFO - Return code: 0 11:10:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:10:28 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')]} 11:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:28 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')]} 11:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:28 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 0x7fe9ea4d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, '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': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', '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 11:10:28 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 11:10:28 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 11:10:28 INFO - Using env: {'DISPLAY': ':0', 11:10:28 INFO - 'HOME': '/home/cltbld', 11:10:28 INFO - 'LANG': 'en_US.UTF-8', 11:10:28 INFO - 'LANGUAGE': 'en_US:en', 11:10:28 INFO - 'LOGNAME': 'cltbld', 11:10:28 INFO - 'MAIL': '/var/mail/cltbld', 11:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:28 INFO - 'MOZ_NO_REMOTE': '1', 11:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:28 INFO - 'NO_EM_RESTART': '1', 11:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:28 INFO - 'SHELL': '/bin/bash', 11:10:28 INFO - 'SHLVL': '1', 11:10:28 INFO - 'TERM': 'linux', 11:10:28 INFO - 'TMOUT': '86400', 11:10:28 INFO - 'USER': 'cltbld', 11:10:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:28 INFO - '_': '/tools/buildbot/bin/python'} 11:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:28 INFO - Downloading/unpacking flake8 11:10:28 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 11:10:28 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 11:10:28 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 11:10:28 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 11:10:28 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 11:10:28 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 11:10:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:10:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:10:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:30 INFO - no previously-included directories found matching 'docs/_build' 11:10:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:10:30 INFO - Running setup.py install for pep8 11:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:10:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:10:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:10:30 INFO - no previously-included directories found matching 'docs/_build' 11:10:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:10:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:10:31 INFO - Cleaning up... 11:10:31 INFO - Return code: 0 11:10:31 INFO - Running post-action listener: _resource_record_post_action 11:10:31 INFO - Running post-action listener: _start_resource_monitoring 11:10:31 INFO - Starting resource monitoring. 11:10:31 INFO - ##### 11:10:31 INFO - ##### Running install step. 11:10:31 INFO - ##### 11:10:31 INFO - Running pre-action listener: _resource_record_pre_action 11:10:31 INFO - Running main action method: install 11:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:10:31 INFO - Reading from file tmpfile_stdout 11:10:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:10:31 INFO - Reading from file tmpfile_stdout 11:10:31 INFO - Output received: 11:10:31 INFO - Usage: mozinstall [options] installer 11:10:31 INFO - Options: 11:10:31 INFO - -h, --help show this help message and exit 11:10:31 INFO - -d DEST, --destination=DEST 11:10:31 INFO - Directory to install application into. [default: 11:10:31 INFO - "/builds/slave/test-pgo"] 11:10:31 INFO - --app=APP Application being installed. [default: firefox] 11:10:31 INFO - mkdir: /builds/slave/test-pgo/build/application 11:10:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:10:45 INFO - Reading from file tmpfile_stdout 11:10:45 INFO - Output received: 11:10:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:10:45 INFO - Running post-action listener: _resource_record_post_action 11:10:45 INFO - ##### 11:10:45 INFO - ##### Running run-tests step. 11:10:45 INFO - ##### 11:10:45 INFO - Running pre-action listener: _resource_record_pre_action 11:10:45 INFO - Running main action method: run_tests 11:10:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:10:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:10:45 INFO - Python 2.7.3 11:10:45 INFO - Return code: 0 11:10:45 INFO - grabbing minidump binary from tooltool 11:10: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')]} 11:10:45 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 0x20be350>, '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 0x20bf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:10:45 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 11:10:45 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 11:10:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:46 INFO - Return code: 0 11:10:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:10:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:10:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:10:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:10:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:10:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:10:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:10:47 INFO - Return code: 0 11:10:47 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-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:10:47 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-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 11:10:47 INFO - Using env: {'DISPLAY': ':0', 11:10:47 INFO - 'HOME': '/home/cltbld', 11:10:47 INFO - 'LANG': 'en_US.UTF-8', 11:10:47 INFO - 'LANGUAGE': 'en_US:en', 11:10:47 INFO - 'LOGNAME': 'cltbld', 11:10:47 INFO - 'MAIL': '/var/mail/cltbld', 11:10:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:10:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:47 INFO - 'MOZ_NO_REMOTE': '1', 11:10:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:10:47 INFO - 'NO_EM_RESTART': '1', 11:10:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:10:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:10:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:10:47 INFO - 'SHELL': '/bin/bash', 11:10:47 INFO - 'SHLVL': '1', 11:10:47 INFO - 'TERM': 'linux', 11:10:47 INFO - 'TMOUT': '86400', 11:10:47 INFO - 'USER': 'cltbld', 11:10:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957', 11:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:47 INFO - '_': '/tools/buildbot/bin/python'} 11:10:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 11:10:47 INFO - mozversion INFO | application_buildid: 20160121084622 11:10:47 INFO - mozversion INFO | application_changeset: 737f3b6e93c64099d651f7805dc61121250c73c0 11:10:47 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:10:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:47 INFO - mozversion INFO | application_name: Firefox 11:10:47 INFO - mozversion INFO | application_remotingname: firefox-dev 11:10:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:10:47 INFO - mozversion INFO | application_vendor: Mozilla 11:10:47 INFO - mozversion INFO | application_version: 45.0a2 11:10:47 INFO - mozversion INFO | platform_buildid: 20160121084622 11:10:47 INFO - mozversion INFO | platform_changeset: 737f3b6e93c64099d651f7805dc61121250c73c0 11:10:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:10:47 INFO - mozversion INFO | platform_version: 45.0a2 11:10:47 INFO - 2016-01-21 11:10:47,326 DEBUG : using testdate: 1453403447 11:10:47 INFO - 2016-01-21 11:10:47,326 DEBUG : actual date: 1453403447 11:10:47 INFO - 2016-01-21 11:10:47,342 INFO : starting webserver on 'localhost:45722' 11:10:47 INFO - 2016-01-21 11:10:47,343 INFO : Starting test suite talos-linux64-ix-023 11:10:47 INFO - 2016-01-21 11:10:47,344 INFO : Starting test dromaeo_css 11:10:47 INFO - 2016-01-21 11:10:47,344 DEBUG : operating with platform_type : linux_ 11:10:47 INFO - 2016-01-21 11:10:47,344 INFO : Initialising browser for dromaeo_css test... 11:10:47 INFO - 2016-01-21 11:10:47,356 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOAogH9/profile http://localhost:45722/getInfo.html 11:10:51 INFO - 2016-01-21 11:10:51,281 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:10:51 INFO - 2016-01-21 11:10:51,281 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:10:51 INFO - 2016-01-21 11:10:51,281 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:10:51 INFO - 2016-01-21 11:10:51,281 DEBUG : BROWSER_OUTPUT: __metrics 11:10:51 INFO - 2016-01-21 11:10:51,409 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] 11:10:52 INFO - 2016-01-21 11:10:52,327 INFO : Browser initialized. 11:10:52 INFO - 2016-01-21 11:10:52,328 INFO : Running cycle 1/1 for dromaeo_css test... 11:10:52 INFO - 2016-01-21 11:10:52,328 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOAogH9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:11:04 INFO - 2016-01-21 11:11:04,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 138076160 11:11:04 INFO - 2016-01-21 11:11:04,106 DEBUG : BROWSER_OUTPUT: 11:11:54 INFO - 2016-01-21 11:11:54,808 DEBUG : BROWSER_OUTPUT: 1453403514807 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] 11:14:03 INFO - 2016-01-21 11:14:03,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45722/tests/dromaeo/cssquery-ext.html) 11:14:04 INFO - 2016-01-21 11:14:04,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 219828224 11:14:04 INFO - 2016-01-21 11:14:04,410 DEBUG : BROWSER_OUTPUT: 11:17:06 INFO - 2016-01-21 11:17:06,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-ext.html (next: http://localhost:45722/tests/dromaeo/cssquery-jquery.html) 11:17:07 INFO - 2016-01-21 11:17:07,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 220233728 11:17:07 INFO - 2016-01-21 11:17:07,273 DEBUG : BROWSER_OUTPUT: 11:20:09 INFO - 2016-01-21 11:20:09,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45722/tests/dromaeo/cssquery-mootools.html) 11:20:09 INFO - 2016-01-21 11:20:09,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 218697728 11:20:09 INFO - 2016-01-21 11:20:09,677 DEBUG : BROWSER_OUTPUT: 11:23:11 INFO - 2016-01-21 11:23:11,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45722/tests/dromaeo/cssquery-prototype.html) 11:23:11 INFO - 2016-01-21 11:23:11,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 205860864 11:23:11 INFO - 2016-01-21 11:23:11,992 DEBUG : BROWSER_OUTPUT: 11:26:14 INFO - 2016-01-21 11:26:14,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45722/tests/dromaeo/cssquery-yui.html) 11:26:14 INFO - 2016-01-21 11:26:14,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 209358848 11:26:14 INFO - 2016-01-21 11:26:14,990 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/dromaeo/cssquery-yui.html (next: http://localhost:45722/tests/dromaeo/cssquery-dojo.html) 11:29:17 INFO - 2016-01-21 11:29:17,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 251990016 11:29:17 INFO - 2016-01-21 11:29:17,421 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,422 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:29:17 INFO - 2016-01-21 11:29:17,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:29:17 INFO - 2016-01-21 11:29:17,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:29:17 INFO - 2016-01-21 11:29:17,422 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:29:17 INFO - 2016-01-21 11:29:17,424 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3217.694319039691;3260.608726952766;3263.494158405445;3267.9673203267976;3289.1119397762604;5359.196120581914;5375.220593014011;5386.228991963006;5404.91892621611;5447.319085114361;5433.8369848904595;5452;5461.69960652164;5462.836114916549;5467.808626698066;4871.269309603553;4950.598437647613;4995.025969935864;5019.54824065834;5030.974845125787;4962.950370496285;5024.5226703463295;5027.924581131286;5030.5975521958335;5031.849044528652;4941.283513890502;4978.850634480971;5044.369453818273;5059.114654935372;5062.9240561391425;5096.51583099605;5110.5656019238595;5136.255242989746;5137.280780690707;5163.974180129113;4967.10592093423;5030.597552195815;5075.492450754932;5084.211947148198;5093.363329583802;5159.974200129013;5190.11767999441;5281.181416880389;5284.630075894689;5293.7353132343615;5851.824445266606;5885.028970219909;5886.882262354772;5897.970510147465;5901.970490147564;5762.135679648086;5920.259967504062;5937.851553711149;5947.37552556984;5951.613145145551;5364.868477066419;5443.673379597197;5443.727813609383;5462.863428414282;5474.698891560963;5927.585069045212;5932.703364831741;5933.584649074523;5937.70311484424;5940.138679891392;5546.611737178439;5650.519705825051;5767.077267637242;5777.913331300034;5778.017736984722;5817.7963771267805;5823.4467725566;5831.650100993954;5836.416358364129;5870.14882841994;5809.7095145242565;5832.737526811304;5835;5837.532997360201;5863.237779088691;5642.097264437671;5751.079827227707;5771.365149833515;5817.7091145442555;5829.446202610745;4534.59188673021;4543.704659197141;4560.224761790503;4568.474625418053;4576.81692732287;4052.3111071117983;4053.635172834459;4063.0858056936954;4089.836406543705;4092.304308267542;5351.57187425005;5461.7711015021305;5517.889642207133;5567.025770490229;5578.525825304813;5781.71091445426;5847.239858818326;5863.413658634103;5866.941330586725;5899.292084949833;5429.375621803464;5433.320834895638;5439.646422982493;5465.59008074396;5519.613627046148;4986.102501549683;5055.797768089309;5075.264086707407;5080.74596270185;5110.28456016158;6033.3966603340195;6045.818625441244;6048.243969503812;6053.394660534;6070.2412198475195;5893.469587736953;5909.409059094056;5910.290765108214;5916.26046744157;5921.082232254007;5887.116932460165;5990.161377407079;6056.697165141637;6078.027515597483;6111.873114042709;5788.884222315614;5799;5802.5357971361345;5805;5808.477237048517;5830.446107619939;5882.411758824083;5893.675847828239;5897.351291358033;5903.911441328298;5564.4991950724625;5611.326640802967;5685.118806584986;5702.144678298288;5743.081107023024;5669.461401166883;5796.449337312949;5803;5829.387914268941;5830.416958304136;5338.786448542015;5720.056190728483;5748.109043098327;5749.080147176432;5769.480746732815;5587.161925711013;5760.884782304414;5844.795432159854;5872.207252021093;5887.499562537232;5745.052066408995;5748.109043098327;5748.741306641127;5752.539796816161;5754.424557544212 11:29:17 INFO - 2016-01-21 11:29:17,427 DEBUG : BROWSER_OUTPUT: |1;ext.html;615.2709039787851;617.9402325012604;639.2137670665082;639.8400399900025;644.2912795924481;38644;39301;39390.803045984765;39480.210395792106;39485.99999999993;45749.31376029354;46213.768931155384;46237;46278.768606157006;46293.537064629345;7927.643256053462;8041.1154772975215;8893.288536917064;9112.179903808656;9116.27069834415;10688.358698478078;10934.507947142398;10944.3980581068;10959.780804383907;10964.0680542154;10625.681229563126;10718.303310284806;10722.249442539025;10726;10727.517261723242;8230.465019773696;8420.28427583656;10555.472226388689;10643.893561064368;10760.946195269053;10425.218108641882;10522.947385263025;10592.152627789836;10592.947035264851;10594.947025264824;43527;43634.56365436369;43800;43910.12179756419;43968.78015609901;3469.548958635361;3531.134871956387;3599.352992410103;3955.745902906227;4296.9687275054075;33099.50350744717;33169.33661326784;33254.83372583122;33426.49860252098;33575.16062098467;3495.965040349615;3519.8768043118366;3536.7701099428455;3542.822858857073;3676.5036720042717;290988;292787;292802;293141;293361;56793;58531.70734146302;58553.707231464425;64999;65523;66155.66922165359;67725.66137169382;67935.32064679389;67948.32051679518;68023;15043.699126017418;15049.623759406102;15075.698486030436;15083.170425626697;15107.093574385572;13221.867781322064;13307.534236301683;13311.134776239513;13317.334133293296;13317.467301307839;20617.896910515352;21096;21100.78899211019;21271.36185914425;21307.508474406644;7667.923320766832;7805.960970195226;7847.450678452454;7934.880976785353;7936.127026027132;1010.4947526236881;1076.4671487613525;1094.9781004380027;1123.5112725964232;1159.675290918544;30123;30336.69663303383;30606.69393306083;30672.846635766677;31365;1103.9889601104046;1129.2151954391784;1152.7521582859727;1168.3106966889577;1198.4824539975027;13602.727945441036;13908.513202038082;14245.572632821031;15022.699546009018;16108.114053727157;338343;341809;341851;342650;343505;48259.276110858365;48621.75689121603;48644;48683.75658121687;48685.26972095422;1355.6407551998727;1394.3376895974534;1413.3286688822727;1464.8388677245493;1477.7044591081826;27115.59326610142;27465.45069098647;27857.72142278551;27887.16338509848;28512.144635660963;40606;41029.79485102555;41163.38254926239;45837.31244031276;46482;306442;313159;317543;317792;317793;33912.660873391935;34374.82812585921;34504.13739656529;34517.82741086379;34554.30891382208;46541.53458465372;46852.99044191897;47521.52478475171;47948.7602561985;48200.5179948196;37749.62250377571;38077.238455231294;38168.2366352677;38708.80645596754;38983.415248770725;38590.80704596459;39173.41239881461;39222.607773921896;39284.6071539281;39720.801395992836;38478.2304353917;38512.80743596264;38832.6116738829;38991.2201755969;39054.80472597619;30608.234794130323;31600.367992640477;31792.68207317897;32103.67896321007;32402.83798580992;26530.734692652826;26549;26817.865910670324;28188.43623127567;28679.283017924718 11:29:17 INFO - 2016-01-21 11:29:17,427 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.1094148217236;357.92125732338894;360.1087308910447;363.20458196549555;365.53029357275904;15409.306581203844;15869.206539673029;16902.661946761073;17526.73709894351;18375.264989400406;17514.47456576305;17546.82453175468;18182.363617273397;18427.723584146213;18892.33876814312;5374.973125134369;5461.590380721442;5490.094134467828;5491.341039075317;5494.395616482184;4142;4228.915421691564;4239.08859595187;5490.423505531921;6075.483583895374;6133.447989680928;6197.256329240475;6218.657973811439;6219.626822390671;6220.564560480768;5441.809536666217;5627.606067575251;5631.60578759487;5661.8584535386535;5667.716614169316;5367.731613419313;5436;5442.482964118402;5444.754986025639;5447.809326673548;14120.858791412056;14287.428502859873;14339;14503.927480362636;22360.10559577615;2177.4447515883508;2182.8253739700785;2193.484531135182;2273.8408311418207;2335.2177020698086;10538.104261137813;11320.377379244139;12241.265524068584;14123.435062597484;14441.422343106264;1896.0223342473378;1948.3278268997174;1967.4196112146808;1982.474644219283;1984.8015198480036;62759;66432;66629.66685166543;68592;68904.96642550366;10884.72788180286;11039.448027598588;11076.501557429934;11114.49984750672;11179.44102794857;15008.549743507712;15028.699426011419;15040.699186016438;15055.397784088733;15070.924645376703;8007.759767206993;8012.919870801334;8072.757817265491;8457.365697572706;8575.1424857515;7858.253465920843;8544.914550854412;8558.78603034929;8581.098984606526;8609.268212202032;4747.2879068140055;4777.9044419112115;4782.091402633558;4813.181759100891;4817.7350245736825;1740.0822858868362;1810.4206653870635;1816.1554876982002;1827.0864567716142;1877.3241633012105;879.9296056315479;1002.8094662014194;1031.9845202321972;1038.065740833256;1047.5233768635405;14516.927415363067;16444.424445144363;16483.6703265934;17006.659866802594;17388.82611173872;961.3174646001278;995.7751965082989;1053.7649416292063;1116.3357802107732;1141.3095077478172;10138.543765530569;10267.794644107076;10323.638672646572;10348.741281467874;10375.948120259502;583753;585366;613756;627589;633159;75018.62490687621;76213.61893190499;78161.21838781654;79437;79836.20163798287;1182.7043239190202;1196.7965445874222;1200.687821166503;1201.1711918776016;1218.5186851193728;15830.841691582937;15832;15872.365105395655;16042.919785400998;16274.186290685182;37025.814870925475;37629.62370376261;37877.431838521894;38998.22003559856;39213;50118;51285.48714512807;51863.2220516685;54061.189082163015;56472.15291770709;10018.849717254101;10410.219233557362;10522.21083418762;10537.420441875463;10556.419396933243;12623.873761262637;18018.63962720712;18258.45224643263;18552.350667726565;19096.618067638847;16040.759388608947;16060.189466843489;16257.837421625632;16363.345466181696;16409.42567010149;11329.886701132884;15655.843441565894;15877.444289449813;16125.435609753602;16317.918410408347;15018.549443516711;15216.543503694907;15334.846651533342;15621.843781562038;15637.139957302457;9901.158401535662;10343.834419195884;10433.895661043292;10471.10995565355;10638.361698298128;16228.837711622733;16271.105089220207;16286.10426426558;16293.59266018359;16577 11:29:17 INFO - 2016-01-21 11:29:17,431 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1367.6512489315223;1518.5444366689997;1520.7338715724752;1802.5673838278813;1840.2822899069356;7033.50765446419;7434.107907051155;7636.770896873103;7642;7649.311561959423;7497.4376921730955;7636.236376362361;7638.312551870331;7640.808979775508;7646.732364367248;2007.056683358819;2051.579426217629;2273.6362182050875;2336.836421450495;2377.4413012941945;2375.3467796356053;2378.583747844129;2381.8928148233285;2382;2384.95230095398;2308.7575804540534;2354.399628094842;2363.7990770784418;2366.7396586375485;2367.065009321317;2317.687112239851;2319.3158018384615;2361.740208577055;2365.73976862545;2366.727826299963;2399.196269249803;2411.1440438644204;2425.8301918865686;2427.647991041289;2437.926862194137;7853.5680537570415;7899.684012639487;7918.406119541058;7923.12845586985;7936.801579960547;4786.282057691339;4879.585235255007;4910;4914.262860570907;4917.704937703749;3030.6666266710645;3038.6353637563634;3090;3099.302656902179;3116.407882502317;951.1487218939011;972.6887396033272;981.1693264930726;986.960521579136;987.2348929579633;10781.407022613754;10833.458327083694;10843.51204195813;10850.29473084247;10851.782964340748;4247.17300329448;4262.339337402707;4333.826646934087;4338.414314067561;4343.630791382705;9294.256459483226;9305;9324.627014919462;9327.860082098774;9331.673391431268;4841.806327746921;4841.927371089437;4846.151923413388;4851.95148048515;4889.633277504201;4402.207602631493;4405.669574781904;4408.162449134654;4436.201483732894;4437.0460351024685;3500.072480792592;3523.3129539739502;3563.394222982099;3619.8371073301764;3714.8699795507027;1249.6063739921894;1249.8375211222483;1254.7866862633375;1261.7697744698846;1263.3620021888887;1126.7577470843808;1128.6557599931934;1175.6766889105565;1348.2382453913704;1414.193909471612;7459.925400746031;7488;7557.4331925105835;7564.319211271012;7571.848563028819;1155.5089087137933;1156.4911438966828;1159.7796418680423;1169.1582060916128;1176.5235079792697;5818.301803783573;5916.615419997686;5916.674582897982;5926.644401335933;5932.228810254639;9083.36416450842;9473.573689183866;9505.382150160218;9612.711618651452;9670.70987870351;9379.5310234488;9411.764705882408;9528.904710952802;9563.09150630689;9572.425654460754;7436.776896693108;7580.583067931317;7610.581418022062;7614.048243969504;7616.885746713914;7232.45756568249;7292.525985810906;7299.817504562428;7313.122425308997;7338.77983660491;8377.329813614775;8450.915490845013;8490.405671602928;8507.361947853811;8658.437201581877;8637.833892424693;8649.956750216208;8698.869516957377;8775.297976162019;8841.646334146562;6213.782517611862;7135.250798666066;7191.676374563262;7193.208747037717;7195.568265904062;6941.652917354011;7266.382357499671;7531.8493630125995;7535.660895259617;7548.584827834522;7130.857382852418;7301.707931682886;7302.087239095114;7384.446166537424;7391.482596218213;7197.928020719726;7219.241979592067;7234.16807067194;7318.194998550049;7324.96337518309;7249.130104387507;7290.198078211499;7315.049043624294;7324.926750732425;7325.194228634739;6619.867602647823;6650.434713049445;6669.533132680665;6688.866222675422;6694.263631000488;6383.457406120346;6773.729050837911;6813.0461735358085;6847.726090956506;6858.211305699709 11:29:17 INFO - 2016-01-21 11:29:17,432 DEBUG : BROWSER_OUTPUT: |4;prototype.html;356.47598030894585;357.5994885727984;360.1913703735115;365.99268014639694;366.28939856678045;6096.237970253718;6110.908336374958;6119.847003824907;6145.846353841151;6197.225346831646;6058.394160583939;6068.150458935753;6070.757169713206;6077.908831367533;6089.6955152242435;4654.138984287901;4707.764611769415;4727.787249573769;4739.73931433771;4744.9525504745025;4734.502877197896;4736.763161841911;4746.833860814872;4748.335233067356;4757.310190022445;4643.628509719214;4675.181843177447;4692.06158768246;4693.108309421199;4693.178693728601;4437.5784300491405;4514.751688657123;4590.219662657356;4651.62786977041;4694.201985662446;4136.772477513736;4140.91718165635;4170.645495132887;4174.08170202555;4179.080602267527;5612.326520817528;5754.050581654022;5815.621984570989;5817.069268916953;5842.298924129089;5308.628396012242;5379.892402151935;5497.862553436156;5509.779608815643;5528.474794894519;6420.6147631142285;6443.29123796382;6462.450691691212;6466.579672321284;6473;4589.839355622537;4627.95372046282;4632.235681112612;4633.119707255611;4634.83778067766;6470.450011749007;6581.04574836646;6625;6639.767608133692;6707.128073350434;4609.516000819933;4639.373684552542;4640.79339371759;4642;4644.0944015916575;4700.106979673851;4703.412073490814;4710.95289047112;4712.363830882856;4715.292706094045;5283.815066472655;5396.460353964572;5403;5410.702411367334;5412.404635490172;6430.324815894263;6435.131257280301;6439.7424103035355;6447.065175549519;6448;1697.2023149119893;1709.2479309103956;1710.0936503653083;1710.4783041172561;1718.8538974187084;1166.4984056855633;1168.6143572621015;1176.0591526778544;1182.5920057580122;1187.857457105153;6314.842128946813;6316.778912738032;6325.462335701425;6335.461485773761;6347.0479428086155;6712.160979877515;6721.831954201086;6724.562903411263;6729.192496900403;6729.293424190488;6158.815235542851;6288.8427789304715;6292.685365731787;6311.147995020705;6321.083442900754;3604.3512167810045;3632.4006538921312;3644.908877278089;3645.1616128290643;3646.507721457622;6915.827104322432;6943.583384996917;6965.930340696629;6968.756093536702;6977.616231107237;6680.23177334603;6810.148731408574;6846.5892046477375;6978.79063628092;6987.7204911802955;6928.965355173293;6949.30506949301;6956.269591692901;6963.651817409109;6967.407770339477;6620.3710647488415;6775.322467753185;6784.966075169593;6785.321467853372;6786.3892249697765;6611.933880661132;6615.867682646416;6621;6622;6625.933740662532;6973.511854170362;6979.476539259677;6981.685824137824;6981.685824137824;6983.406410455168;4601.0567833594705;4647.930281045719;4686.835960741358;4687.789049492849;4688.624910007123;6696.59820410777;6755.93244067553;6762.830929226809;6763.8985415219795;6769.221539522821;6591.340865913562;6592.604443733391;6595.571287866273;6596.60420374779;6601.933980660132;6463.7737679181;6561.507886908405;6587.703553340016;6589.967050164719;6592.373724496165;6437.517186210959;6464.353564643498;6466.353364663496;6489.772857949949;6494.447971922439;6588.40704336612;6621.33786621334;6623.437007854386;6626.602403855784;6638.701258443285;6358.777442789666;6437.227532696106;6463.095166676575;6466.708998095191;6483.189601299838 11:29:17 INFO - 2016-01-21 11:29:17,433 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.6059158350283;754.6830331260874;778.9639779093804;818.664347617477;851.1020872979012;14541.27293635318;15033.849661503382;15049.774253386195;15061.548153555383;15086.3211155498;13474;13574.864251357509;13590.048696591242;13597.04820662554;13597.456101755917;721.3039416962617;750.2235186581889;881.352206128495;923.445932440537;924.339097545255;912.2428384440898;913.524967017154;918.6509126531909;920.4523308631387;921.741912264567;766.5247546521165;793.9285464308211;962.2927148545813;966.8984756600561;967.4920666649995;919.5723988345418;964.0552258786429;964.7781010367655;967.1634036558362;967.3373738988815;702.6381413572014;709.4678990756933;713.6574444266729;713.9500234983553;714.3285311806885;13028.41372138256;13294.468221271138;13370.866291337157;13457.125286856322;13458.461661533527;11968.34174120423;12677.74644507114;12810.871891281062;12991.090623656348;12991.350432478339;9248.861267081;9366.20387267083;9568.56941437637;9645.228381729445;9749.805003899883;3487.232808782064;3508.0878971467346;3511.3504001759757;3518.1380561762276;3522.559680039995;50054.74972625114;50412.495875041146;51868;52274.73862630701;52303.47696523062;9518.90481095194;9895.703128906145;9917;10159.542820573091;10636.414997175076;18533.907330463262;18679.252829886926;18755.718664220047;18770.343037993876;19190.712139317922;7465.813354666177;7527.2849079337375;7565.167831538526;7598.506097103671;7766.262205090507;4177.832886684499;4302.376155457504;4411.801468933906;4417.757023363682;4436.911261774746;3135.372925414926;3163.0352742413324;3166.0660105269003;3172.587563616715;3175.063356309894;571.7570032736071;573.6042130929645;594.0732457366436;600.1208229943154;609.3540846702509;646.3536463536464;668.3951024322995;679.6533767778468;681.0975457518807;704.9400800931876;8105.731274671511;8331.625076871434;8716.95641521801;8775.956120219485;8864.335174861912;569.5472099680763;684.3567046975926;685.324954919404;687.7455341523669;701.0685561278747;4061.817218225187;4106.6242808658835;4160.750354978711;4195.077083041726;4218.7468751874985;59926.70036649789;60975.695121524106;61151.694241529396;61324;61659;53558.464415355345;54701.72649136729;54854.9999999992;55893;56223.71888140533;45875;49359.25961110586;49532;49998.25002624963;50199;8253.752387428387;8271.751847444586;8731.956340218258;8849.292056635324;8988.955055224682;36184.81907590445;37140.44289335716;37964.62035379611;38502.22995540129;39393;47556.28665570088;47738.52261477341;48024.51975480201;48861;50914.490855090975;10723.517441714985;11175;11547.133964952494;11609;11845.348505832262;12083.75832483363;12112.15214934946;12151.453184606891;12404.56584019555;13431.597052088453;10898.836517452402;11050.557977680803;11148.55405783792;11269.323840569592;11367.886321136682;10569.577216911237;10620.468976550987;10792.676219713421;11151.665450036511;11169.609063682732;9499.38254013487;9653.613855445703;9937.155341796028;10154.79690406173;10705.625303114353;9732;9805.656802011896;10010.749731256778;10132.189424846141;10267.332623379456;9529.761755955878;9935.155511781579;10062.295639305179;10067.949660251652;10137.493125343852 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404557421__endTimestamp 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5443.91 Median:5669.46 stddev:593.02 (10.5%) stddev-sans-first:568.54 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: Values: 3217.7 3260.6 3263.5 3268.0 3289.1 5359.2 5375.2 5386.2 5404.9 5447.3 5433.8 5452.0 5461.7 5462.8 5467.8 4871.3 4950.6 4995.0 5019.5 5031.0 4963.0 5024.5 5027.9 5030.6 5031.8 4941.3 4978.9 5044.4 5059.1 5062.9 5096.5 5110.6 5136.3 5137.3 5164.0 4967.1 5030.6 5075.5 5084.2 5093.4 5160.0 5190.1 5281.2 5284.6 5293.7 5851.8 5885.0 5886.9 5898.0 5902.0 5762.1 5920.3 5937.9 5947.4 5951.6 5364.9 5443.7 5443.7 5462.9 5474.7 5927.6 5932.7 5933.6 5937.7 5940.1 5546.6 5650.5 5767.1 5777.9 5778.0 5817.8 5823.4 5831.7 5836.4 5870.1 5809.7 5832.7 5835.0 5837.5 5863.2 5642.1 5751.1 5771.4 5817.7 5829.4 4534.6 4543.7 4560.2 4568.5 4576.8 4052.3 4053.6 4063.1 4089.8 4092.3 5351.6 5461.8 5517.9 5567.0 5578.5 5781.7 5847.2 5863.4 5866.9 5899.3 5429.4 5433.3 5439.6 5465.6 5519.6 4986.1 5055.8 5075.3 5080.7 5110.3 6033.4 6045.8 6048.2 6053.4 6070.2 5893.5 5909.4 5910.3 5916.3 5921.1 5887.1 5990.2 6056.7 6078.0 6111.9 5788.9 5799.0 5802.5 5805.0 5808.5 5830.4 5882.4 5893.7 5897.4 5903.9 5564.5 5611.3 5685.1 5702.1 5743.1 5669.5 5796.4 5803.0 5829.4 5830.4 5338.8 5720.1 5748.1 5749.1 5769.5 5587.2 5760.9 5844.8 5872.2 5887.5 5745.1 5748.1 5748.7 5752.5 5754.4 11:29:17 INFO - 2016-01-21 11:29:17,434 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,435 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49467.53 Median:341830.00 stddev:82806.40 (24.2%) stddev-sans-first:82957.46 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: Values: 615.3 617.9 639.2 639.8 644.3 38644.0 39301.0 39390.8 39480.2 39486.0 45749.3 46213.8 46237.0 46278.8 46293.5 7927.6 8041.1 8893.3 9112.2 9116.3 10688.4 10934.5 10944.4 10959.8 10964.1 10625.7 10718.3 10722.2 10726.0 10727.5 8230.5 8420.3 10555.5 10643.9 10760.9 10425.2 10522.9 10592.2 10592.9 10594.9 43527.0 43634.6 43800.0 43910.1 43968.8 3469.5 3531.1 3599.4 3955.7 4297.0 33099.5 33169.3 33254.8 33426.5 33575.2 3496.0 3519.9 3536.8 3542.8 3676.5 290988.0 292787.0 292802.0 293141.0 293361.0 56793.0 58531.7 58553.7 64999.0 65523.0 66155.7 67725.7 67935.3 67948.3 68023.0 15043.7 15049.6 15075.7 15083.2 15107.1 13221.9 13307.5 13311.1 13317.3 13317.5 20617.9 21096.0 21100.8 21271.4 21307.5 7667.9 7806.0 7847.5 7934.9 7936.1 1010.5 1076.5 1095.0 1123.5 1159.7 30123.0 30336.7 30606.7 30672.8 31365.0 1104.0 1129.2 1152.8 1168.3 1198.5 13602.7 13908.5 14245.6 15022.7 16108.1 338343.0 341809.0 341851.0 342650.0 343505.0 48259.3 48621.8 48644.0 48683.8 48685.3 1355.6 1394.3 1413.3 1464.8 1477.7 27115.6 27465.5 27857.7 27887.2 28512.1 40606.0 41029.8 41163.4 45837.3 46482.0 306442.0 313159.0 317543.0 317792.0 317793.0 33912.7 34374.8 34504.1 34517.8 34554.3 46541.5 46853.0 47521.5 47948.8 48200.5 37749.6 38077.2 38168.2 38708.8 38983.4 38590.8 39173.4 39222.6 39284.6 39720.8 38478.2 38512.8 38832.6 38991.2 39054.8 30608.2 31600.4 31792.7 32103.7 32402.8 26530.7 26549.0 26817.9 28188.4 28679.3 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31549.86 Median:18490.04 stddev:99403.64 (537.6%) stddev-sans-first:99654.89 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: Values: 354.1 357.9 360.1 363.2 365.5 15409.3 15869.2 16902.7 17526.7 18375.3 17514.5 17546.8 18182.4 18427.7 18892.3 5375.0 5461.6 5490.1 5491.3 5494.4 4142.0 4228.9 4239.1 5490.4 6075.5 6133.4 6197.3 6218.7 6219.6 6220.6 5441.8 5627.6 5631.6 5661.9 5667.7 5367.7 5436.0 5442.5 5444.8 5447.8 14120.9 14287.4 14339.0 14503.9 22360.1 2177.4 2182.8 2193.5 2273.8 2335.2 10538.1 11320.4 12241.3 14123.4 14441.4 1896.0 1948.3 1967.4 1982.5 1984.8 62759.0 66432.0 66629.7 68592.0 68905.0 10884.7 11039.4 11076.5 11114.5 11179.4 15008.5 15028.7 15040.7 15055.4 15070.9 8007.8 8012.9 8072.8 8457.4 8575.1 7858.3 8544.9 8558.8 8581.1 8609.3 4747.3 4777.9 4782.1 4813.2 4817.7 1740.1 1810.4 1816.2 1827.1 1877.3 879.9 1002.8 1032.0 1038.1 1047.5 14516.9 16444.4 16483.7 17006.7 17388.8 961.3 995.8 1053.8 1116.3 1141.3 10138.5 10267.8 10323.6 10348.7 10375.9 583753.0 585366.0 613756.0 627589.0 633159.0 75018.6 76213.6 78161.2 79437.0 79836.2 1182.7 1196.8 1200.7 1201.2 1218.5 15830.8 15832.0 15872.4 16042.9 16274.2 37025.8 37629.6 37877.4 38998.2 39213.0 50118.0 51285.5 51863.2 54061.2 56472.2 10018.8 10410.2 10522.2 10537.4 10556.4 12623.9 18018.6 18258.5 18552.4 19096.6 16040.8 16060.2 16257.8 16363.3 16409.4 11329.9 15655.8 15877.4 16125.4 16317.9 15018.5 15216.5 15334.8 15621.8 15637.1 9901.2 10343.8 10433.9 10471.1 10638.4 16228.8 16271.1 16286.1 16293.6 16577.0 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,436 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5564.02 Median:6691.56 stddev:2855.42 (42.7%) stddev-sans-first:2846.00 11:29:17 INFO - 2016-01-21 11:29:17,437 DEBUG : BROWSER_OUTPUT: Values: 1367.7 1518.5 1520.7 1802.6 1840.3 7033.5 7434.1 7636.8 7642.0 7649.3 7497.4 7636.2 7638.3 7640.8 7646.7 2007.1 2051.6 2273.6 2336.8 2377.4 2375.3 2378.6 2381.9 2382.0 2385.0 2308.8 2354.4 2363.8 2366.7 2367.1 2317.7 2319.3 2361.7 2365.7 2366.7 2399.2 2411.1 2425.8 2427.6 2437.9 7853.6 7899.7 7918.4 7923.1 7936.8 4786.3 4879.6 4910.0 4914.3 4917.7 3030.7 3038.6 3090.0 3099.3 3116.4 951.1 972.7 981.2 987.0 987.2 10781.4 10833.5 10843.5 10850.3 10851.8 4247.2 4262.3 4333.8 4338.4 4343.6 9294.3 9305.0 9324.6 9327.9 9331.7 4841.8 4841.9 4846.2 4852.0 4889.6 4402.2 4405.7 4408.2 4436.2 4437.0 3500.1 3523.3 3563.4 3619.8 3714.9 1249.6 1249.8 1254.8 1261.8 1263.4 1126.8 1128.7 1175.7 1348.2 1414.2 7459.9 7488.0 7557.4 7564.3 7571.8 1155.5 1156.5 1159.8 1169.2 1176.5 5818.3 5916.6 5916.7 5926.6 5932.2 9083.4 9473.6 9505.4 9612.7 9670.7 9379.5 9411.8 9528.9 9563.1 9572.4 7436.8 7580.6 7610.6 7614.0 7616.9 7232.5 7292.5 7299.8 7313.1 7338.8 8377.3 8450.9 8490.4 8507.4 8658.4 8637.8 8650.0 8698.9 8775.3 8841.6 6213.8 7135.3 7191.7 7193.2 7195.6 6941.7 7266.4 7531.8 7535.7 7548.6 7130.9 7301.7 7302.1 7384.4 7391.5 7197.9 7219.2 7234.2 7318.2 7325.0 7249.1 7290.2 7315.0 7324.9 7325.2 6619.9 6650.4 6669.5 6688.9 6694.3 6383.5 6773.7 6813.0 6847.7 6858.2 11:29:17 INFO - 2016-01-21 11:29:17,437 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,437 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5460.21 Median:6243.03 stddev:1628.76 (26.1%) stddev-sans-first:1587.65 11:29:17 INFO - 2016-01-21 11:29:17,437 DEBUG : BROWSER_OUTPUT: Values: 356.5 357.6 360.2 366.0 366.3 6096.2 6110.9 6119.8 6145.8 6197.2 6058.4 6068.2 6070.8 6077.9 6089.7 4654.1 4707.8 4727.8 4739.7 4745.0 4734.5 4736.8 4746.8 4748.3 4757.3 4643.6 4675.2 4692.1 4693.1 4693.2 4437.6 4514.8 4590.2 4651.6 4694.2 4136.8 4140.9 4170.6 4174.1 4179.1 5612.3 5754.1 5815.6 5817.1 5842.3 5308.6 5379.9 5497.9 5509.8 5528.5 6420.6 6443.3 6462.5 6466.6 6473.0 4589.8 4628.0 4632.2 4633.1 4634.8 6470.5 6581.0 6625.0 6639.8 6707.1 4609.5 4639.4 4640.8 4642.0 4644.1 4700.1 4703.4 4711.0 4712.4 4715.3 5283.8 5396.5 5403.0 5410.7 5412.4 6430.3 6435.1 6439.7 6447.1 6448.0 1697.2 1709.2 1710.1 1710.5 1718.9 1166.5 1168.6 1176.1 1182.6 1187.9 6314.8 6316.8 6325.5 6335.5 6347.0 6712.2 6721.8 6724.6 6729.2 6729.3 6158.8 6288.8 6292.7 6311.1 6321.1 3604.4 3632.4 3644.9 3645.2 3646.5 6915.8 6943.6 6965.9 6968.8 6977.6 6680.2 6810.1 6846.6 6978.8 6987.7 6929.0 6949.3 6956.3 6963.7 6967.4 6620.4 6775.3 6785.0 6785.3 6786.4 6611.9 6615.9 6621.0 6622.0 6625.9 6973.5 6979.5 6981.7 6981.7 6983.4 4601.1 4647.9 4686.8 4687.8 4688.6 6696.6 6755.9 6762.8 6763.9 6769.2 6591.3 6592.6 6595.6 6596.6 6601.9 6463.8 6561.5 6587.7 6590.0 6592.4 6437.5 6464.4 6466.4 6489.8 6494.4 6588.4 6621.3 6623.4 6626.6 6638.7 6358.8 6437.2 6463.1 6466.7 6483.2 11:29:17 INFO - 2016-01-21 11:29:17,438 DEBUG : BROWSER_OUTPUT: 11:29:17 INFO - 2016-01-21 11:29:17,438 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14401.73 Median:50663.49 stddev:17137.45 (33.8%) stddev-sans-first:17154.80 11:29:17 INFO - 2016-01-21 11:29:17,438 DEBUG : BROWSER_OUTPUT: Values: 736.6 754.7 779.0 818.7 851.1 14541.3 15033.8 15049.8 15061.5 15086.3 13474.0 13574.9 13590.0 13597.0 13597.5 721.3 750.2 881.4 923.4 924.3 912.2 913.5 918.7 920.5 921.7 766.5 793.9 962.3 966.9 967.5 919.6 964.1 964.8 967.2 967.3 702.6 709.5 713.7 714.0 714.3 13028.4 13294.5 13370.9 13457.1 13458.5 11968.3 12677.7 12810.9 12991.1 12991.4 9248.9 9366.2 9568.6 9645.2 9749.8 3487.2 3508.1 3511.4 3518.1 3522.6 50054.7 50412.5 51868.0 52274.7 52303.5 9518.9 9895.7 9917.0 10159.5 10636.4 18533.9 18679.3 18755.7 18770.3 19190.7 7465.8 7527.3 7565.2 7598.5 7766.3 4177.8 4302.4 4411.8 4417.8 4436.9 3135.4 3163.0 3166.1 3172.6 3175.1 571.8 573.6 594.1 600.1 609.4 646.4 668.4 679.7 681.1 704.9 8105.7 8331.6 8717.0 8776.0 8864.3 569.5 684.4 685.3 687.7 701.1 4061.8 4106.6 4160.8 4195.1 4218.7 59926.7 60975.7 61151.7 61324.0 61659.0 53558.5 54701.7 54855.0 55893.0 56223.7 45875.0 49359.3 49532.0 49998.3 50199.0 8253.8 8271.8 8732.0 8849.3 8989.0 36184.8 37140.4 37964.6 38502.2 39393.0 47556.3 47738.5 48024.5 48861.0 50914.5 10723.5 11175.0 11547.1 11609.0 11845.3 12083.8 12112.2 12151.5 12404.6 13431.6 10898.8 11050.6 11148.6 11269.3 11367.9 10569.6 10620.5 10792.7 11151.7 11169.6 9499.4 9653.6 9937.2 10154.8 10705.6 9732.0 9805.7 10010.7 10132.2 10267.3 9529.8 9935.2 10062.3 10067.9 10137.5 11:29:17 INFO - 2016-01-21 11:29:17,438 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:29:17 INFO - 2016-01-21 11:29:17,438 DEBUG : BROWSER_OUTPUT: 11:29:18 INFO - 2016-01-21 11:29:18,146 INFO : Browser exited with error code: 0 11:29:18 INFO - 2016-01-21 11:29:18,169 INFO : Completed test dromaeo_css (00:18:30) 11:29:18 INFO - 2016-01-21 11:29:18,169 INFO : Starting test kraken 11:29:18 INFO - 2016-01-21 11:29:18,169 DEBUG : operating with platform_type : linux_ 11:29:18 INFO - 2016-01-21 11:29:18,169 INFO : Initialising browser for kraken test... 11:29:18 INFO - 2016-01-21 11:29:18,175 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5cZNR2/profile http://localhost:45722/getInfo.html 11:29:22 INFO - 2016-01-21 11:29:22,071 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:29:22 INFO - 2016-01-21 11:29:22,071 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:29:22 INFO - 2016-01-21 11:29:22,071 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:29:22 INFO - 2016-01-21 11:29:22,071 DEBUG : BROWSER_OUTPUT: __metrics 11:29:22 INFO - 2016-01-21 11:29:22,199 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] 11:29:22 INFO - 2016-01-21 11:29:22,995 INFO : Browser initialized. 11:29:22 INFO - 2016-01-21 11:29:22,996 INFO : Running cycle 1/1 for kraken test... 11:29:22 INFO - 2016-01-21 11:29:22,996 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5cZNR2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:29:34 INFO - 2016-01-21 11:29:34,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 137932800 11:29:34 INFO - 2016-01-21 11:29:34,846 DEBUG : BROWSER_OUTPUT: 11:29:37 INFO - 2016-01-21 11:29:37,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:37 INFO - 2016-01-21 11:29:37,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 169816064 11:29:37 INFO - 2016-01-21 11:29:37,875 DEBUG : BROWSER_OUTPUT: 11:29:40 INFO - 2016-01-21 11:29:40,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-dft) 11:29:41 INFO - 2016-01-21 11:29:41,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 167227392 11:29:41 INFO - 2016-01-21 11:29:41,045 DEBUG : BROWSER_OUTPUT: 11:29:43 INFO - 2016-01-21 11:29:43,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-fft) 11:29:44 INFO - 2016-01-21 11:29:44,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 164110336 11:29:44 INFO - 2016-01-21 11:29:44,394 DEBUG : BROWSER_OUTPUT: 11:29:46 INFO - 2016-01-21 11:29:46,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45722/tests/kraken/driver.html?testName=audio-oscillator) 11:29:46 INFO - 2016-01-21 11:29:46,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 164327424 11:29:46 INFO - 2016-01-21 11:29:46,942 DEBUG : BROWSER_OUTPUT: 11:29:49 INFO - 2016-01-21 11:29:49,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:49 INFO - 2016-01-21 11:29:49,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 162639872 11:29:49 INFO - 2016-01-21 11:29:49,701 DEBUG : BROWSER_OUTPUT: 11:29:52 INFO - 2016-01-21 11:29:52,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:53 INFO - 2016-01-21 11:29:53,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 163459072 11:29:53 INFO - 2016-01-21 11:29:53,154 DEBUG : BROWSER_OUTPUT: 11:29:56 INFO - 2016-01-21 11:29:56,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45722/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:57 INFO - 2016-01-21 11:29:57,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 164769792 11:29:57 INFO - 2016-01-21 11:29:57,083 DEBUG : BROWSER_OUTPUT: 11:29:59 INFO - 2016-01-21 11:29:59,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45722/tests/kraken/driver.html?testName=json-parse-financial) 11:30:00 INFO - 2016-01-21 11:30:00,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 165130240 11:30:00 INFO - 2016-01-21 11:30:00,368 DEBUG : BROWSER_OUTPUT: 11:30:01 INFO - 2016-01-21 11:30:01,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:30:02 INFO - 2016-01-21 11:30:02,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 171339776 11:30:02 INFO - 2016-01-21 11:30:02,519 DEBUG : BROWSER_OUTPUT: 11:30:04 INFO - 2016-01-21 11:30:04,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:30:04 INFO - 2016-01-21 11:30:04,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 169152512 11:30:04 INFO - 2016-01-21 11:30:04,877 DEBUG : BROWSER_OUTPUT: 11:30:06 INFO - 2016-01-21 11:30:06,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:30:07 INFO - 2016-01-21 11:30:07,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 175595520 11:30:07 INFO - 2016-01-21 11:30:07,461 DEBUG : BROWSER_OUTPUT: 11:30:09 INFO - 2016-01-21 11:30:09,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:30:10 INFO - 2016-01-21 11:30:10,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 180555776 11:30:10 INFO - 2016-01-21 11:30:10,397 DEBUG : BROWSER_OUTPUT: 11:30:12 INFO - 2016-01-21 11:30:12,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:30:13 INFO - 2016-01-21 11:30:13,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 180224000 11:30:13 INFO - 2016-01-21 11:30:13,422 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45722/tests/kraken/driver.html?testName=ai-astar) 11:30:15 INFO - 2016-01-21 11:30:15,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 238387200 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:30:15 INFO - 2016-01-21 11:30:15,347 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;105;110;111;112;98;110;110;111 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;129;152;153;130;152;150;132;168;127 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;167;161;160;159;159;159;161;160;160 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;147;71;72;73;74;165;74 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;140;94;94;93;145;93;94;141 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;110;109;109;109;109 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;146 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;96;96;96;95;96 11:30:15 INFO - 2016-01-21 11:30:15,348 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;59;60;57;56;58;57;58;63;55 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;64;64;64;64;64;64;64 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;83;80;80;80;80;81;80;82 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;110;112;116;112;119;125;119;114;120;112 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;133;143;142;142;132;144;132;146;143 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;67;65;66;65;67;69;67;65 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:30:15 INFO - 2016-01-21 11:30:15,349 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:30:15 INFO - 2016-01-21 11:30:15,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 11:30:15 INFO - 2016-01-21 11:30:15,350 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:30:15 INFO - 2016-01-21 11:30:15,350 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404615345__endTimestamp 11:30:15 INFO - 2016-01-21 11:30:15,350 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:4.19 (3.8%) stddev-sans-first:4.42 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 105.0 110.0 111.0 112.0 98.0 110.0 110.0 111.0 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:151.00 stddev:13.71 (9.1%) stddev-sans-first:14.47 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: Values: 148.0 129.0 152.0 153.0 130.0 152.0 150.0 132.0 168.0 127.0 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:2.36 (1.5%) stddev-sans-first:2.50 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: Values: 161.0 167.0 161.0 160.0 159.0 159.0 159.0 161.0 160.0 160.0 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:35.26 (48.3%) stddev-sans-first:36.89 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 147.0 71.0 72.0 73.0 74.0 165.0 74.0 11:30:15 INFO - 2016-01-21 11:30:15,358 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:23.36 (24.9%) stddev-sans-first:24.21 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 140.0 94.0 94.0 93.0 145.0 93.0 94.0 141.0 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.44 (4.2%) stddev-sans-first:2.37 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: Values: 55.0 59.0 60.0 57.0 56.0 58.0 57.0 58.0 63.0 55.0 11:30:15 INFO - 2016-01-21 11:30:15,359 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:1.14 (1.4%) stddev-sans-first:1.17 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 83.0 80.0 80.0 80.0 80.0 81.0 80.0 82.0 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:117.50 stddev:4.75 (4.0%) stddev-sans-first:4.53 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 116.0 112.0 119.0 125.0 119.0 114.0 120.0 112.0 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:142.50 stddev:5.51 (3.9%) stddev-sans-first:5.63 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: Values: 135.0 133.0 143.0 142.0 142.0 132.0 144.0 132.0 146.0 143.0 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.32 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 67.0 65.0 66.0 65.0 67.0 69.0 67.0 65.0 11:30:15 INFO - 2016-01-21 11:30:15,360 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:30:15 INFO - 2016-01-21 11:30:15,361 DEBUG : BROWSER_OUTPUT: 11:30:16 INFO - 2016-01-21 11:30:16,169 INFO : Browser exited with error code: 0 11:30:16 INFO - 2016-01-21 11:30:16,226 INFO : Completed test kraken (00:00:58) 11:30:16 INFO - 2016-01-21 11:30:16,226 INFO : Starting test v8_7 11:30:16 INFO - 2016-01-21 11:30:16,226 DEBUG : operating with platform_type : linux_ 11:30:16 INFO - 2016-01-21 11:30:16,226 INFO : Initialising browser for v8_7 test... 11:30:16 INFO - 2016-01-21 11:30:16,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLNTeDL/profile http://localhost:45722/getInfo.html 11:30:20 INFO - 2016-01-21 11:30:20,169 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:30:20 INFO - 2016-01-21 11:30:20,169 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:30:20 INFO - 2016-01-21 11:30:20,169 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:30:20 INFO - 2016-01-21 11:30:20,169 DEBUG : BROWSER_OUTPUT: __metrics 11:30:20 INFO - 2016-01-21 11:30:20,285 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] 11:30:21 INFO - 2016-01-21 11:30:21,203 INFO : Browser initialized. 11:30:21 INFO - 2016-01-21 11:30:21,204 INFO : Running cycle 1/1 for v8_7 test... 11:30:21 INFO - 2016-01-21 11:30:21,204 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLNTeDL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:30:32 INFO - 2016-01-21 11:30:32,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 11:30:32 INFO - 2016-01-21 11:30:32,973 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45722/tests/v8_7/run.html (next: http://localhost:45722/tests/v8_7/run.html) 11:30:54 INFO - 2016-01-21 11:30:54,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 424660992 11:30:54 INFO - 2016-01-21 11:30:54,582 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,582 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:30:54 INFO - 2016-01-21 11:30:54,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:30:54 INFO - 2016-01-21 11:30:54,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |0;Richards;168.03898504453034 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0843776106934 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 11:30:54 INFO - 2016-01-21 11:30:54,583 DEBUG : BROWSER_OUTPUT: |4;RayTrace;931.0986964618249 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: |5;Earley;556.4830272676684 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: |6;Boyer;11076.923076923076 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: |8;Splay;522.466039707419 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:30:54 INFO - 2016-01-21 11:30:54,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404654579__endTimestamp 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: Values: 168.0 11:30:54 INFO - 2016-01-21 11:30:54,585 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: Values: 167.1 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:30:54 INFO - 2016-01-21 11:30:54,586 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: Values: 5112.2 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:931.10 Median:931.10 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: Values: 931.1 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:556.48 Median:556.48 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: Values: 556.5 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: Values: 11076.9 11:30:54 INFO - 2016-01-21 11:30:54,587 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: Values: 24166.7 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:522.47 Median:522.47 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: Values: 522.5 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:30:54 INFO - 2016-01-21 11:30:54,588 DEBUG : BROWSER_OUTPUT: 11:30:55 INFO - 2016-01-21 11:30:55,377 INFO : Browser exited with error code: 0 11:30:55 INFO - 2016-01-21 11:30:55,394 INFO : Completed test v8_7 (00:00:39) 11:30:55 INFO - 2016-01-21 11:30:55,627 INFO : Completed test suite (00:20:08) 11:30:55 INFO - 2016-01-21 11:30:55,628 DEBUG : Working with test: dromaeo_css 11:30:55 INFO - 2016-01-21 11:30:55,628 DEBUG : Generating results file: dromaeo_css 11:30:55 INFO - 2016-01-21 11:30:55,629 DEBUG : Working with test: kraken 11:30:55 INFO - 2016-01-21 11:30:55,629 DEBUG : Generating results file: kraken 11:30:55 INFO - 2016-01-21 11:30:55,629 INFO : javascript benchmark 11:30:55 INFO - 2016-01-21 11:30:55,629 DEBUG : Working with test: v8_7 11:30:55 INFO - 2016-01-21 11:30:55,630 DEBUG : Generating results file: v8_7 11:30:55 INFO - 2016-01-21 11:30:55,630 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:55 INFO - 2016-01-21 11:30:55,693 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 11:30:55 INFO - 2016-01-21 11:30:55,693 DEBUG : process_Request line: dromaeo_css 7269.88 graph.html#tests=[[72,52,35]] 11:30:55 INFO - 2016-01-21 11:30:55,693 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:55 INFO - 2016-01-21 11:30:55,723 DEBUG : process_Request line: kraken 1485.90 graph.html#tests=[[232,52,35]] 11:30:55 INFO - 2016-01-21 11:30:55,723 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:55 INFO - 2016-01-21 11:30:55,757 DEBUG : process_Request line: v8_7 23159.69 graph.html#tests=[[230,52,35]] 11:30:55 INFO - 2016-01-21 11:30:55,759 INFO : javascript benchmark 11:30:55 INFO - 2016-01-21 11:30:55,761 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3217.694319039691, 3260.608726952766, 3263.494158405445, 3267.9673203267976, 3289.1119397762604, 5359.196120581914, 5375.220593014011, 5386.228991963006, 5404.91892621611, 5447.319085114361, 5433.8369848904595, 5452.0, 5461.69960652164, 5462.836114916549, 5467.808626698066, 4871.269309603553, 4950.598437647613, 4995.025969935864, 5019.54824065834, 5030.974845125787, 4962.950370496285, 5024.5226703463295, 5027.924581131286, 5030.5975521958335, 5031.849044528652, 4941.283513890502, 4978.850634480971, 5044.369453818273, 5059.114654935372, 5062.9240561391425, 5096.51583099605, 5110.5656019238595, 5136.255242989746, 5137.280780690707, 5163.974180129113, 4967.10592093423, 5030.597552195815, 5075.492450754932, 5084.211947148198, 5093.363329583802, 5159.974200129013, 5190.11767999441, 5281.181416880389, 5284.630075894689, 5293.7353132343615, 5851.824445266606, 5885.028970219909, 5886.882262354772, 5897.970510147465, 5901.970490147564, 5762.135679648086, 5920.259967504062, 5937.851553711149, 5947.37552556984, 5951.613145145551, 5364.868477066419, 5443.673379597197, 5443.727813609383, 5462.863428414282, 5474.698891560963, 5927.585069045212, 5932.703364831741, 5933.584649074523, 5937.70311484424, 5940.138679891392, 5546.611737178439, 5650.519705825051, 5767.077267637242, 5777.913331300034, 5778.017736984722, 5817.7963771267805, 5823.4467725566, 5831.650100993954, 5836.416358364129, 5870.14882841994, 5809.7095145242565, 5832.737526811304, 5835.0, 5837.532997360201, 5863.237779088691, 5642.097264437671, 5751.079827227707, 5771.365149833515, 5817.7091145442555, 5829.446202610745, 4534.59188673021, 4543.704659197141, 4560.224761790503, 4568.474625418053, 4576.81692732287, 4052.3111071117983, 4053.635172834459, 4063.0858056936954, 4089.836406543705, 4092.304308267542, 5351.57187425005, 5461.7711015021305, 5517.889642207133, 5567.025770490229, 5578.525825304813, 5781.71091445426, 5847.239858818326, 5863.413658634103, 5866.941330586725, 5899.292084949833, 5429.375621803464, 5433.320834895638, 5439.646422982493, 5465.59008074396, 5519.613627046148, 4986.102501549683, 5055.797768089309, 5075.264086707407, 5080.74596270185, 5110.28456016158, 6033.3966603340195, 6045.818625441244, 6048.243969503812, 6053.394660534, 6070.2412198475195, 5893.469587736953, 5909.409059094056, 5910.290765108214, 5916.26046744157, 5921.082232254007, 5887.116932460165, 5990.161377407079, 6056.697165141637, 6078.027515597483, 6111.873114042709, 5788.884222315614, 5799.0, 5802.5357971361345, 5805.0, 5808.477237048517, 5830.446107619939, 5882.411758824083, 5893.675847828239, 5897.351291358033, 5903.911441328298, 5564.4991950724625, 5611.326640802967, 5685.118806584986, 5702.144678298288, 5743.081107023024, 5669.461401166883, 5796.449337312949, 5803.0, 5829.387914268941, 5830.416958304136, 5338.786448542015, 5720.056190728483, 5748.109043098327, 5749.080147176432, 5769.480746732815, 5587.161925711013, 5760.884782304414, 5844.795432159854, 5872.207252021093, 5887.499562537232, 5745.052066408995, 5748.109043098327, 5748.741306641127, 5752.539796816161, 5754.424557544212], "unit": "ms", "name": "dojo.html", "value": 5405.998784631755}, {"lowerIsBetter": false, "replicates": [615.2709039787851, 617.9402325012604, 639.2137670665082, 639.8400399900025, 644.2912795924481, 38644.0, 39301.0, 39390.803045984765, 39480.210395792106, 39485.99999999993, 45749.31376029354, 46213.768931155384, 46237.0, 46278.768606157006, 46293.537064629345, 7927.643256053462, 8041.1154772975215, 8893.288536917064, 9112.179903808656, 9116.27069834415, 10688.358698478078, 10934.507947142398, 10944.3980581068, 10959.780804383907, 10964.0680542154, 10625.681229563126, 10718.303310284806, 10722.249442539025, 10726.0, 10727.517261723242, 8230.465019773696, 8420.28427583656, 10555.472226388689, 10643.893561064368, 10760.946195269053, 10425.218108641882, 10522.947385263025, 10592.152627789836, 10592.947035264851, 10594.947025264824, 43527.0, 43634.56365436369, 43800.0, 43910.12179756419, 43968.78015609901, 3469.548958635361, 3531.134871956387, 3599.352992410103, 3955.745902906227, 4296.9687275054075, 33099.50350744717, 33169.33661326784, 33254.83372583122, 33426.49860252098, 33575.16062098467, 3495.965040349615, 3519.8768043118366, 3536.7701099428455, 3542.822858857073, 3676.5036720042717, 290988.0, 292787.0, 292802.0, 293141.0, 293361.0, 56793.0, 58531.70734146302, 58553.707231464425, 64999.0, 65523.0, 66155.66922165359, 67725.66137169382, 67935.32064679389, 67948.32051679518, 68023.0, 15043.699126017418, 15049.623759406102, 15075.698486030436, 15083.170425626697, 15107.093574385572, 13221.867781322064, 13307.534236301683, 13311.134776239513, 13317.334133293296, 13317.467301307839, 20617.896910515352, 21096.0, 21100.78899211019, 21271.36185914425, 21307.508474406644, 7667.923320766832, 7805.960970195226, 7847.450678452454, 7934.880976785353, 7936.127026027132, 1010.4947526236881, 1076.4671487613525, 1094.9781004380027, 1123.5112725964232, 1159.675290918544, 30123.0, 30336.69663303383, 30606.69393306083, 30672.846635766677, 31365.0, 1103.9889601104046, 1129.2151954391784, 1152.7521582859727, 1168.3106966889577, 1198.4824539975027, 13602.727945441036, 13908.513202038082, 14245.572632821031, 15022.699546009018, 16108.114053727157, 338343.0, 341809.0, 341851.0, 342650.0, 343505.0, 48259.276110858365, 48621.75689121603, 48644.0, 48683.75658121687, 48685.26972095422, 1355.6407551998727, 1394.3376895974534, 1413.3286688822727, 1464.8388677245493, 1477.7044591081826, 27115.59326610142, 27465.45069098647, 27857.72142278551, 27887.16338509848, 28512.144635660963, 40606.0, 41029.79485102555, 41163.38254926239, 45837.31244031276, 46482.0, 306442.0, 313159.0, 317543.0, 317792.0, 317793.0, 33912.660873391935, 34374.82812585921, 34504.13739656529, 34517.82741086379, 34554.30891382208, 46541.53458465372, 46852.99044191897, 47521.52478475171, 47948.7602561985, 48200.5179948196, 37749.62250377571, 38077.238455231294, 38168.2366352677, 38708.80645596754, 38983.415248770725, 38590.80704596459, 39173.41239881461, 39222.607773921896, 39284.6071539281, 39720.801395992836, 38478.2304353917, 38512.80743596264, 38832.6116738829, 38991.2201755969, 39054.80472597619, 30608.234794130323, 31600.367992640477, 31792.68207317897, 32103.67896321007, 32402.83798580992, 26530.734692652826, 26549.0, 26817.865910670324, 28188.43623127567, 28679.283017924718], "unit": "ms", "name": "ext.html", "value": 19670.074860106706}, {"lowerIsBetter": false, "replicates": [354.1094148217236, 357.92125732338894, 360.1087308910447, 363.20458196549555, 365.53029357275904, 15409.306581203844, 15869.206539673029, 16902.661946761073, 17526.73709894351, 18375.264989400406, 17514.47456576305, 17546.82453175468, 18182.363617273397, 18427.723584146213, 18892.33876814312, 5374.973125134369, 5461.590380721442, 5490.094134467828, 5491.341039075317, 5494.395616482184, 4142.0, 4228.915421691564, 4239.08859595187, 5490.423505531921, 6075.483583895374, 6133.447989680928, 6197.256329240475, 6218.657973811439, 6219.626822390671, 6220.564560480768, 5441.809536666217, 5627.606067575251, 5631.60578759487, 5661.8584535386535, 5667.716614169316, 5367.731613419313, 5436.0, 5442.482964118402, 5444.754986025639, 5447.809326673548, 14120.858791412056, 14287.428502859873, 14339.0, 14503.927480362636, 22360.10559577615, 2177.4447515883508, 2182.8253739700785, 2193.484531135182, 2273.8408311418207, 2335.2177020698086, 10538.104261137813, 11320.377379244139, 12241.265524068584, 14123.435062597484, 14441.422343106264, 1896.0223342473378, 1948.3278268997174, 1967.4196112146808, 1982.474644219283, 1984.8015198480036, 62759.0, 66432.0, 66629.66685166543, 68592.0, 68904.96642550366, 10884.72788180286, 11039.448027598588, 11076.501557429934, 11114.49984750672, 11179.44102794857, 15008.549743507712, 15028.699426011419, 15040.699186016438, 15055.397784088733, 15070.924645376703, 8007.759767206993, 8012.919870801334, 8072.757817265491, 8457.365697572706, 8575.1424857515, 7858.253465920843, 8544.914550854412, 8558.78603034929, 8581.098984606526, 8609.268212202032, 4747.2879068140055, 4777.9044419112115, 4782.091402633558, 4813.181759100891, 4817.7350245736825, 1740.0822858868362, 1810.4206653870635, 1816.1554876982002, 1827.0864567716142, 1877.3241633012105, 879.9296056315479, 1002.8094662014194, 1031.9845202321972, 1038.065740833256, 1047.5233768635405, 14516.927415363067, 16444.424445144363, 16483.6703265934, 17006.659866802594, 17388.82611173872, 961.3174646001278, 995.7751965082989, 1053.7649416292063, 1116.3357802107732, 1141.3095077478172, 10138.543765530569, 10267.794644107076, 10323.638672646572, 10348.741281467874, 10375.948120259502, 583753.0, 585366.0, 613756.0, 627589.0, 633159.0, 75018.62490687621, 76213.61893190499, 78161.21838781654, 79437.0, 79836.20163798287, 1182.7043239190202, 1196.7965445874222, 1200.687821166503, 1201.1711918776016, 1218.5186851193728, 15830.841691582937, 15832.0, 15872.365105395655, 16042.919785400998, 16274.186290685182, 37025.814870925475, 37629.62370376261, 37877.431838521894, 38998.22003559856, 39213.0, 50118.0, 51285.48714512807, 51863.2220516685, 54061.189082163015, 56472.15291770709, 10018.849717254101, 10410.219233557362, 10522.21083418762, 10537.420441875463, 10556.419396933243, 12623.873761262637, 18018.63962720712, 18258.45224643263, 18552.350667726565, 19096.618067638847, 16040.759388608947, 16060.189466843489, 16257.837421625632, 16363.345466181696, 16409.42567010149, 11329.886701132884, 15655.843441565894, 15877.444289449813, 16125.435609753602, 16317.918410408347, 15018.549443516711, 15216.543503694907, 15334.846651533342, 15621.843781562038, 15637.139957302457, 9901.158401535662, 10343.834419195884, 10433.895661043292, 10471.10995565355, 10638.361698298128, 16228.837711622733, 16271.105089220207, 16286.10426426558, 16293.59266018359, 16577.0], "unit": "ms", "name": "jquery.html", "value": 9424.978274031266}, {"lowerIsBetter": false, "replicates": [1367.6512489315223, 1518.5444366689997, 1520.7338715724752, 1802.5673838278813, 1840.2822899069356, 7033.50765446419, 7434.107907051155, 7636.770896873103, 7642.0, 7649.311561959423, 7497.4376921730955, 7636.236376362361, 7638.312551870331, 7640.808979775508, 7646.732364367248, 2007.056683358819, 2051.579426217629, 2273.6362182050875, 2336.836421450495, 2377.4413012941945, 2375.3467796356053, 2378.583747844129, 2381.8928148233285, 2382.0, 2384.95230095398, 2308.7575804540534, 2354.399628094842, 2363.7990770784418, 2366.7396586375485, 2367.065009321317, 2317.687112239851, 2319.3158018384615, 2361.740208577055, 2365.73976862545, 2366.727826299963, 2399.196269249803, 2411.1440438644204, 2425.8301918865686, 2427.647991041289, 2437.926862194137, 7853.5680537570415, 7899.684012639487, 7918.406119541058, 7923.12845586985, 7936.801579960547, 4786.282057691339, 4879.585235255007, 4910.0, 4914.262860570907, 4917.704937703749, 3030.6666266710645, 3038.6353637563634, 3090.0, 3099.302656902179, 3116.407882502317, 951.1487218939011, 972.6887396033272, 981.1693264930726, 986.960521579136, 987.2348929579633, 10781.407022613754, 10833.458327083694, 10843.51204195813, 10850.29473084247, 10851.782964340748, 4247.17300329448, 4262.339337402707, 4333.826646934087, 4338.414314067561, 4343.630791382705, 9294.256459483226, 9305.0, 9324.627014919462, 9327.860082098774, 9331.673391431268, 4841.806327746921, 4841.927371089437, 4846.151923413388, 4851.95148048515, 4889.633277504201, 4402.207602631493, 4405.669574781904, 4408.162449134654, 4436.201483732894, 4437.0460351024685, 3500.072480792592, 3523.3129539739502, 3563.394222982099, 3619.8371073301764, 3714.8699795507027, 1249.6063739921894, 1249.8375211222483, 1254.7866862633375, 1261.7697744698846, 1263.3620021888887, 1126.7577470843808, 1128.6557599931934, 1175.6766889105565, 1348.2382453913704, 1414.193909471612, 7459.925400746031, 7488.0, 7557.4331925105835, 7564.319211271012, 7571.848563028819, 1155.5089087137933, 1156.4911438966828, 1159.7796418680423, 1169.1582060916128, 1176.5235079792697, 5818.301803783573, 5916.615419997686, 5916.674582897982, 5926.644401335933, 5932.228810254639, 9083.36416450842, 9473.573689183866, 9505.382150160218, 9612.711618651452, 9670.70987870351, 9379.5310234488, 9411.764705882408, 9528.904710952802, 9563.09150630689, 9572.425654460754, 7436.776896693108, 7580.583067931317, 7610.581418022062, 7614.048243969504, 7616.885746713914, 7232.45756568249, 7292.525985810906, 7299.817504562428, 7313.122425308997, 7338.77983660491, 8377.329813614775, 8450.915490845013, 8490.405671602928, 8507.361947853811, 8658.437201581877, 8637.833892424693, 8649.956750216208, 8698.869516957377, 8775.297976162019, 8841.646334146562, 6213.782517611862, 7135.250798666066, 7191.676374563262, 7193.208747037717, 7195.568265904062, 6941.652917354011, 7266.382357499671, 7531.8493630125995, 7535.660895259617, 7548.584827834522, 7130.857382852418, 7301.707931682886, 7302.087239095114, 7384.446166537424, 7391.482596218213, 7197.928020719726, 7219.241979592067, 7234.16807067194, 7318.194998550049, 7324.96337518309, 7249.130104387507, 7290.198078211499, 7315.049043624294, 7324.926750732425, 7325.194228634739, 6619.867602647823, 6650.434713049445, 6669.533132680665, 6688.866222675422, 6694.263631000488, 6383.457406120346, 6773.729050837911, 6813.0461735358085, 6847.726090956506, 6858.211305699709], "unit": "ms", "name": "mootools.html", "value": 4588.341928337901}, {"lowerIsBetter": false, "replicates": [356.47598030894585, 357.5994885727984, 360.1913703735115, 365.99268014639694, 366.28939856678045, 6096.237970253718, 6110.908336374958, 6119.847003824907, 6145.846353841151, 6197.225346831646, 6058.394160583939, 6068.150458935753, 6070.757169713206, 6077.908831367533, 6089.6955152242435, 4654.138984287901, 4707.764611769415, 4727.787249573769, 4739.73931433771, 4744.9525504745025, 4734.502877197896, 4736.763161841911, 4746.833860814872, 4748.335233067356, 4757.310190022445, 4643.628509719214, 4675.181843177447, 4692.06158768246, 4693.108309421199, 4693.178693728601, 4437.5784300491405, 4514.751688657123, 4590.219662657356, 4651.62786977041, 4694.201985662446, 4136.772477513736, 4140.91718165635, 4170.645495132887, 4174.08170202555, 4179.080602267527, 5612.326520817528, 5754.050581654022, 5815.621984570989, 5817.069268916953, 5842.298924129089, 5308.628396012242, 5379.892402151935, 5497.862553436156, 5509.779608815643, 5528.474794894519, 6420.6147631142285, 6443.29123796382, 6462.450691691212, 6466.579672321284, 6473.0, 4589.839355622537, 4627.95372046282, 4632.235681112612, 4633.119707255611, 4634.83778067766, 6470.450011749007, 6581.04574836646, 6625.0, 6639.767608133692, 6707.128073350434, 4609.516000819933, 4639.373684552542, 4640.79339371759, 4642.0, 4644.0944015916575, 4700.106979673851, 4703.412073490814, 4710.95289047112, 4712.363830882856, 4715.292706094045, 5283.815066472655, 5396.460353964572, 5403.0, 5410.702411367334, 5412.404635490172, 6430.324815894263, 6435.131257280301, 6439.7424103035355, 6447.065175549519, 6448.0, 1697.2023149119893, 1709.2479309103956, 1710.0936503653083, 1710.4783041172561, 1718.8538974187084, 1166.4984056855633, 1168.6143572621015, 1176.0591526778544, 1182.5920057580122, 1187.857457105153, 6314.842128946813, 6316.778912738032, 6325.462335701425, 6335.461485773761, 6347.0479428086155, 6712.160979877515, 6721.831954201086, 6724.562903411263, 6729.192496900403, 6729.293424190488, 6158.815235542851, 6288.8427789304715, 6292.685365731787, 6311.147995020705, 6321.083442900754, 3604.3512167810045, 3632.4006538921312, 3644.908877278089, 3645.1616128290643, 3646.507721457622, 6915.827104322432, 6943.583384996917, 6965.930340696629, 6968.756093536702, 6977.616231107237, 6680.23177334603, 6810.148731408574, 6846.5892046477375, 6978.79063628092, 6987.7204911802955, 6928.965355173293, 6949.30506949301, 6956.269591692901, 6963.651817409109, 6967.407770339477, 6620.3710647488415, 6775.322467753185, 6784.966075169593, 6785.321467853372, 6786.3892249697765, 6611.933880661132, 6615.867682646416, 6621.0, 6622.0, 6625.933740662532, 6973.511854170362, 6979.476539259677, 6981.685824137824, 6981.685824137824, 6983.406410455168, 4601.0567833594705, 4647.930281045719, 4686.835960741358, 4687.789049492849, 4688.624910007123, 6696.59820410777, 6755.93244067553, 6762.830929226809, 6763.8985415219795, 6769.221539522821, 6591.340865913562, 6592.604443733391, 6595.571287866273, 6596.60420374779, 6601.933980660132, 6463.7737679181, 6561.507886908405, 6587.703553340016, 6589.967050164719, 6592.373724496165, 6437.517186210959, 6464.353564643498, 6466.353364663496, 6489.772857949949, 6494.447971922439, 6588.40704336612, 6621.33786621334, 6623.437007854386, 6626.602403855784, 6638.701258443285, 6358.777442789666, 6437.227532696106, 6463.095166676575, 6466.708998095191, 6483.189601299838], "unit": "ms", "name": "prototype.html", "value": 4941.845362205371}, {"lowerIsBetter": false, "replicates": [736.6059158350283, 754.6830331260874, 778.9639779093804, 818.664347617477, 851.1020872979012, 14541.27293635318, 15033.849661503382, 15049.774253386195, 15061.548153555383, 15086.3211155498, 13474.0, 13574.864251357509, 13590.048696591242, 13597.04820662554, 13597.456101755917, 721.3039416962617, 750.2235186581889, 881.352206128495, 923.445932440537, 924.339097545255, 912.2428384440898, 913.524967017154, 918.6509126531909, 920.4523308631387, 921.741912264567, 766.5247546521165, 793.9285464308211, 962.2927148545813, 966.8984756600561, 967.4920666649995, 919.5723988345418, 964.0552258786429, 964.7781010367655, 967.1634036558362, 967.3373738988815, 702.6381413572014, 709.4678990756933, 713.6574444266729, 713.9500234983553, 714.3285311806885, 13028.41372138256, 13294.468221271138, 13370.866291337157, 13457.125286856322, 13458.461661533527, 11968.34174120423, 12677.74644507114, 12810.871891281062, 12991.090623656348, 12991.350432478339, 9248.861267081, 9366.20387267083, 9568.56941437637, 9645.228381729445, 9749.805003899883, 3487.232808782064, 3508.0878971467346, 3511.3504001759757, 3518.1380561762276, 3522.559680039995, 50054.74972625114, 50412.495875041146, 51868.0, 52274.73862630701, 52303.47696523062, 9518.90481095194, 9895.703128906145, 9917.0, 10159.542820573091, 10636.414997175076, 18533.907330463262, 18679.252829886926, 18755.718664220047, 18770.343037993876, 19190.712139317922, 7465.813354666177, 7527.2849079337375, 7565.167831538526, 7598.506097103671, 7766.262205090507, 4177.832886684499, 4302.376155457504, 4411.801468933906, 4417.757023363682, 4436.911261774746, 3135.372925414926, 3163.0352742413324, 3166.0660105269003, 3172.587563616715, 3175.063356309894, 571.7570032736071, 573.6042130929645, 594.0732457366436, 600.1208229943154, 609.3540846702509, 646.3536463536464, 668.3951024322995, 679.6533767778468, 681.0975457518807, 704.9400800931876, 8105.731274671511, 8331.625076871434, 8716.95641521801, 8775.956120219485, 8864.335174861912, 569.5472099680763, 684.3567046975926, 685.324954919404, 687.7455341523669, 701.0685561278747, 4061.817218225187, 4106.6242808658835, 4160.750354978711, 4195.077083041726, 4218.7468751874985, 59926.70036649789, 60975.695121524106, 61151.694241529396, 61324.0, 61659.0, 53558.464415355345, 54701.72649136729, 54854.9999999992, 55893.0, 56223.71888140533, 45875.0, 49359.25961110586, 49532.0, 49998.25002624963, 50199.0, 8253.752387428387, 8271.751847444586, 8731.956340218258, 8849.292056635324, 8988.955055224682, 36184.81907590445, 37140.44289335716, 37964.62035379611, 38502.22995540129, 39393.0, 47556.28665570088, 47738.52261477341, 48024.51975480201, 48861.0, 50914.490855090975, 10723.517441714985, 11175.0, 11547.133964952494, 11609.0, 11845.348505832262, 12083.75832483363, 12112.15214934946, 12151.453184606891, 12404.56584019555, 13431.597052088453, 10898.836517452402, 11050.557977680803, 11148.55405783792, 11269.323840569592, 11367.886321136682, 10569.577216911237, 10620.468976550987, 10792.676219713421, 11151.665450036511, 11169.609063682732, 9499.38254013487, 9653.613855445703, 9937.155341796028, 10154.79690406173, 10705.625303114353, 9732.0, 9805.656802011896, 10010.749731256778, 10132.189424846141, 10267.332623379456, 9529.761755955878, 9935.155511781579, 10062.295639305179, 10067.949660251652, 10137.493125343852], "unit": "ms", "name": "yui.html", "value": 6495.566919499138}], "name": "dromaeo_css", "value": 7269.880813055756}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 111.0, 112.0, 98.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [148.0, 129.0, 152.0, 153.0, 130.0, 152.0, 150.0, 132.0, 168.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 167.0, 161.0, 160.0, 159.0, 159.0, 159.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 147.0, 71.0, 72.0, 73.0, 74.0, 165.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 140.0, 94.0, 94.0, 93.0, 145.0, 93.0, 94.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 60.0, 57.0, 56.0, 58.0, 57.0, 58.0, 63.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 83.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 116.0, 112.0, 119.0, 125.0, 119.0, 114.0, 120.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [135.0, 133.0, 143.0, 142.0, 142.0, 132.0, 144.0, 132.0, 146.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 67.0, 65.0, 66.0, 65.0, 67.0, 69.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1485.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "DeltaBlue", "value": 395.71623000000017}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [931.0986964618249], "unit": "score", "name": "RayTrace", "value": 794.7481860000001}, {"lowerIsBetter": false, "replicates": [556.4830272676684], "unit": "score", "name": "Earley", "value": 1197.6340109999996}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [522.466039707419], "unit": "score", "name": "Splay", "value": 155.97377400000002}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23159.693679024247}]} 11:30:55 INFO - RETURN: dromaeo_css: 7269.88 11:30:55 INFO - RETURN: kraken: 1485.90 11:30:55 INFO - RETURN: v8_7: 23159.69 11:30:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23159.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1485.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7269.88"}}} 11:30:55 INFO - Return code: 0 11:30:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:30:55 INFO - # TBPL SUCCESS # 11:30:55 INFO - Running post-action listener: _resource_record_post_action 11:30:55 INFO - Running post-run listener: _resource_record_post_run 11:30:56 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 508399616; Read time: 0; Write time: 427176 11:30:56 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237387776; Read time: 0; Write time: 239080 11:30:56 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 266981376; Read time: 0; Write time: 187104 11:30:56 INFO - Running post-run listener: _upload_blobber_files 11:30:56 INFO - Blob upload gear active. 11:30:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:30:56 INFO - Copying logs to upload dir... 11:30:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.831445 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-21 11:30:56.695707) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:30:56.699315) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009937 build_url: 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:30:56.751592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:30:56.751982) ========= 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=6d15e502d8e29d5d2676d664000001c3-1453403394.536921-1229907957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:30:56.802082) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:30:56.802451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:30:56.802824) ========= ========= Total master_lag: 0.30 =========