builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1447653215.16 results: success (0) buildid: 20151115193431 builduid: 31d5f83d78d84db8864dc258b62253e8 revision: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.163213) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.163754) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.164098) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006434 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.195606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.196448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.217694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.218116) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004836 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.268934) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.269199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.269544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.269821) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 21:53:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-11-15 21:53:36 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.275937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.558136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.558461) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.607480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:35.607822) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc74dbdea094059d5f1d353a2585b4f6352b6ec4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bc74dbdea094059d5f1d353a2585b4f6352b6ec4 --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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 21:53:36,790 truncating revision to first 12 chars 2015-11-15 21:53:36,790 Setting DEBUG logging. 2015-11-15 21:53:36,790 attempt 1/10 2015-11-15 21:53:36,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc74dbdea094?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 21:53:37,017 unpacking tar archive at: mozilla-central-bc74dbdea094/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566037 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:36.186696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:36.187076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:36.194476) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:36.194751) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:53:36.195186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-15 21:53:36.195476) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:53:37 INFO - MultiFileLogger online at 20151115 21:53:37 in /builds/slave/test-pgo 21:53:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:53:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:53:37 INFO - {'append_to_log': False, 21:53:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:53:37 INFO - 'blob_upload_branch': 'Firefox', 21:53:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:53:37 INFO - 'branch': 'Firefox', 21:53:37 INFO - 'buildbot_json_path': 'buildprops.json', 21:53:37 INFO - 'config_files': ('talos/linux_config.py',), 21:53:37 INFO - 'default_actions': ('clobber', 21:53:37 INFO - 'read-buildbot-config', 21:53:37 INFO - 'download-and-extract', 21:53:37 INFO - 'populate-webroot', 21:53:37 INFO - 'create-virtualenv', 21:53:37 INFO - 'install', 21:53:37 INFO - 'run-tests'), 21:53:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:53:37 INFO - 'download_minidump_stackwalk': True, 21:53:37 INFO - 'download_symbols': 'ondemand', 21:53:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:53:37 INFO - 'tooltool.py': '/tools/tooltool.py', 21:53:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:53:37 INFO - '/tools/misc-python/virtualenv.py')}, 21:53:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:53:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:53:37 INFO - 'installer_path': 'installer.exe', 21:53:37 INFO - 'log_level': 'info', 21:53:37 INFO - 'log_name': 'talos', 21:53:37 INFO - 'log_to_console': True, 21:53:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:53:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:53:37 INFO - 'opt_config_files': (), 21:53:37 INFO - 'pip_index': False, 21:53:37 INFO - 'sps_profile': False, 21:53:37 INFO - 'sps_profile_interval': 0, 21:53:37 INFO - 'suite': 'dromaeojs', 21:53:37 INFO - 'system_bits': '64', 21:53:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:53:37 INFO - 'title': 'talos-linux64-ix-045', 21:53:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:53:37 INFO - 'use_talos_json': True, 21:53:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:53:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:53:37 INFO - 'work_dir': 'build'} 21:53:37 INFO - ##### 21:53:37 INFO - ##### Running clobber step. 21:53:37 INFO - ##### 21:53:37 INFO - Running pre-action listener: _resource_record_pre_action 21:53:37 INFO - Running main action method: clobber 21:53:37 INFO - rmtree: /builds/slave/test-pgo/build 21:53:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:53:37 INFO - Running post-action listener: _resource_record_post_action 21:53:37 INFO - ##### 21:53:37 INFO - ##### Running read-buildbot-config step. 21:53:37 INFO - ##### 21:53:37 INFO - Running pre-action listener: _resource_record_pre_action 21:53:37 INFO - Running main action method: read_buildbot_config 21:53:37 INFO - Using buildbot properties: 21:53:37 INFO - { 21:53:37 INFO - "properties": { 21:53:37 INFO - "buildnumber": 555, 21:53:37 INFO - "product": "firefox", 21:53:37 INFO - "script_repo_revision": "production", 21:53:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:53:37 INFO - "repository": "", 21:53:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:53:37 INFO - "buildid": "20151115193431", 21:53:37 INFO - "slavename": "talos-linux64-ix-045", 21:53:37 INFO - "pgo_build": "True", 21:53:37 INFO - "basedir": "/builds/slave/test-pgo", 21:53:37 INFO - "project": "", 21:53:37 INFO - "platform": "ubuntu64_hw", 21:53:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:53:37 INFO - "slavebuilddir": "test", 21:53:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:53:37 INFO - "branch": "mozilla-central", 21:53:37 INFO - "repo_path": "mozilla-central", 21:53:37 INFO - "stage_platform": "linux64-pgo", 21:53:37 INFO - "builduid": "31d5f83d78d84db8864dc258b62253e8", 21:53:37 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 21:53:37 INFO - }, 21:53:37 INFO - "sourcestamp": { 21:53:37 INFO - "repository": "", 21:53:37 INFO - "hasPatch": false, 21:53:37 INFO - "project": "", 21:53:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:53:37 INFO - "changes": [ 21:53:37 INFO - { 21:53:37 INFO - "category": null, 21:53:37 INFO - "files": [ 21:53:37 INFO - { 21:53:37 INFO - "url": null, 21:53:37 INFO - "name": "https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:53:37 INFO - } 21:53:37 INFO - ], 21:53:37 INFO - "repository": "", 21:53:37 INFO - "rev": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4", 21:53:37 INFO - "who": "sendchange", 21:53:37 INFO - "when": 1447653139, 21:53:37 INFO - "number": 6664900, 21:53:37 INFO - "comments": "", 21:53:37 INFO - "project": "", 21:53:37 INFO - "at": "Sun 15 Nov 2015 21:52:19", 21:53:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:53:37 INFO - "revlink": "", 21:53:37 INFO - "properties": [ 21:53:37 INFO - [ 21:53:37 INFO - "buildid", 21:53:37 INFO - "20151115193431", 21:53:37 INFO - "Change" 21:53:37 INFO - ], 21:53:37 INFO - [ 21:53:37 INFO - "builduid", 21:53:37 INFO - "31d5f83d78d84db8864dc258b62253e8", 21:53:37 INFO - "Change" 21:53:37 INFO - ], 21:53:37 INFO - [ 21:53:37 INFO - "pgo_build", 21:53:37 INFO - "True", 21:53:37 INFO - "Change" 21:53:37 INFO - ] 21:53:37 INFO - ], 21:53:37 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 21:53:37 INFO - } 21:53:37 INFO - ], 21:53:37 INFO - "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4" 21:53:37 INFO - } 21:53:37 INFO - } 21:53:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:53:37 INFO - Running post-action listener: _resource_record_post_action 21:53:37 INFO - ##### 21:53:37 INFO - ##### Running download-and-extract step. 21:53:37 INFO - ##### 21:53:37 INFO - Running pre-action listener: _resource_record_pre_action 21:53:37 INFO - Running main action method: download_and_extract 21:53:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:53:37 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')]} 21:53:37 INFO - https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/test_packages.json 21:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/test_packages.json 21:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:53:39 INFO - Downloaded 1302 bytes. 21:53:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:53:39 INFO - Using the following test package requirements: 21:53:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:53:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'jsshell-linux-x86_64.zip'], 21:53:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:53:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:53:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:53:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:53:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:53:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:39 INFO - https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:53:41 INFO - Downloaded 22462151 bytes. 21:53:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:53:42 INFO - Return code: 0 21:53:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:42 INFO - https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:53:44 INFO - Downloaded 22462151 bytes. 21:53:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:53:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:53:45 INFO - Return code: 0 21:53: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')]} 21:53:45 INFO - https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:53:46 INFO - Downloaded 11131693 bytes. 21:53:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:53:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:53:47 INFO - Return code: 0 21:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:47 INFO - https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:53:48 INFO - Downloaded 57137209 bytes. 21:53:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:53:48 INFO - mkdir: /builds/slave/test-pgo/properties 21:53:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:53:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:53:48 INFO - Contents: 21:53:48 INFO - build_url:https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:53:48 INFO - Running post-action listener: _resource_record_post_action 21:53:48 INFO - Running post-action listener: set_extra_try_arguments 21:53:48 INFO - ##### 21:53:48 INFO - ##### Running populate-webroot step. 21:53:48 INFO - ##### 21:53:48 INFO - Running pre-action listener: _resource_record_pre_action 21:53:48 INFO - Running main action method: populate_webroot 21:53:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:53:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:53:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:53:48 INFO - '../fennec_ids.txt'], 21:53:48 INFO - 'tests': ['tcheck2']}, 21:53:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:53:48 INFO - '--tppagecycles', 21:53:48 INFO - '7'], 21:53:48 INFO - 'tests': ['tsvgm']}}, 21:53:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:53:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:53:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'tests': ['damp', 'tps']}, 21:53:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['damp', 'tps']}, 21:53:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:53:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:53:48 INFO - 'other': {'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'other_l64': {'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'other_nol64': {'tests': ['a11yr', 21:53:48 INFO - 'ts_paint', 21:53:48 INFO - 'tpaint', 21:53:48 INFO - 'sessionrestore', 21:53:48 INFO - 'sessionrestore_no_auto_restore']}, 21:53:48 INFO - 'svgr': {'tests': ['tsvgx', 21:53:48 INFO - 'tsvgr_opacity', 21:53:48 INFO - 'tart', 21:53:48 INFO - 'tscrollx', 21:53:48 INFO - 'cart']}, 21:53:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['tsvgx', 21:53:48 INFO - 'tsvgr_opacity', 21:53:48 INFO - 'tart', 21:53:48 INFO - 'tscrollx', 21:53:48 INFO - 'cart']}, 21:53:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'tests': ['tp5o']}, 21:53:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'talos_options': ['--e10s'], 21:53:48 INFO - 'tests': ['tp5o']}, 21:53:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'talos_options': ['--xperf_path', 21:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:48 INFO - 'tests': ['tp5n']}, 21:53:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:48 INFO - 'talos_options': ['--e10s', 21:53:48 INFO - '--xperf_path', 21:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:48 INFO - 'tests': ['tp5n']}}, 21:53:48 INFO - 'talos.zip': {'path': '', 21:53:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:53:48 INFO - Running post-action listener: _resource_record_post_action 21:53:48 INFO - ##### 21:53:48 INFO - ##### Running create-virtualenv step. 21:53:48 INFO - ##### 21:53:48 INFO - Running pre-action listener: _resource_record_pre_action 21:53:48 INFO - Running main action method: create_virtualenv 21:53:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:53:48 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 21:53:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:53:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:53:48 INFO - Using real prefix '/usr' 21:53:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:53:50 INFO - Installing pip.................done. 21:53:50 INFO - Return code: 0 21:53:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:53:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:53:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:53:50 INFO - Using env: {'DISPLAY': ':0', 21:53:50 INFO - 'HOME': '/home/cltbld', 21:53:50 INFO - 'LANG': 'en_US.UTF-8', 21:53:50 INFO - 'LANGUAGE': 'en_US:en', 21:53:50 INFO - 'LOGNAME': 'cltbld', 21:53:50 INFO - 'MAIL': '/var/mail/cltbld', 21:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:50 INFO - 'MOZ_NO_REMOTE': '1', 21:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:50 INFO - 'NO_EM_RESTART': '1', 21:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:50 INFO - 'SHELL': '/bin/bash', 21:53:50 INFO - 'SHLVL': '1', 21:53:50 INFO - 'TERM': 'linux', 21:53:50 INFO - 'TMOUT': '86400', 21:53:50 INFO - 'USER': 'cltbld', 21:53:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:50 INFO - '_': '/tools/buildbot/bin/python'} 21:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:51 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 21:53:51 INFO - Cleaning up... 21:53:51 INFO - Return code: 0 21:53:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:53:51 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')]} 21:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:51 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')]} 21:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:53:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:53:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:53:51 INFO - Using env: {'DISPLAY': ':0', 21:53:51 INFO - 'HOME': '/home/cltbld', 21:53:51 INFO - 'LANG': 'en_US.UTF-8', 21:53:51 INFO - 'LANGUAGE': 'en_US:en', 21:53:51 INFO - 'LOGNAME': 'cltbld', 21:53:51 INFO - 'MAIL': '/var/mail/cltbld', 21:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:51 INFO - 'MOZ_NO_REMOTE': '1', 21:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:51 INFO - 'NO_EM_RESTART': '1', 21:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:51 INFO - 'SHELL': '/bin/bash', 21:53:51 INFO - 'SHLVL': '1', 21:53:51 INFO - 'TERM': 'linux', 21:53:51 INFO - 'TMOUT': '86400', 21:53:51 INFO - 'USER': 'cltbld', 21:53:51 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:51 INFO - '_': '/tools/buildbot/bin/python'} 21:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:51 INFO - Downloading/unpacking psutil>=0.7.1 21:53:51 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 21:53:51 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 21:53:51 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 21:53:51 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 21:53:51 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 21:53:51 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 21:53:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:53:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:53 INFO - Installing collected packages: psutil 21:53:53 INFO - Running setup.py install for psutil 21:53:53 INFO - building 'psutil._psutil_linux' extension 21:53:53 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 21:53:53 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 21:53:53 INFO - building 'psutil._psutil_posix' extension 21:53:53 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 21:53:53 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 21:53:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:53 INFO - Successfully installed psutil 21:53:53 INFO - Cleaning up... 21:53:53 INFO - Return code: 0 21:53:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:53:53 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')]} 21:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 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')]} 21:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:53:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:53:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:53:53 INFO - Using env: {'DISPLAY': ':0', 21:53:53 INFO - 'HOME': '/home/cltbld', 21:53:53 INFO - 'LANG': 'en_US.UTF-8', 21:53:53 INFO - 'LANGUAGE': 'en_US:en', 21:53:53 INFO - 'LOGNAME': 'cltbld', 21:53:53 INFO - 'MAIL': '/var/mail/cltbld', 21:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:53 INFO - 'MOZ_NO_REMOTE': '1', 21:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:53 INFO - 'NO_EM_RESTART': '1', 21:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:53 INFO - 'SHELL': '/bin/bash', 21:53:53 INFO - 'SHLVL': '1', 21:53:53 INFO - 'TERM': 'linux', 21:53:53 INFO - 'TMOUT': '86400', 21:53:53 INFO - 'USER': 'cltbld', 21:53:53 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:53 INFO - '_': '/tools/buildbot/bin/python'} 21:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:53:53 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 21:53:53 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 21:53:53 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 21:53:53 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 21:53:53 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 21:53:53 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 21:53:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:53:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:53:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:53:55 INFO - Installing collected packages: mozsystemmonitor 21:53:55 INFO - Running setup.py install for mozsystemmonitor 21:53:55 INFO - Successfully installed mozsystemmonitor 21:53:55 INFO - Cleaning up... 21:53:55 INFO - Return code: 0 21:53:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:53:55 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')]} 21:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:55 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')]} 21:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:53:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:53:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:53:55 INFO - Using env: {'DISPLAY': ':0', 21:53:55 INFO - 'HOME': '/home/cltbld', 21:53:55 INFO - 'LANG': 'en_US.UTF-8', 21:53:55 INFO - 'LANGUAGE': 'en_US:en', 21:53:55 INFO - 'LOGNAME': 'cltbld', 21:53:55 INFO - 'MAIL': '/var/mail/cltbld', 21:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:55 INFO - 'MOZ_NO_REMOTE': '1', 21:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:55 INFO - 'NO_EM_RESTART': '1', 21:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:55 INFO - 'SHELL': '/bin/bash', 21:53:55 INFO - 'SHLVL': '1', 21:53:55 INFO - 'TERM': 'linux', 21:53:55 INFO - 'TMOUT': '86400', 21:53:55 INFO - 'USER': 'cltbld', 21:53:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:55 INFO - '_': '/tools/buildbot/bin/python'} 21:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:56 INFO - Downloading/unpacking blobuploader==1.2.4 21:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:57 INFO - Downloading blobuploader-1.2.4.tar.gz 21:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:53:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:53:57 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 21:53:57 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 21:53:57 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 21:53:57 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 21:53:57 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 21:53:57 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 21:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:53:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:53:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:58 INFO - Downloading docopt-0.6.1.tar.gz 21:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:53:58 INFO - Installing collected packages: blobuploader, requests, docopt 21:53:58 INFO - Running setup.py install for blobuploader 21:53:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:53:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:53:58 INFO - Running setup.py install for requests 21:53:58 INFO - Running setup.py install for docopt 21:53:58 INFO - Successfully installed blobuploader requests docopt 21:53:58 INFO - Cleaning up... 21:53:58 INFO - Return code: 0 21:53:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:53:58 INFO - Using env: {'DISPLAY': ':0', 21:53:58 INFO - 'HOME': '/home/cltbld', 21:53:58 INFO - 'LANG': 'en_US.UTF-8', 21:53:58 INFO - 'LANGUAGE': 'en_US:en', 21:53:58 INFO - 'LOGNAME': 'cltbld', 21:53:58 INFO - 'MAIL': '/var/mail/cltbld', 21:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:58 INFO - 'MOZ_NO_REMOTE': '1', 21:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:58 INFO - 'NO_EM_RESTART': '1', 21:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:58 INFO - 'SHELL': '/bin/bash', 21:53:58 INFO - 'SHLVL': '1', 21:53:58 INFO - 'TERM': 'linux', 21:53:58 INFO - 'TMOUT': '86400', 21:53:58 INFO - 'USER': 'cltbld', 21:53:58 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:58 INFO - '_': '/tools/buildbot/bin/python'} 21:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:59 INFO - Running setup.py (path:/tmp/pip-pDmGCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:59 INFO - Running setup.py (path:/tmp/pip-Ed3oqW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:59 INFO - Running setup.py (path:/tmp/pip-e22ndI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:59 INFO - Running setup.py (path:/tmp/pip-4sGCX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:59 INFO - Running setup.py (path:/tmp/pip-8a0Tt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:59 INFO - Running setup.py (path:/tmp/pip-3pEaed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:59 INFO - Running setup.py (path:/tmp/pip-74fxvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:59 INFO - Running setup.py (path:/tmp/pip-T8LARU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:59 INFO - Running setup.py (path:/tmp/pip-UuBr8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:59 INFO - Running setup.py (path:/tmp/pip-DRhVrT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:59 INFO - Running setup.py (path:/tmp/pip-YxJHvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:59 INFO - Running setup.py (path:/tmp/pip-2sb5TE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:00 INFO - Running setup.py (path:/tmp/pip-MW0QV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:00 INFO - Running setup.py (path:/tmp/pip-aixOKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:00 INFO - Running setup.py (path:/tmp/pip-aqv5G_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:00 INFO - Running setup.py (path:/tmp/pip-WDYNyp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:00 INFO - Running setup.py (path:/tmp/pip-xnAz0k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:54:00 INFO - Running setup.py install for manifestparser 21:54:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozcrash 21:54:00 INFO - Running setup.py install for mozdebug 21:54:00 INFO - Running setup.py install for mozdevice 21:54:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozfile 21:54:00 INFO - Running setup.py install for mozhttpd 21:54:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:54:00 INFO - Running setup.py install for mozinfo 21:54:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozInstall 21:54:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozleak 21:54:01 INFO - Running setup.py install for mozlog 21:54:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for moznetwork 21:54:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozprocess 21:54:01 INFO - Running setup.py install for mozprofile 21:54:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozrunner 21:54:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:54:01 INFO - Running setup.py install for mozscreenshot 21:54:01 INFO - Running setup.py install for moztest 21:54:02 INFO - Running setup.py install for mozversion 21:54:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:54:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:54:02 INFO - Cleaning up... 21:54:02 INFO - Return code: 0 21:54:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:54:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:54:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:54:02 INFO - Using env: {'DISPLAY': ':0', 21:54:02 INFO - 'HOME': '/home/cltbld', 21:54:02 INFO - 'LANG': 'en_US.UTF-8', 21:54:02 INFO - 'LANGUAGE': 'en_US:en', 21:54:02 INFO - 'LOGNAME': 'cltbld', 21:54:02 INFO - 'MAIL': '/var/mail/cltbld', 21:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:02 INFO - 'MOZ_NO_REMOTE': '1', 21:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:02 INFO - 'NO_EM_RESTART': '1', 21:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:02 INFO - 'SHELL': '/bin/bash', 21:54:02 INFO - 'SHLVL': '1', 21:54:02 INFO - 'TERM': 'linux', 21:54:02 INFO - 'TMOUT': '86400', 21:54:02 INFO - 'USER': 'cltbld', 21:54:02 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:02 INFO - '_': '/tools/buildbot/bin/python'} 21:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:02 INFO - Running setup.py (path:/tmp/pip-Wotgj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:02 INFO - Running setup.py (path:/tmp/pip-srAil9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:02 INFO - Running setup.py (path:/tmp/pip-FGuGgb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:02 INFO - Running setup.py (path:/tmp/pip-Ab5Dnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:02 INFO - Running setup.py (path:/tmp/pip-2L5bYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:02 INFO - Running setup.py (path:/tmp/pip-ilbAdp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:02 INFO - Running setup.py (path:/tmp/pip-E2FX6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:02 INFO - Running setup.py (path:/tmp/pip-NUnNJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:54:02 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)) 21:54:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:02 INFO - Running setup.py (path:/tmp/pip-_1csA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:03 INFO - Running setup.py (path:/tmp/pip-Qkr0bt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:03 INFO - Running setup.py (path:/tmp/pip-bxjiGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:03 INFO - Running setup.py (path:/tmp/pip-mrbAYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:03 INFO - Running setup.py (path:/tmp/pip-7iyZ6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:03 INFO - Running setup.py (path:/tmp/pip-zVfspz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:03 INFO - Running setup.py (path:/tmp/pip-yc0NeN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:03 INFO - Running setup.py (path:/tmp/pip-HXpTfA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:54:03 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)) 21:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:03 INFO - Running setup.py (path:/tmp/pip-Tw0WRn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:54:03 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)) 21:54:03 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)) 21:54:03 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)) 21:54:03 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)) 21:54:03 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)) 21:54:03 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)) 21:54:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - Downloading blessings-1.5.1.tar.gz 21:54:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:05 INFO - Installing collected packages: blessings 21:54:05 INFO - Running setup.py install for blessings 21:54:05 INFO - Successfully installed blessings 21:54:05 INFO - Cleaning up... 21:54:05 INFO - Return code: 0 21:54:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:05 INFO - Reading from file tmpfile_stdout 21:54:05 INFO - Current package versions: 21:54:05 INFO - argparse == 1.2.1 21:54:05 INFO - blessings == 1.5.1 21:54:05 INFO - blobuploader == 1.2.4 21:54:05 INFO - docopt == 0.6.1 21:54:05 INFO - manifestparser == 1.1 21:54:05 INFO - mozInstall == 1.12 21:54:05 INFO - mozcrash == 0.16 21:54:05 INFO - mozdebug == 0.1 21:54:05 INFO - mozdevice == 0.47 21:54:05 INFO - mozfile == 1.2 21:54:05 INFO - mozhttpd == 0.7 21:54:05 INFO - mozinfo == 0.9 21:54:05 INFO - mozleak == 0.1 21:54:05 INFO - mozlog == 3.0 21:54:05 INFO - moznetwork == 0.27 21:54:05 INFO - mozprocess == 0.22 21:54:05 INFO - mozprofile == 0.27 21:54:05 INFO - mozrunner == 6.11 21:54:05 INFO - mozscreenshot == 0.1 21:54:05 INFO - mozsystemmonitor == 0.0 21:54:05 INFO - moztest == 0.7 21:54:05 INFO - mozversion == 1.4 21:54:05 INFO - psutil == 3.1.1 21:54:05 INFO - requests == 1.2.3 21:54:05 INFO - wsgiref == 0.1.2 21:54:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54: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')]} 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54: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')]} 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f8041e5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', '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 21:54:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 21:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 21:54:05 INFO - Using env: {'DISPLAY': ':0', 21:54:05 INFO - 'HOME': '/home/cltbld', 21:54:05 INFO - 'LANG': 'en_US.UTF-8', 21:54:05 INFO - 'LANGUAGE': 'en_US:en', 21:54:05 INFO - 'LOGNAME': 'cltbld', 21:54:05 INFO - 'MAIL': '/var/mail/cltbld', 21:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:05 INFO - 'MOZ_NO_REMOTE': '1', 21:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:05 INFO - 'NO_EM_RESTART': '1', 21:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:05 INFO - 'SHELL': '/bin/bash', 21:54:05 INFO - 'SHLVL': '1', 21:54:05 INFO - 'TERM': 'linux', 21:54:05 INFO - 'TMOUT': '86400', 21:54:05 INFO - 'USER': 'cltbld', 21:54:05 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:05 INFO - '_': '/tools/buildbot/bin/python'} 21:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 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)) 21:54:05 INFO - Cleaning up... 21:54:05 INFO - Return code: 0 21:54:05 INFO - Running post-action listener: _resource_record_post_action 21:54:05 INFO - Running post-action listener: _start_resource_monitoring 21:54:05 INFO - Starting resource monitoring. 21:54:05 INFO - ##### 21:54:05 INFO - ##### Running install step. 21:54:05 INFO - ##### 21:54:05 INFO - Running pre-action listener: _resource_record_pre_action 21:54:05 INFO - Running main action method: install 21:54:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:06 INFO - Reading from file tmpfile_stdout 21:54:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:54:06 INFO - Reading from file tmpfile_stdout 21:54:06 INFO - Output received: 21:54:06 INFO - Usage: mozinstall [options] installer 21:54:06 INFO - Options: 21:54:06 INFO - -h, --help show this help message and exit 21:54:06 INFO - -d DEST, --destination=DEST 21:54:06 INFO - Directory to install application into. [default: 21:54:06 INFO - "/builds/slave/test-pgo"] 21:54:06 INFO - --app=APP Application being installed. [default: firefox] 21:54:06 INFO - mkdir: /builds/slave/test-pgo/build/application 21:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:54:20 INFO - Reading from file tmpfile_stdout 21:54:20 INFO - Output received: 21:54:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:54:20 INFO - Running post-action listener: _resource_record_post_action 21:54:20 INFO - ##### 21:54:20 INFO - ##### Running run-tests step. 21:54:20 INFO - ##### 21:54:20 INFO - Running pre-action listener: _resource_record_pre_action 21:54:20 INFO - Running main action method: run_tests 21:54:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:54:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:54:20 INFO - Python 2.7.3 21:54:20 INFO - Return code: 0 21:54:20 INFO - grabbing minidump binary from tooltool 21:54:20 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')]} 21:54:20 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 0x17108c0>, '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 0x16bd420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:54:20 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 21:54:20 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 21:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:54:20 INFO - Return code: 0 21:54:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:54:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:54:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 21:54:20 INFO - Using env: {'DISPLAY': ':0', 21:54:20 INFO - 'HOME': '/home/cltbld', 21:54:20 INFO - 'LANG': 'en_US.UTF-8', 21:54:20 INFO - 'LANGUAGE': 'en_US:en', 21:54:20 INFO - 'LOGNAME': 'cltbld', 21:54:20 INFO - 'MAIL': '/var/mail/cltbld', 21:54:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:20 INFO - 'MOZ_NO_REMOTE': '1', 21:54:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:20 INFO - 'NO_EM_RESTART': '1', 21:54:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:20 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:54:20 INFO - 'SHELL': '/bin/bash', 21:54:20 INFO - 'SHLVL': '1', 21:54:20 INFO - 'TERM': 'linux', 21:54:20 INFO - 'TMOUT': '86400', 21:54:20 INFO - 'USER': 'cltbld', 21:54:20 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330', 21:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:20 INFO - '_': '/tools/buildbot/bin/python'} 21:54:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 21:54:20 INFO - mozversion INFO | application_buildid: 20151115193431 21:54:20 INFO - mozversion INFO | application_changeset: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 21:54:20 INFO - mozversion INFO | application_display_name: Nightly 21:54:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:54:20 INFO - mozversion INFO | application_name: Firefox 21:54:20 INFO - mozversion INFO | application_remotingname: firefox 21:54:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 21:54:20 INFO - mozversion INFO | application_vendor: Mozilla 21:54:20 INFO - mozversion INFO | application_version: 45.0a1 21:54:20 INFO - mozversion INFO | platform_buildid: 20151115193431 21:54:20 INFO - mozversion INFO | platform_changeset: bc74dbdea094059d5f1d353a2585b4f6352b6ec4 21:54:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 21:54:20 INFO - mozversion INFO | platform_version: 45.0a1 21:54:20 INFO - 2015-11-15 21:54:20,912 DEBUG : using testdate: 1447653260 21:54:20 INFO - 2015-11-15 21:54:20,912 DEBUG : actual date: 1447653260 21:54:20 INFO - 2015-11-15 21:54:20,920 INFO : starting webserver on 'localhost:34041' 21:54:20 INFO - 2015-11-15 21:54:20,921 INFO : Starting test suite talos-linux64-ix-045 21:54:20 INFO - 2015-11-15 21:54:20,921 INFO : Starting test dromaeo_css 21:54:20 INFO - 2015-11-15 21:54:20,921 DEBUG : operating with platform_type : linux_ 21:54:20 INFO - 2015-11-15 21:54:20,922 INFO : Initialising browser for dromaeo_css test... 21:54:20 INFO - 2015-11-15 21:54:20,938 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbxJP8q/profile http://localhost:34041/getInfo.html 21:54:25 INFO - 2015-11-15 21:54:25,916 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:54:25 INFO - 2015-11-15 21:54:25,916 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:54:25 INFO - 2015-11-15 21:54:25,916 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:54:25 INFO - 2015-11-15 21:54:25,916 DEBUG : BROWSER_OUTPUT: __metrics 21:54:26 INFO - 2015-11-15 21:54:26,033 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:27 INFO - 2015-11-15 21:54:27,257 INFO : Browser initialized. 21:54:27 INFO - 2015-11-15 21:54:27,258 INFO : Running cycle 1/1 for dromaeo_css test... 21:54:27 INFO - 2015-11-15 21:54:27,258 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbxJP8q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:54:39 INFO - 2015-11-15 21:54:39,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 141848576 21:54:39 INFO - 2015-11-15 21:54:39,026 DEBUG : BROWSER_OUTPUT: 21:55:30 INFO - 2015-11-15 21:55:30,681 DEBUG : BROWSER_OUTPUT: 1447653330679 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] 21:57:39 INFO - 2015-11-15 21:57:39,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34041/tests/dromaeo/cssquery-ext.html) 21:57:40 INFO - 2015-11-15 21:57:40,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 234754048 21:57:40 INFO - 2015-11-15 21:57:40,166 DEBUG : BROWSER_OUTPUT: 22:00:42 INFO - 2015-11-15 22:00:42,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-ext.html (next: http://localhost:34041/tests/dromaeo/cssquery-jquery.html) 22:00:42 INFO - 2015-11-15 22:00:42,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 222781440 22:00:42 INFO - 2015-11-15 22:00:42,881 DEBUG : BROWSER_OUTPUT: 22:03:44 INFO - 2015-11-15 22:03:44,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34041/tests/dromaeo/cssquery-mootools.html) 22:03:45 INFO - 2015-11-15 22:03:45,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 209559552 22:03:45 INFO - 2015-11-15 22:03:45,327 DEBUG : BROWSER_OUTPUT: 22:06:47 INFO - 2015-11-15 22:06:47,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34041/tests/dromaeo/cssquery-prototype.html) 22:06:47 INFO - 2015-11-15 22:06:47,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 193593344 22:06:47 INFO - 2015-11-15 22:06:47,820 DEBUG : BROWSER_OUTPUT: 22:09:50 INFO - 2015-11-15 22:09:50,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34041/tests/dromaeo/cssquery-yui.html) 22:09:50 INFO - 2015-11-15 22:09:50,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 201072640 22:09:50 INFO - 2015-11-15 22:09:50,896 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/dromaeo/cssquery-yui.html (next: http://localhost:34041/tests/dromaeo/cssquery-dojo.html) 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 274386944 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:12:53 INFO - 2015-11-15 22:12:53,575 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3208.117767613907;3266.7223286020685;3306.3883181611404;3311.4205014122535;3320.983395083025;5333.599980001496;5379.596530260236;5462.044142275101;5483.8080667176655;5491.780328786849;5368.114261146916;5469.781208751645;5472.2338872557875;5516.3380394352735;5520.089185284433;4962.330085438456;5000.849974500753;5018.071656743496;5040.84877453677;5103.668261563005;4887.755612219375;5117.641765076446;5123.538881500683;5191.091558977183;5196.558292545138;4864.805407783702;4959.454460009396;4978.228374601942;4983.950160498421;5049.949500504985;5000.599952003831;5017.573506251973;5024.899502009976;5056.84829455117;5062.696238225682;4880.097182021337;4975.875603109915;5010.699358038493;5012.298278241013;5063.291139240509;5158.458361872024;5228.398734145584;5232.816851410183;5233.031889100491;5244.711540865251;5829.417058294179;5836.737346819404;5841.47426731592;5849.678267695275;5868.061110222387;5753.741081651336;5842.503387212092;5851.297844258674;5857.092150716603;5867.677277749722;5395.838124856221;5468.316460442445;5472.179173124063;5476.069068258405;5520.227168196456;6036.366181550961;6047.183630209865;6068.059450785047;6068.21113255274;6077.118817771487;5633.915491267634;5755.22304488897;5756.740946657411;5876.6474011558585;5883.470487656132;5969.850753731192;6001.579889407787;6005;6005.369436209223;6014.8195554133445;5932.495737862244;5938.673372964442;5941.70291485424;5946.851328716817;5947.5539334550085;5745.339285982082;5798.594098413155;5868.471837534642;5917.230760001258;5919.970400148058;4463.66522510813;4495.213337665896;4519.367288579601;4531.750753708578;4566.794494247701;4058.939115913264;4060.5939406059747;4073.490813648294;4110.588941105925;4121.62905338515;5450.427705090988;5549.306336707911;5580.637258578179;5667.688277144796;5707;5890.558208134407;5891.263592050994;5893.057110862242;5893.292804863444;5895.793647222326;5415.620906536584;5556.111022236423;5561.721913904369;5562.582806289544;5578.721063946787;5081.060003899291;5082.771275292621;5147.124988751846;5149.6910185389;5184.507471790174;6134.478569321568;6143.354947730513;6145.385461453819;6155.784547540904;6157.599756015845;5643.068893632505;5735.283089613798;5937.19847820556;5946.910796337972;5950.494207992196;5923.940760592512;6008.8497787553915;6009.2188015557695;6012.6392416455155;6063.242094738158;5786.913196302143;5819.592628516132;5833.504152146946;5836.737346819488;5837.824865254049;5772;5819.418058194146;5865.472107510344;5875.882482350415;5880.176775251382;5825.563082768894;5838.883222335615;5840.415958404295;5849.151872978479;5850.0932355484965;5809.593328466966;5813.3895940925595;5814.854628634318;5822.854428639318;5825.912611310749;5528.308961379827;5596.216529685766;5627.88744225105;5699.658020518782;5708.57185711065;5725.914111288251;5735.512481439125;5750.8849823002465;5756.251687280626;5838.795642152504;5619.466150715675;5623.522000629992;5624.3250809903075;5626.521745651666;5644.040513112863 22:12:53 INFO - 2015-11-15 22:12:53,577 DEBUG : BROWSER_OUTPUT: |1;ext.html;584.1529781816366;590.6190507122905;591.5858898770862;592.6769910398832;595.8152972578504;30568.84715576422;31227.531587026184;39066.21867562647;39773.60226397735;39791.204175916464;42619.786901065454;43249.56750432502;43311.78344108275;43312.35031474523;43317.35023974643;7472.065991751031;7664.425168112386;8659.04750477447;8738.519381434051;8768.868466973001;10149.746256343613;10278.486075696223;10351.482425878714;10359.119474844647;10394.116500097463;10195.13341365981;10328.328658637201;10342.793144137113;10355.844662330072;10359.119474844647;10286.382817031003;10387;10387.740306492322;10389.27275090744;10401;10177.796444071077;10240;10313.535890884928;10328.948355258251;10338.9483052585;38880.22239555221;39213.60786392156;39266.42934282625;39301;39321.41017884734;3320.369129865318;3328.833558322074;3375.1899544109483;3388.4917262410836;3684.871029513981;29391.2652183695;29547.70452295471;29553.26116847096;29783;29887.223668072555;3223.677632236781;3244.9675503244903;3267.9346413071844;3401.642827503101;3402.3535528249554;282357;282711;283324;283788;283902;53695;54630.45369546333;55920.72039639776;55981;57527.424725753044;56099;56784.716076419354;57075.714621426625;57217.71391143101;57259;15317;15555.922220388826;15567.532974010797;15594.844051559567;15596.766048509282;11363.488643011084;11444.370559619134;11586.13104017202;11654.76690466186;11973.640790776291;18468;18624.906875465535;18771;18780.342688005854;18806.623867522572;7867.6066196689935;8037.276645101969;8042.517448953082;8089.352851771844;8112.18878112184;860.6729442811817;933.5052422216236;942.8397172480558;1049.4385503755454;1123.6067376418353;27143;27585.724142758314;27886.3028424291;27953.720462795518;27968.580471292946;1022.5654097008891;1034.5603118674683;1035.8290882004535;1053.2364036073784;1193.952241910314;14431.567052988426;14726.484573040107;14809.777853332209;15441.5367538974;15883.28525216368;306221;311182;311309;311443;311532;51593.48406515962;51644.74177629088;51747;51826.22260666093;51838.22242666363;1324.09299629752;1334.2261488336742;1342.5099838559051;1344.4958140697238;1347.0974447120452;26857;28195.57706634443;28326;28405.43189136247;30007;47186.76406617945;47514.28728569005;47541.76229118832;47543.76228118837;47581.762091189325;257616;258702;260104;260277;260330;30236.395272094876;30699;30846.845765771028;30883.227919302197;31039;41118.79440602778;42138.78930605327;42281.365779513944;42416.57583424126;43035.784821076944;33009.83495082509;33306;33416.832915835264;33494.83252583721;33611.49582756212;32661.673383265865;33069;33309.83345083259;33563.32873342568;33584.66415335816;32554.186145346557;32749.181270467478;32870.178245544055;32920.83539582287;32945;29415.726637297572;30111.849440752656;31463.68536314699;31559;31768;24254.636180456953;24265.51468970646;24283.27150185497;24482.632760508965;24543.263702088967 22:12:53 INFO - 2015-11-15 22:12:53,578 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.325016840897;339.5874013074116;347.2534051788654;350.44979382369684;353.1330583417709;13160.27618480983;16907.74638380424;17091.23089460974;17584.120793960315;17590.736138957895;15262.93159478837;15491.69016619667;16051.518454446355;16084.919575402108;16567.50297491074;3989.740666856645;4084.7549147051272;5294.92057619136;5449.04641687705;5731.1116776899435;5833.912491312633;5852.795152169675;5892.204552385416;5904;5905.261842269716;5319.5478384337375;5323.9467605324035;5324.307839980816;5436.075867102582;5814.215080964079;5829.650220986712;5836.037053886103;5840.036393995007;5844.240248767633;5854.619449735775;5035.546800787946;5049.882745737109;5070.594352451795;5099.4900509949075;5102.336696229503;19756.407307780788;20050.1979920803;20215.191392344288;20415.795842041538;20427.89786051075;2122.5436531145724;2158.212252527816;2203.9449013774624;2216.36833502451;2265.8413911026237;12657.873421265762;12773.361331933365;12824.422900969479;12871.356432178354;13093.934530327382;1793.4081753021471;1809.3034181839955;1812.4925020994142;1825.187791432813;1825.9908700456544;57169;58256.708716456145;58521;58735.70632146812;59225.40774592242;6553.311902250291;6762.83092922671;6923.411510021604;6962.860742785116;6996.985437111591;8389.412741108064;8400.369972252105;8403.41176117666;8405.663773448994;8419.284360829275;5286.62993590445;5296.735163241822;5323.467653234646;5365.704886231217;5383.353997520323;5229.9801538699585;5268.552173065255;5293.179557168645;5306.973465132727;5326.44072372403;3039.5136778115398;3099.2561785171397;3166.366726654632;3186.553882456458;3261.0705948804953;1151.9942400287946;1155.7052951497315;1156.780211759763;1164.7030007348071;1195.1394995603152;468.5197672385764;475.6136751291636;476.0265257548253;477.6202918679589;484.3412958376605;11486.253393529561;11634.127440441831;11971.341576213217;12050.216735912312;12053.75892482163;498.1108720933117;503.7984806077598;506.99746501268;521.1427202252273;547.9479449452296;6360.236771587439;6457.967710161513;6544.934550654528;6546.803595892131;6631.900521492182;378534;386485;391329;510623;516770.5713842881;62972.42568935813;65474;65782.67108664426;70829;73020.2697973024;552.7484994327572;569.8119620525217;569.9683572733366;571.6398668838688;572.4761842913771;10820.080293175168;10860.945695271474;11017.889821102008;11096.833547496633;11141.442927853737;34874.47688284729;35041.824790875886;35080.649193507736;35570.28859422745;36007.459888102225;42740.78629606832;43160.568394315655;45837.541624583326;46932.7653361731;48680;6573.079768832272;6680.899786503109;6710.832229194114;6718.496112791462;6761.492888033319;11838.408079596158;11855.466504007512;11949.76100478003;12034.157608967638;12092.334921579046;8898.822023559364;10087.344322619007;10092.142167915516;10557.577696892038;10667.253292269466;9602.759931001501;9892.802143957224;10004.149647280063;10042.347247429187;10214.846777298199;9948.602055917681;10050.24623153281;10251.794964100825;10322.329048612117;10322.793544129225;14590;14599.708005839611;14675.339609717375;14807.889408294206;14944.55166344968;15216;15241.31414086391;15592.298346574204;15654.530364089096;15719.371225150866 22:12:53 INFO - 2015-11-15 22:12:53,580 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1366.8974826887973;1693.7036018696726;1731.1603872122018;1767.1164417791108;1769.4160926894126;6501.089847421359;6934.271901450345;7083.362497375235;7089.184743754477;7092.042574252474;7208.747693830717;7307.415406767459;7324.670389832457;7328.487005909588;7330.450216233777;1931.9903400482979;1975.0322342052364;2141.8714877107423;2197.9340619781433;2217.390217690132;2224.610693128704;2233.932982010542;2234.977650223493;2235.184157782414;2236.9888150559223;2040.8673436226597;2116.460302622829;2116.608427440928;2118.8940552972367;2125.3730149605826;1933.3233368321046;1981.8117278858485;2139.294032969124;2199.175309259028;2206.3270702435752;2213.2143089203423;2215.634420320645;2234.4748983988748;2261.3555136786104;2262.7171603549555;7251.927480725178;7366.484346095775;7372.852542949165;7374.078240219973;7379.262073792632;4396.868093957154;4455.509893911667;4484;4487.39420178275;4489.349044388546;2790.2884764385153;2809.6347474828344;2825.0394865745743;2835.050258163497;2939.088882446448;877.9517126558037;889.297455010541;903.3315346643436;906.6328137104483;917.8990311065777;9781.41311521311;9791.559379827924;9793.804123917482;9797.67731356265;9797.80404391908;3875.7868317242824;4001.199760047944;4015.257177422128;4018.035671438892;4042.3936409538214;8538.188872057144;8541.914580854113;8556.272716819016;8557.914420855835;8558.272546833465;4485.080558485568;4501.909961800811;4507;4513;4517.277235642281;4080.4287399764057;4082.81627326771;4085.285075111903;4113.177364527047;4119.320312148522;3381.239221175265;3393.7285017198565;3407.6421975692692;3407.880724174642;3420.8973730788116;1096.742265567591;1102.6747109602686;1105.0496572947259;1106.6624679472839;1136.2898188632105;981.4160574458328;1241.0878004666563;1242.515418986596;1259.2004077410727;1282.3267784413072;6006.699665016732;6699.363560461748;6914.757983470655;6914.792556223321;6922.342377474232;659.4493597845757;671.5701950751522;675.1965161457849;708.7590219325455;718.1274751177344;5204.1673332266655;5250.973745131327;5271.182966640177;5280.260763493114;5284.497972692588;8330.250277475056;8459.111793261742;8635.266002389868;8715.172058654418;8770.473771573726;8267.62795674196;8373.95325584302;8506.064332923374;8516.957415213008;8594.484330940164;6720.4287635550545;6817.420519255918;6901.930980690229;6984;6990.545614535141;6822.8635427292165;6850.280720524273;6860.931390686029;6867.553609015398;6868.965655171693;7669.616519173907;7747.341475974606;7748;7769.844603108019;7872.488288261474;7867.921320786719;8001.719939802079;8079.232472915063;8113.472624279403;8123.390745693979;6669.866602668017;6673.532852700265;6734.3602357775935;6753.3921947025;6755.459563234831;6663.666816659244;6958.930410695828;6986.16166060076;7020.543664661781;7020.6489675514995;6753.594784312957;6842.281560436281;6890.173179218526;6926.688299026657;6949.722011119701;6677.866442671217;6723.663816809042;6760.763373282109;6810.080639113657;6847.520673553003;5740.196372507936;5852.619579727304;6573.737050517926;6593.736250549924;6603.867922641616;6095.481884039907;6163.537734669828;6228.4705800007505;6250.874982500233;6253.624782512882;6272.560920735505;6288.6855657217875;6289.119523266838;6294.6852657366035;6298.496120310456 22:12:53 INFO - 2015-11-15 22:12:53,583 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.9137024373662;336.774361178011;340.09873834339;341.0399724774759;346.77113105350475;5838.211841401409;5997.910031349533;6009.669468179249;6031.427014433627;6067.939320606798;5819.156222347768;5948.31594366648;5966.164736936832;5977.731002104905;5997.580169388145;4592.678512504126;4593.655475839326;4596.655250856183;4599.494055653875;4610.446746390421;4361.520232774392;4440.4893437254805;4483.6861419700635;4627.514111018345;4641.489436162019;4572.565606267399;4578.5650363215445;4581.518940511249;4582.129395414877;4594;4551.704139230939;4568.634509239269;4580.610648094916;4588.449386073676;4604.332371806069;4022.758634481911;4024.8993775155564;4031.778252196128;4036.858709945167;4042.413849991764;5543.916841247385;5673.6879471629045;5697.259356283698;5717.656940583578;5729.226554415142;5289.86775330616;5291.021161085211;5293.100172970604;5298.549623282026;5300.973495132538;6009.939900600982;6370.87258254837;6371.681415929185;6374.58565193261;6377.776777812801;4260.9147817043795;4286.742795432284;4421.027373977752;4422;4434.711743736647;6488.5133614978595;6551.541392102555;6594.472442204612;6602.075709400639;6609.735610575572;4387.670924680661;4388.144311859221;4392.143532011227;4393.956060439418;4396.494403143615;4376.234159022159;4395.055063161436;4438.312061630452;4448.7108337957925;4460.754658493814;5193.610479214074;5195.376554813371;5202.219667049897;5205.193195054772;5208.244804503326;6384.329645387167;6386.744530218833;6387.968060159762;6392.16901802772;6393.680315984182;1596.2098761113323;1596.728556145458;1599.8880078394634;1600.2078970909474;1605.3739041773717;1038.48075962019;1048.3447845096814;1059.6132411669685;1064.2231171245035;1103.8564986551696;6128.540359473057;6225.408586184305;6226.097215903668;6226.439620434183;6238.282597501346;6598.7030583623855;6598.934010659928;6601.900971485432;6613.404793568506;6618.602883826986;6097.908531372033;6223.813285601439;6233.470155036782;6235.968820155961;6236.501079913687;3570.285942811396;3590.4973303737497;3596.946045809315;3600.333938221385;3600.945985810215;6866.759663411756;6881.13985751781;6887.174898651861;6891;6894.00036994633;6625.105610742585;6768.661566921634;6769.3907548320885;6777.457803375718;6781.287964763727;6829.726810927507;6864.279250678706;6875.759348422881;6877.1747390313485;6886;6360.332165122595;6525.543211975116;6580.177477815273;6583.901241481477;6587.341265873566;6414.871702566016;6541.08424820516;6545.6399898004165;6548.345165483413;6580.539362244597;6891;6913.792586222421;6923.169219693669;6927.134108236471;6929.133858267716;4425.4246947897855;4524.185646583646;4526.140033393644;4527.411436513232;4542.318652202196;6558.376954189344;6569.310222426768;6569.868602628017;6573.737050517926;6576.605403675795;6409.935900640934;6428.453581445629;6444.613323200623;6445.548811583144;6451.806445806634;6275.270257438029;6444.194475690539;6446.580972236789;6454.967725161344;6470.288268290578;6308.747650093945;6317.968410158103;6318.589291696025;6320.62076275425;6329.145565348619;6471.385218404244;6476.222853257639;6492.28584855656;6493;6496.155499784998;6128.325884152829;6314.873702526015;6328.778492752732;6333.873322533432;6351.07909353132 22:12:53 INFO - 2015-11-15 22:12:53,583 DEBUG : BROWSER_OUTPUT: |5;yui.html;749.9212582678819;841.1475442473472;852.6930305090168;857.9399442039052;872.1409411729445;13397.531086411978;13666.658333541642;13704.314784260798;13741.65645858854;13745.175289482626;12533.811992820116;12621.242725436481;12635.873641263584;12696.555620553283;12718.23690578566;673.9123913891187;679.5582871133778;814.4909431605247;815.7511958852563;831.0442990560842;798.8122791144076;803.8352137811764;808.4906508899385;809.3848675006979;809.4253080312985;710.3997122431537;851.4635779458932;861.3066481482405;861.9310455163603;862.0560486267558;715.9749408770695;849.7493239494364;863.8056437301619;864.8400045991511;865.6191275838643;640.1422094393535;640.2061443809689;640.3724350136846;640.6604499615165;641.4066988036049;12217.93891030539;12378.44297006637;12384.256944583263;12393.93803030988;12420.75158496825;12350.567730129493;13101.08292419531;13140.934295328558;13186.472541098345;13289.202647841064;10120.190384769201;10329.896701032969;10419.583216671399;10553.947230263877;10712.678619641423;3578.35589593873;3579.94630080549;3595.712343012579;3604.8197590120653;3664.4320130379833;47177.29234061492;48948.51051489475;49235.26147107796;49380.75309623465;49601.75199123981;9794.26543009263;9991.900080999098;10091.79349209596;10124.74688132788;10168.949155254177;18578.163982620816;18585.5353616158;18586.44240672782;18599.34902278414;18668.813311866706;7574.5076570022775;7633.618319084024;7721.8455630887065;7801.960990195126;7957.244061814118;4130.153318569686;4185.832566697359;4206.978965105155;4251.744895306291;4257.254980378483;2999.0403071017067;2999.475091858916;3025.364673418607;3025.7428118609723;3026.3190782073857;442.41159258186536;461.30803794308537;462.4081176094604;467.6936606522733;481.33575665581276;612.4518555892452;624.0919462182513;630.5691559039926;642.8232236135007;647.5851500321246;8155.184481551916;8240.423170378135;8256.339492840558;8504.44721093127;8564.357673174536;516.5970542976485;540.1465684218924;540.4784383070356;563.8223959452841;583.3670467542763;3988.262171498282;4004.0790618157985;4284.67864910133;4395.362672412482;4418.55814418562;56575;56891.715541422025;57061;57230;57299;50444.24333634999;51074.74462627663;51123;51511.22733159005;51591;44192.55807441949;45546.77226613912;45685.543144568794;45836.770816146374;46086.769566151954;8426.747197584082;8463.619137138967;8557.828843423222;8624.61189246498;8675.839974529674;33809.154771129935;34415.65584344124;34625.30749385049;34659.4801077979;35118.64881351256;39492;40083.19833603253;42236.577634223264;43447.13105737804;43695.56304436915;7354.301341372561;7706.653200606098;7807;11512.94243528777;11856.70358241051;11494.540218391505;11753.236039657395;12456.190347627375;12717;12959.092863499465;11125.165612578927;11322.26405283654;11848.881511185122;11920.046396288102;12327.321997290235;11474.541018359172;11477.885221147682;11523.481443334902;11876;11937.462814173557;11287.209895307578;11422.771544569228;11572.6528204154;11583;11599.304041757521;9494.145526902335;9654.951725241328;9681.467519286507;9817.950910245403;9994.800103998024;9172.357934944757;9251.491167985825;9969.35199212049;9973.950130249303;9991.150752185855 22:12:53 INFO - 2015-11-15 22:12:53,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:12:53 INFO - 2015-11-15 22:12:53,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:12:53 INFO - 2015-11-15 22:12:53,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,836 22:12:53 INFO - 2015-11-15 22:12:53,585 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:12:53 INFO - 2015-11-15 22:12:53,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654373574__endTimestamp 22:12:53 INFO - 2015-11-15 22:12:53,585 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:12:53 INFO - 2015-11-15 22:12:53,586 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:12:53 INFO - 2015-11-15 22:12:53,586 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,586 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5466.13 Median:5644.04 stddev:604.76 (10.7%) stddev-sans-first:580.09 22:12:53 INFO - 2015-11-15 22:12:53,588 DEBUG : BROWSER_OUTPUT: Values: 3208.1 3266.7 3306.4 3311.4 3321.0 5333.6 5379.6 5462.0 5483.8 5491.8 5368.1 5469.8 5472.2 5516.3 5520.1 4962.3 5000.8 5018.1 5040.8 5103.7 4887.8 5117.6 5123.5 5191.1 5196.6 4864.8 4959.5 4978.2 4984.0 5049.9 5000.6 5017.6 5024.9 5056.8 5062.7 4880.1 4975.9 5010.7 5012.3 5063.3 5158.5 5228.4 5232.8 5233.0 5244.7 5829.4 5836.7 5841.5 5849.7 5868.1 5753.7 5842.5 5851.3 5857.1 5867.7 5395.8 5468.3 5472.2 5476.1 5520.2 6036.4 6047.2 6068.1 6068.2 6077.1 5633.9 5755.2 5756.7 5876.6 5883.5 5969.9 6001.6 6005.0 6005.4 6014.8 5932.5 5938.7 5941.7 5946.9 5947.6 5745.3 5798.6 5868.5 5917.2 5920.0 4463.7 4495.2 4519.4 4531.8 4566.8 4058.9 4060.6 4073.5 4110.6 4121.6 5450.4 5549.3 5580.6 5667.7 5707.0 5890.6 5891.3 5893.1 5893.3 5895.8 5415.6 5556.1 5561.7 5562.6 5578.7 5081.1 5082.8 5147.1 5149.7 5184.5 6134.5 6143.4 6145.4 6155.8 6157.6 5643.1 5735.3 5937.2 5946.9 5950.5 5923.9 6008.8 6009.2 6012.6 6063.2 5786.9 5819.6 5833.5 5836.7 5837.8 5772.0 5819.4 5865.5 5875.9 5880.2 5825.6 5838.9 5840.4 5849.2 5850.1 5809.6 5813.4 5814.9 5822.9 5825.9 5528.3 5596.2 5627.9 5699.7 5708.6 5725.9 5735.5 5750.9 5756.3 5838.8 5619.5 5623.5 5624.3 5626.5 5644.0 22:12:53 INFO - 2015-11-15 22:12:53,588 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,588 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45152.11 Median:171110.50 stddev:74360.36 (43.5%) stddev-sans-first:74493.67 22:12:53 INFO - 2015-11-15 22:12:53,589 DEBUG : BROWSER_OUTPUT: Values: 584.2 590.6 591.6 592.7 595.8 30568.8 31227.5 39066.2 39773.6 39791.2 42619.8 43249.6 43311.8 43312.4 43317.4 7472.1 7664.4 8659.0 8738.5 8768.9 10149.7 10278.5 10351.5 10359.1 10394.1 10195.1 10328.3 10342.8 10355.8 10359.1 10286.4 10387.0 10387.7 10389.3 10401.0 10177.8 10240.0 10313.5 10328.9 10338.9 38880.2 39213.6 39266.4 39301.0 39321.4 3320.4 3328.8 3375.2 3388.5 3684.9 29391.3 29547.7 29553.3 29783.0 29887.2 3223.7 3245.0 3267.9 3401.6 3402.4 282357.0 282711.0 283324.0 283788.0 283902.0 53695.0 54630.5 55920.7 55981.0 57527.4 56099.0 56784.7 57075.7 57217.7 57259.0 15317.0 15555.9 15567.5 15594.8 15596.8 11363.5 11444.4 11586.1 11654.8 11973.6 18468.0 18624.9 18771.0 18780.3 18806.6 7867.6 8037.3 8042.5 8089.4 8112.2 860.7 933.5 942.8 1049.4 1123.6 27143.0 27585.7 27886.3 27953.7 27968.6 1022.6 1034.6 1035.8 1053.2 1194.0 14431.6 14726.5 14809.8 15441.5 15883.3 306221.0 311182.0 311309.0 311443.0 311532.0 51593.5 51644.7 51747.0 51826.2 51838.2 1324.1 1334.2 1342.5 1344.5 1347.1 26857.0 28195.6 28326.0 28405.4 30007.0 47186.8 47514.3 47541.8 47543.8 47581.8 257616.0 258702.0 260104.0 260277.0 260330.0 30236.4 30699.0 30846.8 30883.2 31039.0 41118.8 42138.8 42281.4 42416.6 43035.8 33009.8 33306.0 33416.8 33494.8 33611.5 32661.7 33069.0 33309.8 33563.3 33584.7 32554.2 32749.2 32870.2 32920.8 32945.0 29415.7 30111.8 31463.7 31559.0 31768.0 24254.6 24265.5 24283.3 24482.6 24543.3 22:12:53 INFO - 2015-11-15 22:12:53,590 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,590 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24458.71 Median:23412.77 stddev:72309.99 (308.8%) stddev-sans-first:72490.14 22:12:53 INFO - 2015-11-15 22:12:53,590 DEBUG : BROWSER_OUTPUT: Values: 333.3 339.6 347.3 350.4 353.1 13160.3 16907.7 17091.2 17584.1 17590.7 15262.9 15491.7 16051.5 16084.9 16567.5 3989.7 4084.8 5294.9 5449.0 5731.1 5833.9 5852.8 5892.2 5904.0 5905.3 5319.5 5323.9 5324.3 5436.1 5814.2 5829.7 5836.0 5840.0 5844.2 5854.6 5035.5 5049.9 5070.6 5099.5 5102.3 19756.4 20050.2 20215.2 20415.8 20427.9 2122.5 2158.2 2203.9 2216.4 2265.8 12657.9 12773.4 12824.4 12871.4 13093.9 1793.4 1809.3 1812.5 1825.2 1826.0 57169.0 58256.7 58521.0 58735.7 59225.4 6553.3 6762.8 6923.4 6962.9 6997.0 8389.4 8400.4 8403.4 8405.7 8419.3 5286.6 5296.7 5323.5 5365.7 5383.4 5230.0 5268.6 5293.2 5307.0 5326.4 3039.5 3099.3 3166.4 3186.6 3261.1 1152.0 1155.7 1156.8 1164.7 1195.1 468.5 475.6 476.0 477.6 484.3 11486.3 11634.1 11971.3 12050.2 12053.8 498.1 503.8 507.0 521.1 547.9 6360.2 6458.0 6544.9 6546.8 6631.9 378534.0 386485.0 391329.0 510623.0 516770.6 62972.4 65474.0 65782.7 70829.0 73020.3 552.7 569.8 570.0 571.6 572.5 10820.1 10860.9 11017.9 11096.8 11141.4 34874.5 35041.8 35080.6 35570.3 36007.5 42740.8 43160.6 45837.5 46932.8 48680.0 6573.1 6680.9 6710.8 6718.5 6761.5 11838.4 11855.5 11949.8 12034.2 12092.3 8898.8 10087.3 10092.1 10557.6 10667.3 9602.8 9892.8 10004.1 10042.3 10214.8 9948.6 10050.2 10251.8 10322.3 10322.8 14590.0 14599.7 14675.3 14807.9 14944.6 15216.0 15241.3 15592.3 15654.5 15719.4 22:12:53 INFO - 2015-11-15 22:12:53,591 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,591 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5114.23 Median:6598.80 stddev:2621.22 (39.7%) stddev-sans-first:2613.44 22:12:53 INFO - 2015-11-15 22:12:53,592 DEBUG : BROWSER_OUTPUT: Values: 1366.9 1693.7 1731.2 1767.1 1769.4 6501.1 6934.3 7083.4 7089.2 7092.0 7208.7 7307.4 7324.7 7328.5 7330.5 1932.0 1975.0 2141.9 2197.9 2217.4 2224.6 2233.9 2235.0 2235.2 2237.0 2040.9 2116.5 2116.6 2118.9 2125.4 1933.3 1981.8 2139.3 2199.2 2206.3 2213.2 2215.6 2234.5 2261.4 2262.7 7251.9 7366.5 7372.9 7374.1 7379.3 4396.9 4455.5 4484.0 4487.4 4489.3 2790.3 2809.6 2825.0 2835.1 2939.1 878.0 889.3 903.3 906.6 917.9 9781.4 9791.6 9793.8 9797.7 9797.8 3875.8 4001.2 4015.3 4018.0 4042.4 8538.2 8541.9 8556.3 8557.9 8558.3 4485.1 4501.9 4507.0 4513.0 4517.3 4080.4 4082.8 4085.3 4113.2 4119.3 3381.2 3393.7 3407.6 3407.9 3420.9 1096.7 1102.7 1105.0 1106.7 1136.3 981.4 1241.1 1242.5 1259.2 1282.3 6006.7 6699.4 6914.8 6914.8 6922.3 659.4 671.6 675.2 708.8 718.1 5204.2 5251.0 5271.2 5280.3 5284.5 8330.3 8459.1 8635.3 8715.2 8770.5 8267.6 8374.0 8506.1 8517.0 8594.5 6720.4 6817.4 6901.9 6984.0 6990.5 6822.9 6850.3 6860.9 6867.6 6869.0 7669.6 7747.3 7748.0 7769.8 7872.5 7867.9 8001.7 8079.2 8113.5 8123.4 6669.9 6673.5 6734.4 6753.4 6755.5 6663.7 6958.9 6986.2 7020.5 7020.6 6753.6 6842.3 6890.2 6926.7 6949.7 6677.9 6723.7 6760.8 6810.1 6847.5 5740.2 5852.6 6573.7 6593.7 6603.9 6095.5 6163.5 6228.5 6250.9 6253.6 6272.6 6288.7 6289.1 6294.7 6298.5 22:12:53 INFO - 2015-11-15 22:12:53,592 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,592 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5331.93 Median:6082.92 stddev:1624.86 (26.7%) stddev-sans-first:1585.49 22:12:53 INFO - 2015-11-15 22:12:53,593 DEBUG : BROWSER_OUTPUT: Values: 331.9 336.8 340.1 341.0 346.8 5838.2 5997.9 6009.7 6031.4 6067.9 5819.2 5948.3 5966.2 5977.7 5997.6 4592.7 4593.7 4596.7 4599.5 4610.4 4361.5 4440.5 4483.7 4627.5 4641.5 4572.6 4578.6 4581.5 4582.1 4594.0 4551.7 4568.6 4580.6 4588.4 4604.3 4022.8 4024.9 4031.8 4036.9 4042.4 5543.9 5673.7 5697.3 5717.7 5729.2 5289.9 5291.0 5293.1 5298.5 5301.0 6009.9 6370.9 6371.7 6374.6 6377.8 4260.9 4286.7 4421.0 4422.0 4434.7 6488.5 6551.5 6594.5 6602.1 6609.7 4387.7 4388.1 4392.1 4394.0 4396.5 4376.2 4395.1 4438.3 4448.7 4460.8 5193.6 5195.4 5202.2 5205.2 5208.2 6384.3 6386.7 6388.0 6392.2 6393.7 1596.2 1596.7 1599.9 1600.2 1605.4 1038.5 1048.3 1059.6 1064.2 1103.9 6128.5 6225.4 6226.1 6226.4 6238.3 6598.7 6598.9 6601.9 6613.4 6618.6 6097.9 6223.8 6233.5 6236.0 6236.5 3570.3 3590.5 3596.9 3600.3 3600.9 6866.8 6881.1 6887.2 6891.0 6894.0 6625.1 6768.7 6769.4 6777.5 6781.3 6829.7 6864.3 6875.8 6877.2 6886.0 6360.3 6525.5 6580.2 6583.9 6587.3 6414.9 6541.1 6545.6 6548.3 6580.5 6891.0 6913.8 6923.2 6927.1 6929.1 4425.4 4524.2 4526.1 4527.4 4542.3 6558.4 6569.3 6569.9 6573.7 6576.6 6409.9 6428.5 6444.6 6445.5 6451.8 6275.3 6444.2 6446.6 6455.0 6470.3 6308.7 6318.0 6318.6 6320.6 6329.1 6471.4 6476.2 6492.3 6493.0 6496.2 6128.3 6314.9 6328.8 6333.9 6351.1 22:12:53 INFO - 2015-11-15 22:12:53,593 DEBUG : BROWSER_OUTPUT: 22:12:53 INFO - 2015-11-15 22:12:53,593 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13648.72 Median:23274.04 stddev:15751.16 (67.7%) stddev-sans-first:15765.56 22:12:53 INFO - 2015-11-15 22:12:53,594 DEBUG : BROWSER_OUTPUT: Values: 749.9 841.1 852.7 857.9 872.1 13397.5 13666.7 13704.3 13741.7 13745.2 12533.8 12621.2 12635.9 12696.6 12718.2 673.9 679.6 814.5 815.8 831.0 798.8 803.8 808.5 809.4 809.4 710.4 851.5 861.3 861.9 862.1 716.0 849.7 863.8 864.8 865.6 640.1 640.2 640.4 640.7 641.4 12217.9 12378.4 12384.3 12393.9 12420.8 12350.6 13101.1 13140.9 13186.5 13289.2 10120.2 10329.9 10419.6 10553.9 10712.7 3578.4 3579.9 3595.7 3604.8 3664.4 47177.3 48948.5 49235.3 49380.8 49601.8 9794.3 9991.9 10091.8 10124.7 10168.9 18578.2 18585.5 18586.4 18599.3 18668.8 7574.5 7633.6 7721.8 7802.0 7957.2 4130.2 4185.8 4207.0 4251.7 4257.3 2999.0 2999.5 3025.4 3025.7 3026.3 442.4 461.3 462.4 467.7 481.3 612.5 624.1 630.6 642.8 647.6 8155.2 8240.4 8256.3 8504.4 8564.4 516.6 540.1 540.5 563.8 583.4 3988.3 4004.1 4284.7 4395.4 4418.6 56575.0 56891.7 57061.0 57230.0 57299.0 50444.2 51074.7 51123.0 51511.2 51591.0 44192.6 45546.8 45685.5 45836.8 46086.8 8426.7 8463.6 8557.8 8624.6 8675.8 33809.2 34415.7 34625.3 34659.5 35118.6 39492.0 40083.2 42236.6 43447.1 43695.6 7354.3 7706.7 7807.0 11512.9 11856.7 11494.5 11753.2 12456.2 12717.0 12959.1 11125.2 11322.3 11848.9 11920.0 12327.3 11474.5 11477.9 11523.5 11876.0 11937.5 11287.2 11422.8 11572.7 11583.0 11599.3 9494.1 9655.0 9681.5 9818.0 9994.8 9172.4 9251.5 9969.4 9974.0 9991.2 22:12:53 INFO - 2015-11-15 22:12:53,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:12:53 INFO - 2015-11-15 22:12:53,594 DEBUG : BROWSER_OUTPUT: 22:12:54 INFO - 2015-11-15 22:12:54,257 INFO : Browser exited with error code: 0 22:12:54 INFO - 2015-11-15 22:12:54,278 INFO : Completed test dromaeo_css (00:18:33) 22:12:54 INFO - 2015-11-15 22:12:54,278 INFO : Starting test kraken 22:12:54 INFO - 2015-11-15 22:12:54,278 DEBUG : operating with platform_type : linux_ 22:12:54 INFO - 2015-11-15 22:12:54,279 INFO : Initialising browser for kraken test... 22:12:54 INFO - 2015-11-15 22:12:54,285 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp52N1kd/profile http://localhost:34041/getInfo.html 22:12:58 INFO - 2015-11-15 22:12:58,022 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:12:58 INFO - 2015-11-15 22:12:58,022 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:12:58 INFO - 2015-11-15 22:12:58,022 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:12:58 INFO - 2015-11-15 22:12:58,022 DEBUG : BROWSER_OUTPUT: __metrics 22:12:58 INFO - 2015-11-15 22:12:58,103 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:59 INFO - 2015-11-15 22:12:59,403 INFO : Browser initialized. 22:12:59 INFO - 2015-11-15 22:12:59,404 INFO : Running cycle 1/1 for kraken test... 22:12:59 INFO - 2015-11-15 22:12:59,404 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp52N1kd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:13:11 INFO - 2015-11-15 22:13:11,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 141225984 22:13:11 INFO - 2015-11-15 22:13:11,199 DEBUG : BROWSER_OUTPUT: 22:13:13 INFO - 2015-11-15 22:13:13,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34041/tests/kraken/driver.html?testName=audio-beat-detection) 22:13:14 INFO - 2015-11-15 22:13:14,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 178892800 22:13:14 INFO - 2015-11-15 22:13:14,237 DEBUG : BROWSER_OUTPUT: 22:13:16 INFO - 2015-11-15 22:13:16,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34041/tests/kraken/driver.html?testName=audio-dft) 22:13:17 INFO - 2015-11-15 22:13:17,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 169402368 22:13:17 INFO - 2015-11-15 22:13:17,396 DEBUG : BROWSER_OUTPUT: 22:13:20 INFO - 2015-11-15 22:13:20,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34041/tests/kraken/driver.html?testName=audio-fft) 22:13:20 INFO - 2015-11-15 22:13:20,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 151461888 22:13:20 INFO - 2015-11-15 22:13:20,838 DEBUG : BROWSER_OUTPUT: 22:13:22 INFO - 2015-11-15 22:13:22,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34041/tests/kraken/driver.html?testName=audio-oscillator) 22:13:23 INFO - 2015-11-15 22:13:23,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 153268224 22:13:23 INFO - 2015-11-15 22:13:23,389 DEBUG : BROWSER_OUTPUT: 22:13:25 INFO - 2015-11-15 22:13:25,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34041/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:13:26 INFO - 2015-11-15 22:13:26,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 154071040 22:13:26 INFO - 2015-11-15 22:13:26,116 DEBUG : BROWSER_OUTPUT: 22:13:29 INFO - 2015-11-15 22:13:29,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34041/tests/kraken/driver.html?testName=imaging-darkroom) 22:13:29 INFO - 2015-11-15 22:13:29,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 154193920 22:13:29 INFO - 2015-11-15 22:13:29,588 DEBUG : BROWSER_OUTPUT: 22:13:32 INFO - 2015-11-15 22:13:32,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34041/tests/kraken/driver.html?testName=imaging-desaturate) 22:13:33 INFO - 2015-11-15 22:13:33,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 156946432 22:13:33 INFO - 2015-11-15 22:13:33,527 DEBUG : BROWSER_OUTPUT: 22:13:36 INFO - 2015-11-15 22:13:36,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34041/tests/kraken/driver.html?testName=json-parse-financial) 22:13:36 INFO - 2015-11-15 22:13:36,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 155131904 22:13:36 INFO - 2015-11-15 22:13:36,891 DEBUG : BROWSER_OUTPUT: 22:13:38 INFO - 2015-11-15 22:13:38,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34041/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:13:38 INFO - 2015-11-15 22:13:38,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 166981632 22:13:38 INFO - 2015-11-15 22:13:38,997 DEBUG : BROWSER_OUTPUT: 22:13:40 INFO - 2015-11-15 22:13:40,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:13:41 INFO - 2015-11-15 22:13:41,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 167407616 22:13:41 INFO - 2015-11-15 22:13:41,413 DEBUG : BROWSER_OUTPUT: 22:13:43 INFO - 2015-11-15 22:13:43,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:13:44 INFO - 2015-11-15 22:13:44,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 169598976 22:13:44 INFO - 2015-11-15 22:13:44,051 DEBUG : BROWSER_OUTPUT: 22:13:46 INFO - 2015-11-15 22:13:46,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:13:47 INFO - 2015-11-15 22:13:47,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 179245056 22:13:47 INFO - 2015-11-15 22:13:47,051 DEBUG : BROWSER_OUTPUT: 22:13:49 INFO - 2015-11-15 22:13:49,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:13:50 INFO - 2015-11-15 22:13:50,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 179523584 22:13:50 INFO - 2015-11-15 22:13:50,182 DEBUG : BROWSER_OUTPUT: 22:13:51 INFO - 2015-11-15 22:13:51,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34041/tests/kraken/driver.html?testName=ai-astar) 22:13:52 INFO - 2015-11-15 22:13:52,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 238424064 22:13:52 INFO - 2015-11-15 22:13:52,106 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;105;110;113;111;100;111;114;111 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;124;150;168;125;160;153;125;162;123 22:13:52 INFO - 2015-11-15 22:13:52,110 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;164;161;160;159;163;162;161 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;83;93;71;72;72;94;92;72 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;135;90;90;91;140;89;90;145 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;110;109;110 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;145;147;145;146;146;145;146;145 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;57;56;58;57;58;65;54;55 22:13:52 INFO - 2015-11-15 22:13:52,111 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;69;69;68;68;68 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;85;84;86;87;85;94;85 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;124;123;127;119;117;118;131;126;116 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;155;153;148;152;144;148;150;150;143 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;68;67;67;77;67;66;67 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:13:52 INFO - 2015-11-15 22:13:52,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 22:13:52 INFO - 2015-11-15 22:13:52,113 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:13:52 INFO - 2015-11-15 22:13:52,113 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654432108__endTimestamp 22:13:52 INFO - 2015-11-15 22:13:52,113 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,114 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:13:52 INFO - 2015-11-15 22:13:52,114 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:13:52 INFO - 2015-11-15 22:13:52,114 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,114 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:4.24 (3.8%) stddev-sans-first:4.49 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 105.0 110.0 113.0 111.0 100.0 111.0 114.0 111.0 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:151.50 stddev:17.76 (11.7%) stddev-sans-first:18.81 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: Values: 146.0 124.0 150.0 168.0 125.0 160.0 153.0 125.0 162.0 123.0 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 164.0 161.0 160.0 159.0 163.0 162.0 161.0 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:78.00 stddev:10.00 (12.8%) stddev-sans-first:10.34 22:13:52 INFO - 2015-11-15 22:13:52,115 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 83.0 93.0 71.0 72.0 72.0 94.0 92.0 72.0 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:90.00 stddev:24.20 (26.9%) stddev-sans-first:25.05 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 135.0 90.0 90.0 91.0 140.0 89.0 90.0 145.0 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,116 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 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:13:52 INFO - 2015-11-15 22:13:52,116 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 145.0 147.0 145.0 146.0 146.0 145.0 146.0 145.0 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:2.95 (5.1%) stddev-sans-first:3.13 22:13:52 INFO - 2015-11-15 22:13:52,117 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 57.0 56.0 58.0 57.0 58.0 65.0 54.0 55.0 22:13:52 INFO - 2015-11-15 22:13:52,118 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,118 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.53 22:13:52 INFO - 2015-11-15 22:13:52,118 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 68.0 68.0 68.0 22:13:52 INFO - 2015-11-15 22:13:52,118 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.08 (3.6%) stddev-sans-first:3.10 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 85.0 84.0 86.0 87.0 85.0 94.0 85.0 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:125.00 stddev:5.17 (4.1%) stddev-sans-first:5.15 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: Values: 128.0 124.0 123.0 127.0 119.0 117.0 118.0 131.0 126.0 116.0 22:13:52 INFO - 2015-11-15 22:13:52,119 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,120 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.00 stddev:4.03 (2.7%) stddev-sans-first:3.96 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: Values: 154.0 155.0 153.0 148.0 152.0 144.0 148.0 150.0 150.0 143.0 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.00 stddev:3.23 (4.8%) stddev-sans-first:3.41 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 68.0 67.0 67.0 77.0 67.0 66.0 67.0 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:13:52 INFO - 2015-11-15 22:13:52,121 DEBUG : BROWSER_OUTPUT: 22:13:52 INFO - 2015-11-15 22:13:52,997 INFO : Browser exited with error code: 0 22:13:53 INFO - 2015-11-15 22:13:53,045 INFO : Completed test kraken (00:00:58) 22:13:53 INFO - 2015-11-15 22:13:53,045 INFO : Starting test v8_7 22:13:53 INFO - 2015-11-15 22:13:53,046 DEBUG : operating with platform_type : linux_ 22:13:53 INFO - 2015-11-15 22:13:53,046 INFO : Initialising browser for v8_7 test... 22:13:53 INFO - 2015-11-15 22:13:53,052 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplaf7SS/profile http://localhost:34041/getInfo.html 22:13:56 INFO - 2015-11-15 22:13:56,807 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:13:56 INFO - 2015-11-15 22:13:56,807 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:13:56 INFO - 2015-11-15 22:13:56,807 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:13:56 INFO - 2015-11-15 22:13:56,808 DEBUG : BROWSER_OUTPUT: __metrics 22:13:56 INFO - 2015-11-15 22:13:56,896 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:13:58 INFO - 2015-11-15 22:13:58,220 INFO : Browser initialized. 22:13:58 INFO - 2015-11-15 22:13:58,221 INFO : Running cycle 1/1 for v8_7 test... 22:13:58 INFO - 2015-11-15 22:13:58,221 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplaf7SS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:14:09 INFO - 2015-11-15 22:14:09,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 22:14:09 INFO - 2015-11-15 22:14:09,951 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34041/tests/v8_7/run.html (next: http://localhost:34041/tests/v8_7/run.html) 22:14:31 INFO - 2015-11-15 22:14:31,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 531066880 22:14:31 INFO - 2015-11-15 22:14:31,577 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: |0;Richards;170.29972752043597 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;195.08388607101054 22:14:31 INFO - 2015-11-15 22:14:31,579 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1136.3636363636363 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |5;Earley;802.5682182985554 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |8;Splay;576.7012687427913 22:14:31 INFO - 2015-11-15 22:14:31,580 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654471578__endTimestamp 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:14:31 INFO - 2015-11-15 22:14:31,581 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,582 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.30 Median:170.30 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,582 DEBUG : BROWSER_OUTPUT: Values: 170.3 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:195.08 Median:195.08 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: Values: 195.1 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: Values: 285.1 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: Values: 5035.2 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1136.36 Median:1136.36 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: Values: 1136.4 22:14:31 INFO - 2015-11-15 22:14:31,583 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: Values: 802.6 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: Values: 12120.5 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: Values: 26394.7 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:576.70 Median:576.70 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: Values: 576.7 22:14:31 INFO - 2015-11-15 22:14:31,584 DEBUG : BROWSER_OUTPUT: 22:14:31 INFO - 2015-11-15 22:14:31,585 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 22:14:31 INFO - 2015-11-15 22:14:31,585 DEBUG : BROWSER_OUTPUT: Values: 4812.5 22:14:31 INFO - 2015-11-15 22:14:31,585 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:14:31 INFO - 2015-11-15 22:14:31,585 DEBUG : BROWSER_OUTPUT: 22:14:32 INFO - 2015-11-15 22:14:32,441 INFO : Browser exited with error code: 0 22:14:32 INFO - 2015-11-15 22:14:32,458 INFO : Completed test v8_7 (00:00:39) 22:14:32 INFO - 2015-11-15 22:14:32,625 INFO : Completed test suite (00:20:11) 22:14:32 INFO - 2015-11-15 22:14:32,626 DEBUG : Working with test: dromaeo_css 22:14:32 INFO - 2015-11-15 22:14:32,626 DEBUG : Generating results file: dromaeo_css 22:14:32 INFO - 2015-11-15 22:14:32,627 DEBUG : Working with test: kraken 22:14:32 INFO - 2015-11-15 22:14:32,627 DEBUG : Generating results file: kraken 22:14:32 INFO - 2015-11-15 22:14:32,627 INFO : javascript benchmark 22:14:32 INFO - 2015-11-15 22:14:32,627 DEBUG : Working with test: v8_7 22:14:32 INFO - 2015-11-15 22:14:32,627 DEBUG : Generating results file: v8_7 22:14:32 INFO - 2015-11-15 22:14:32,628 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:32 INFO - 2015-11-15 22:14:32,674 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:14:32 INFO - 2015-11-15 22:14:32,674 DEBUG : process_Request line: dromaeo_css 6712.05 graph.html#tests=[[72,1,35]] 22:14:32 INFO - 2015-11-15 22:14:32,674 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:32 INFO - 2015-11-15 22:14:32,699 DEBUG : process_Request line: kraken 1503.00 graph.html#tests=[[232,1,35]] 22:14:32 INFO - 2015-11-15 22:14:32,699 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:32 INFO - 2015-11-15 22:14:32,726 DEBUG : process_Request line: v8_7 20929.53 graph.html#tests=[[230,1,35]] 22:14:32 INFO - 2015-11-15 22:14:32,728 INFO : javascript benchmark 22:14:32 INFO - 2015-11-15 22:14:32,732 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [333.325016840897, 339.5874013074116, 347.2534051788654, 350.44979382369684, 353.1330583417709, 13160.27618480983, 16907.74638380424, 17091.23089460974, 17584.120793960315, 17590.736138957895, 15262.93159478837, 15491.69016619667, 16051.518454446355, 16084.919575402108, 16567.50297491074, 3989.740666856645, 4084.7549147051272, 5294.92057619136, 5449.04641687705, 5731.1116776899435, 5833.912491312633, 5852.795152169675, 5892.204552385416, 5904.0, 5905.261842269716, 5319.5478384337375, 5323.9467605324035, 5324.307839980816, 5436.075867102582, 5814.215080964079, 5829.650220986712, 5836.037053886103, 5840.036393995007, 5844.240248767633, 5854.619449735775, 5035.546800787946, 5049.882745737109, 5070.594352451795, 5099.4900509949075, 5102.336696229503, 19756.407307780788, 20050.1979920803, 20215.191392344288, 20415.795842041538, 20427.89786051075, 2122.5436531145724, 2158.212252527816, 2203.9449013774624, 2216.36833502451, 2265.8413911026237, 12657.873421265762, 12773.361331933365, 12824.422900969479, 12871.356432178354, 13093.934530327382, 1793.4081753021471, 1809.3034181839955, 1812.4925020994142, 1825.187791432813, 1825.9908700456544, 57169.0, 58256.708716456145, 58521.0, 58735.70632146812, 59225.40774592242, 6553.311902250291, 6762.83092922671, 6923.411510021604, 6962.860742785116, 6996.985437111591, 8389.412741108064, 8400.369972252105, 8403.41176117666, 8405.663773448994, 8419.284360829275, 5286.62993590445, 5296.735163241822, 5323.467653234646, 5365.704886231217, 5383.353997520323, 5229.9801538699585, 5268.552173065255, 5293.179557168645, 5306.973465132727, 5326.44072372403, 3039.5136778115398, 3099.2561785171397, 3166.366726654632, 3186.553882456458, 3261.0705948804953, 1151.9942400287946, 1155.7052951497315, 1156.780211759763, 1164.7030007348071, 1195.1394995603152, 468.5197672385764, 475.6136751291636, 476.0265257548253, 477.6202918679589, 484.3412958376605, 11486.253393529561, 11634.127440441831, 11971.341576213217, 12050.216735912312, 12053.75892482163, 498.1108720933117, 503.7984806077598, 506.99746501268, 521.1427202252273, 547.9479449452296, 6360.236771587439, 6457.967710161513, 6544.934550654528, 6546.803595892131, 6631.900521492182, 378534.0, 386485.0, 391329.0, 510623.0, 516770.5713842881, 62972.42568935813, 65474.0, 65782.67108664426, 70829.0, 73020.2697973024, 552.7484994327572, 569.8119620525217, 569.9683572733366, 571.6398668838688, 572.4761842913771, 10820.080293175168, 10860.945695271474, 11017.889821102008, 11096.833547496633, 11141.442927853737, 34874.47688284729, 35041.824790875886, 35080.649193507736, 35570.28859422745, 36007.459888102225, 42740.78629606832, 43160.568394315655, 45837.541624583326, 46932.7653361731, 48680.0, 6573.079768832272, 6680.899786503109, 6710.832229194114, 6718.496112791462, 6761.492888033319, 11838.408079596158, 11855.466504007512, 11949.76100478003, 12034.157608967638, 12092.334921579046, 8898.822023559364, 10087.344322619007, 10092.142167915516, 10557.577696892038, 10667.253292269466, 9602.759931001501, 9892.802143957224, 10004.149647280063, 10042.347247429187, 10214.846777298199, 9948.602055917681, 10050.24623153281, 10251.794964100825, 10322.329048612117, 10322.793544129225, 14590.0, 14599.708005839611, 14675.339609717375, 14807.889408294206, 14944.55166344968, 15216.0, 15241.31414086391, 15592.298346574204, 15654.530364089096, 15719.371225150866], "dojo.html": [3208.117767613907, 3266.7223286020685, 3306.3883181611404, 3311.4205014122535, 3320.983395083025, 5333.599980001496, 5379.596530260236, 5462.044142275101, 5483.8080667176655, 5491.780328786849, 5368.114261146916, 5469.781208751645, 5472.2338872557875, 5516.3380394352735, 5520.089185284433, 4962.330085438456, 5000.849974500753, 5018.071656743496, 5040.84877453677, 5103.668261563005, 4887.755612219375, 5117.641765076446, 5123.538881500683, 5191.091558977183, 5196.558292545138, 4864.805407783702, 4959.454460009396, 4978.228374601942, 4983.950160498421, 5049.949500504985, 5000.599952003831, 5017.573506251973, 5024.899502009976, 5056.84829455117, 5062.696238225682, 4880.097182021337, 4975.875603109915, 5010.699358038493, 5012.298278241013, 5063.291139240509, 5158.458361872024, 5228.398734145584, 5232.816851410183, 5233.031889100491, 5244.711540865251, 5829.417058294179, 5836.737346819404, 5841.47426731592, 5849.678267695275, 5868.061110222387, 5753.741081651336, 5842.503387212092, 5851.297844258674, 5857.092150716603, 5867.677277749722, 5395.838124856221, 5468.316460442445, 5472.179173124063, 5476.069068258405, 5520.227168196456, 6036.366181550961, 6047.183630209865, 6068.059450785047, 6068.21113255274, 6077.118817771487, 5633.915491267634, 5755.22304488897, 5756.740946657411, 5876.6474011558585, 5883.470487656132, 5969.850753731192, 6001.579889407787, 6005.0, 6005.369436209223, 6014.8195554133445, 5932.495737862244, 5938.673372964442, 5941.70291485424, 5946.851328716817, 5947.5539334550085, 5745.339285982082, 5798.594098413155, 5868.471837534642, 5917.230760001258, 5919.970400148058, 4463.66522510813, 4495.213337665896, 4519.367288579601, 4531.750753708578, 4566.794494247701, 4058.939115913264, 4060.5939406059747, 4073.490813648294, 4110.588941105925, 4121.62905338515, 5450.427705090988, 5549.306336707911, 5580.637258578179, 5667.688277144796, 5707.0, 5890.558208134407, 5891.263592050994, 5893.057110862242, 5893.292804863444, 5895.793647222326, 5415.620906536584, 5556.111022236423, 5561.721913904369, 5562.582806289544, 5578.721063946787, 5081.060003899291, 5082.771275292621, 5147.124988751846, 5149.6910185389, 5184.507471790174, 6134.478569321568, 6143.354947730513, 6145.385461453819, 6155.784547540904, 6157.599756015845, 5643.068893632505, 5735.283089613798, 5937.19847820556, 5946.910796337972, 5950.494207992196, 5923.940760592512, 6008.8497787553915, 6009.2188015557695, 6012.6392416455155, 6063.242094738158, 5786.913196302143, 5819.592628516132, 5833.504152146946, 5836.737346819488, 5837.824865254049, 5772.0, 5819.418058194146, 5865.472107510344, 5875.882482350415, 5880.176775251382, 5825.563082768894, 5838.883222335615, 5840.415958404295, 5849.151872978479, 5850.0932355484965, 5809.593328466966, 5813.3895940925595, 5814.854628634318, 5822.854428639318, 5825.912611310749, 5528.308961379827, 5596.216529685766, 5627.88744225105, 5699.658020518782, 5708.57185711065, 5725.914111288251, 5735.512481439125, 5750.8849823002465, 5756.251687280626, 5838.795642152504, 5619.466150715675, 5623.522000629992, 5624.3250809903075, 5626.521745651666, 5644.040513112863], "mootools.html": [1366.8974826887973, 1693.7036018696726, 1731.1603872122018, 1767.1164417791108, 1769.4160926894126, 6501.089847421359, 6934.271901450345, 7083.362497375235, 7089.184743754477, 7092.042574252474, 7208.747693830717, 7307.415406767459, 7324.670389832457, 7328.487005909588, 7330.450216233777, 1931.9903400482979, 1975.0322342052364, 2141.8714877107423, 2197.9340619781433, 2217.390217690132, 2224.610693128704, 2233.932982010542, 2234.977650223493, 2235.184157782414, 2236.9888150559223, 2040.8673436226597, 2116.460302622829, 2116.608427440928, 2118.8940552972367, 2125.3730149605826, 1933.3233368321046, 1981.8117278858485, 2139.294032969124, 2199.175309259028, 2206.3270702435752, 2213.2143089203423, 2215.634420320645, 2234.4748983988748, 2261.3555136786104, 2262.7171603549555, 7251.927480725178, 7366.484346095775, 7372.852542949165, 7374.078240219973, 7379.262073792632, 4396.868093957154, 4455.509893911667, 4484.0, 4487.39420178275, 4489.349044388546, 2790.2884764385153, 2809.6347474828344, 2825.0394865745743, 2835.050258163497, 2939.088882446448, 877.9517126558037, 889.297455010541, 903.3315346643436, 906.6328137104483, 917.8990311065777, 9781.41311521311, 9791.559379827924, 9793.804123917482, 9797.67731356265, 9797.80404391908, 3875.7868317242824, 4001.199760047944, 4015.257177422128, 4018.035671438892, 4042.3936409538214, 8538.188872057144, 8541.914580854113, 8556.272716819016, 8557.914420855835, 8558.272546833465, 4485.080558485568, 4501.909961800811, 4507.0, 4513.0, 4517.277235642281, 4080.4287399764057, 4082.81627326771, 4085.285075111903, 4113.177364527047, 4119.320312148522, 3381.239221175265, 3393.7285017198565, 3407.6421975692692, 3407.880724174642, 3420.8973730788116, 1096.742265567591, 1102.6747109602686, 1105.0496572947259, 1106.6624679472839, 1136.2898188632105, 981.4160574458328, 1241.0878004666563, 1242.515418986596, 1259.2004077410727, 1282.3267784413072, 6006.699665016732, 6699.363560461748, 6914.757983470655, 6914.792556223321, 6922.342377474232, 659.4493597845757, 671.5701950751522, 675.1965161457849, 708.7590219325455, 718.1274751177344, 5204.1673332266655, 5250.973745131327, 5271.182966640177, 5280.260763493114, 5284.497972692588, 8330.250277475056, 8459.111793261742, 8635.266002389868, 8715.172058654418, 8770.473771573726, 8267.62795674196, 8373.95325584302, 8506.064332923374, 8516.957415213008, 8594.484330940164, 6720.4287635550545, 6817.420519255918, 6901.930980690229, 6984.0, 6990.545614535141, 6822.8635427292165, 6850.280720524273, 6860.931390686029, 6867.553609015398, 6868.965655171693, 7669.616519173907, 7747.341475974606, 7748.0, 7769.844603108019, 7872.488288261474, 7867.921320786719, 8001.719939802079, 8079.232472915063, 8113.472624279403, 8123.390745693979, 6669.866602668017, 6673.532852700265, 6734.3602357775935, 6753.3921947025, 6755.459563234831, 6663.666816659244, 6958.930410695828, 6986.16166060076, 7020.543664661781, 7020.6489675514995, 6753.594784312957, 6842.281560436281, 6890.173179218526, 6926.688299026657, 6949.722011119701, 6677.866442671217, 6723.663816809042, 6760.763373282109, 6810.080639113657, 6847.520673553003, 5740.196372507936, 5852.619579727304, 6573.737050517926, 6593.736250549924, 6603.867922641616, 6095.481884039907, 6163.537734669828, 6228.4705800007505, 6250.874982500233, 6253.624782512882, 6272.560920735505, 6288.6855657217875, 6289.119523266838, 6294.6852657366035, 6298.496120310456], "ext.html": [584.1529781816366, 590.6190507122905, 591.5858898770862, 592.6769910398832, 595.8152972578504, 30568.84715576422, 31227.531587026184, 39066.21867562647, 39773.60226397735, 39791.204175916464, 42619.786901065454, 43249.56750432502, 43311.78344108275, 43312.35031474523, 43317.35023974643, 7472.065991751031, 7664.425168112386, 8659.04750477447, 8738.519381434051, 8768.868466973001, 10149.746256343613, 10278.486075696223, 10351.482425878714, 10359.119474844647, 10394.116500097463, 10195.13341365981, 10328.328658637201, 10342.793144137113, 10355.844662330072, 10359.119474844647, 10286.382817031003, 10387.0, 10387.740306492322, 10389.27275090744, 10401.0, 10177.796444071077, 10240.0, 10313.535890884928, 10328.948355258251, 10338.9483052585, 38880.22239555221, 39213.60786392156, 39266.42934282625, 39301.0, 39321.41017884734, 3320.369129865318, 3328.833558322074, 3375.1899544109483, 3388.4917262410836, 3684.871029513981, 29391.2652183695, 29547.70452295471, 29553.26116847096, 29783.0, 29887.223668072555, 3223.677632236781, 3244.9675503244903, 3267.9346413071844, 3401.642827503101, 3402.3535528249554, 282357.0, 282711.0, 283324.0, 283788.0, 283902.0, 53695.0, 54630.45369546333, 55920.72039639776, 55981.0, 57527.424725753044, 56099.0, 56784.716076419354, 57075.714621426625, 57217.71391143101, 57259.0, 15317.0, 15555.922220388826, 15567.532974010797, 15594.844051559567, 15596.766048509282, 11363.488643011084, 11444.370559619134, 11586.13104017202, 11654.76690466186, 11973.640790776291, 18468.0, 18624.906875465535, 18771.0, 18780.342688005854, 18806.623867522572, 7867.6066196689935, 8037.276645101969, 8042.517448953082, 8089.352851771844, 8112.18878112184, 860.6729442811817, 933.5052422216236, 942.8397172480558, 1049.4385503755454, 1123.6067376418353, 27143.0, 27585.724142758314, 27886.3028424291, 27953.720462795518, 27968.580471292946, 1022.5654097008891, 1034.5603118674683, 1035.8290882004535, 1053.2364036073784, 1193.952241910314, 14431.567052988426, 14726.484573040107, 14809.777853332209, 15441.5367538974, 15883.28525216368, 306221.0, 311182.0, 311309.0, 311443.0, 311532.0, 51593.48406515962, 51644.74177629088, 51747.0, 51826.22260666093, 51838.22242666363, 1324.09299629752, 1334.2261488336742, 1342.5099838559051, 1344.4958140697238, 1347.0974447120452, 26857.0, 28195.57706634443, 28326.0, 28405.43189136247, 30007.0, 47186.76406617945, 47514.28728569005, 47541.76229118832, 47543.76228118837, 47581.762091189325, 257616.0, 258702.0, 260104.0, 260277.0, 260330.0, 30236.395272094876, 30699.0, 30846.845765771028, 30883.227919302197, 31039.0, 41118.79440602778, 42138.78930605327, 42281.365779513944, 42416.57583424126, 43035.784821076944, 33009.83495082509, 33306.0, 33416.832915835264, 33494.83252583721, 33611.49582756212, 32661.673383265865, 33069.0, 33309.83345083259, 33563.32873342568, 33584.66415335816, 32554.186145346557, 32749.181270467478, 32870.178245544055, 32920.83539582287, 32945.0, 29415.726637297572, 30111.849440752656, 31463.68536314699, 31559.0, 31768.0, 24254.636180456953, 24265.51468970646, 24283.27150185497, 24482.632760508965, 24543.263702088967], "prototype.html": [331.9137024373662, 336.774361178011, 340.09873834339, 341.0399724774759, 346.77113105350475, 5838.211841401409, 5997.910031349533, 6009.669468179249, 6031.427014433627, 6067.939320606798, 5819.156222347768, 5948.31594366648, 5966.164736936832, 5977.731002104905, 5997.580169388145, 4592.678512504126, 4593.655475839326, 4596.655250856183, 4599.494055653875, 4610.446746390421, 4361.520232774392, 4440.4893437254805, 4483.6861419700635, 4627.514111018345, 4641.489436162019, 4572.565606267399, 4578.5650363215445, 4581.518940511249, 4582.129395414877, 4594.0, 4551.704139230939, 4568.634509239269, 4580.610648094916, 4588.449386073676, 4604.332371806069, 4022.758634481911, 4024.8993775155564, 4031.778252196128, 4036.858709945167, 4042.413849991764, 5543.916841247385, 5673.6879471629045, 5697.259356283698, 5717.656940583578, 5729.226554415142, 5289.86775330616, 5291.021161085211, 5293.100172970604, 5298.549623282026, 5300.973495132538, 6009.939900600982, 6370.87258254837, 6371.681415929185, 6374.58565193261, 6377.776777812801, 4260.9147817043795, 4286.742795432284, 4421.027373977752, 4422.0, 4434.711743736647, 6488.5133614978595, 6551.541392102555, 6594.472442204612, 6602.075709400639, 6609.735610575572, 4387.670924680661, 4388.144311859221, 4392.143532011227, 4393.956060439418, 4396.494403143615, 4376.234159022159, 4395.055063161436, 4438.312061630452, 4448.7108337957925, 4460.754658493814, 5193.610479214074, 5195.376554813371, 5202.219667049897, 5205.193195054772, 5208.244804503326, 6384.329645387167, 6386.744530218833, 6387.968060159762, 6392.16901802772, 6393.680315984182, 1596.2098761113323, 1596.728556145458, 1599.8880078394634, 1600.2078970909474, 1605.3739041773717, 1038.48075962019, 1048.3447845096814, 1059.6132411669685, 1064.2231171245035, 1103.8564986551696, 6128.540359473057, 6225.408586184305, 6226.097215903668, 6226.439620434183, 6238.282597501346, 6598.7030583623855, 6598.934010659928, 6601.900971485432, 6613.404793568506, 6618.602883826986, 6097.908531372033, 6223.813285601439, 6233.470155036782, 6235.968820155961, 6236.501079913687, 3570.285942811396, 3590.4973303737497, 3596.946045809315, 3600.333938221385, 3600.945985810215, 6866.759663411756, 6881.13985751781, 6887.174898651861, 6891.0, 6894.00036994633, 6625.105610742585, 6768.661566921634, 6769.3907548320885, 6777.457803375718, 6781.287964763727, 6829.726810927507, 6864.279250678706, 6875.759348422881, 6877.1747390313485, 6886.0, 6360.332165122595, 6525.543211975116, 6580.177477815273, 6583.901241481477, 6587.341265873566, 6414.871702566016, 6541.08424820516, 6545.6399898004165, 6548.345165483413, 6580.539362244597, 6891.0, 6913.792586222421, 6923.169219693669, 6927.134108236471, 6929.133858267716, 4425.4246947897855, 4524.185646583646, 4526.140033393644, 4527.411436513232, 4542.318652202196, 6558.376954189344, 6569.310222426768, 6569.868602628017, 6573.737050517926, 6576.605403675795, 6409.935900640934, 6428.453581445629, 6444.613323200623, 6445.548811583144, 6451.806445806634, 6275.270257438029, 6444.194475690539, 6446.580972236789, 6454.967725161344, 6470.288268290578, 6308.747650093945, 6317.968410158103, 6318.589291696025, 6320.62076275425, 6329.145565348619, 6471.385218404244, 6476.222853257639, 6492.28584855656, 6493.0, 6496.155499784998, 6128.325884152829, 6314.873702526015, 6328.778492752732, 6333.873322533432, 6351.07909353132], "yui.html": [749.9212582678819, 841.1475442473472, 852.6930305090168, 857.9399442039052, 872.1409411729445, 13397.531086411978, 13666.658333541642, 13704.314784260798, 13741.65645858854, 13745.175289482626, 12533.811992820116, 12621.242725436481, 12635.873641263584, 12696.555620553283, 12718.23690578566, 673.9123913891187, 679.5582871133778, 814.4909431605247, 815.7511958852563, 831.0442990560842, 798.8122791144076, 803.8352137811764, 808.4906508899385, 809.3848675006979, 809.4253080312985, 710.3997122431537, 851.4635779458932, 861.3066481482405, 861.9310455163603, 862.0560486267558, 715.9749408770695, 849.7493239494364, 863.8056437301619, 864.8400045991511, 865.6191275838643, 640.1422094393535, 640.2061443809689, 640.3724350136846, 640.6604499615165, 641.4066988036049, 12217.93891030539, 12378.44297006637, 12384.256944583263, 12393.93803030988, 12420.75158496825, 12350.567730129493, 13101.08292419531, 13140.934295328558, 13186.472541098345, 13289.202647841064, 10120.190384769201, 10329.896701032969, 10419.583216671399, 10553.947230263877, 10712.678619641423, 3578.35589593873, 3579.94630080549, 3595.712343012579, 3604.8197590120653, 3664.4320130379833, 47177.29234061492, 48948.51051489475, 49235.26147107796, 49380.75309623465, 49601.75199123981, 9794.26543009263, 9991.900080999098, 10091.79349209596, 10124.74688132788, 10168.949155254177, 18578.163982620816, 18585.5353616158, 18586.44240672782, 18599.34902278414, 18668.813311866706, 7574.5076570022775, 7633.618319084024, 7721.8455630887065, 7801.960990195126, 7957.244061814118, 4130.153318569686, 4185.832566697359, 4206.978965105155, 4251.744895306291, 4257.254980378483, 2999.0403071017067, 2999.475091858916, 3025.364673418607, 3025.7428118609723, 3026.3190782073857, 442.41159258186536, 461.30803794308537, 462.4081176094604, 467.6936606522733, 481.33575665581276, 612.4518555892452, 624.0919462182513, 630.5691559039926, 642.8232236135007, 647.5851500321246, 8155.184481551916, 8240.423170378135, 8256.339492840558, 8504.44721093127, 8564.357673174536, 516.5970542976485, 540.1465684218924, 540.4784383070356, 563.8223959452841, 583.3670467542763, 3988.262171498282, 4004.0790618157985, 4284.67864910133, 4395.362672412482, 4418.55814418562, 56575.0, 56891.715541422025, 57061.0, 57230.0, 57299.0, 50444.24333634999, 51074.74462627663, 51123.0, 51511.22733159005, 51591.0, 44192.55807441949, 45546.77226613912, 45685.543144568794, 45836.770816146374, 46086.769566151954, 8426.747197584082, 8463.619137138967, 8557.828843423222, 8624.61189246498, 8675.839974529674, 33809.154771129935, 34415.65584344124, 34625.30749385049, 34659.4801077979, 35118.64881351256, 39492.0, 40083.19833603253, 42236.577634223264, 43447.13105737804, 43695.56304436915, 7354.301341372561, 7706.653200606098, 7807.0, 11512.94243528777, 11856.70358241051, 11494.540218391505, 11753.236039657395, 12456.190347627375, 12717.0, 12959.092863499465, 11125.165612578927, 11322.26405283654, 11848.881511185122, 11920.046396288102, 12327.321997290235, 11474.541018359172, 11477.885221147682, 11523.481443334902, 11876.0, 11937.462814173557, 11287.209895307578, 11422.771544569228, 11572.6528204154, 11583.0, 11599.304041757521, 9494.145526902335, 9654.951725241328, 9681.467519286507, 9817.950910245403, 9994.800103998024, 9172.357934944757, 9251.491167985825, 9969.35199212049, 9973.950130249303, 9991.150752185855]}, "summary": {"lowerIsBetter": false, "suite": 6712.052070638085, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7355.06299016868, "unit": "ms", "value": 7355.06299016868}, "dojo.html": {"lowerIsBetter": false, "filtered": 5427.054808101702, "unit": "ms", "value": 5427.054808101702}, "mootools.html": {"lowerIsBetter": false, "filtered": 4188.971739586213, "unit": "ms", "value": 4188.971739586213}, "ext.html": {"lowerIsBetter": false, "filtered": 18368.09167808988, "unit": "ms", "value": 18368.09167808988}, "prototype.html": {"lowerIsBetter": false, "filtered": 4803.245479924862, "unit": "ms", "value": 4803.245479924862}, "yui.html": {"lowerIsBetter": false, "filtered": 6197.783464726712, "unit": "ms", "value": 6197.783464726712}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447653260, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115193431", "branch": "Firefox", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 164.0, 161.0, 160.0, 159.0, 163.0, 162.0, 161.0], "ai-astar": [110.0, 113.0, 105.0, 110.0, 113.0, 111.0, 100.0, 111.0, 114.0, 111.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "audio-beat-detection": [146.0, 124.0, 150.0, 168.0, 125.0, 160.0, 153.0, 125.0, 162.0, 123.0], "json-stringify-tinderbox": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [154.0, 155.0, 153.0, 148.0, 152.0, 144.0, 148.0, 150.0, 150.0, 143.0], "json-parse-financial": [57.0, 58.0, 57.0, 56.0, 58.0, 57.0, 58.0, 65.0, 54.0, 55.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 68.0, 68.0, 67.0, 67.0, 77.0, 67.0, 66.0, 67.0], "audio-fft": [73.0, 72.0, 83.0, 93.0, 71.0, 72.0, 72.0, 94.0, 92.0, 72.0], "imaging-darkroom": [146.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0], "stanford-crypto-ccm": [128.0, 124.0, 123.0, 127.0, 119.0, 117.0, 118.0, 131.0, 126.0, 116.0], "audio-oscillator": [90.0, 91.0, 135.0, 90.0, 90.0, 91.0, 140.0, 89.0, 90.0, 145.0], "stanford-crypto-aes": [83.0, 84.0, 85.0, 85.0, 84.0, 86.0, 87.0, 85.0, 94.0, 85.0], "imaging-desaturate": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1503.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.4, "unit": "ms", "value": 79.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.7, "unit": "ms", "value": 149.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.6, "unit": "ms", "value": 143.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.9, "unit": "ms", "value": 122.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.5, "unit": "ms", "value": 57.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.1, "unit": "ms", "value": 105.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.6, "unit": "ms", "value": 68.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.8, "unit": "ms", "value": 85.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.9, "unit": "ms", "value": 95.9}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447653260, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115193431", "branch": "Firefox", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}, {"talos_counters": {}, "results": {"DeltaBlue": [195.08388607101054], "Encrypt": [285.143997718848], "NavierStokes": [4812.5], "Decrypt": [5035.175879396985], "Splay": [576.7012687427913], "Richards": [170.29972752043597], "RegExp": [26394.736842105263], "Earley": [802.5682182985554], "Boyer": [12120.481927710844], "RayTrace": [1136.3636363636363]}, "summary": {"lowerIsBetter": false, "suite": 20929.52831958123, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 338.920868, "unit": "score", "value": 338.920868}, "Encrypt": {"lowerIsBetter": false, "filtered": 933.4967669999996, "unit": "score", "value": 933.4967669999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.3636363636364, "unit": "score", "value": 308.3636363636364}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 141.30539399999998, "unit": "score", "value": 141.30539399999998}, "RegExp": {"lowerIsBetter": false, "filtered": 34.51388833499503, "unit": "score", "value": 34.51388833499503}, "Richards": {"lowerIsBetter": false, "filtered": 207.293344, "unit": "score", "value": 207.293344}, "Earley": {"lowerIsBetter": false, "filtered": 830.4128980000002, "unit": "score", "value": 830.4128980000002}, "Boyer": {"lowerIsBetter": false, "filtered": 54.9865099403579, "unit": "score", "value": 54.9865099403579}, "RayTrace": {"lowerIsBetter": false, "filtered": 651.1903200000003, "unit": "score", "value": 651.1903200000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447653260, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115193431", "branch": "Firefox", "revision": "bc74dbdea094059d5f1d353a2585b4f6352b6ec4"}}] 22:14:32 INFO - RETURN: dromaeo_css: 6712.05 22:14:32 INFO - RETURN: kraken: 1503.00 22:14:32 INFO - RETURN: v8_7: 20929.53 22:14:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20929.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1503.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6712.05"}}} 22:14:32 INFO - Return code: 0 22:14:32 INFO - # TBPL SUCCESS # 22:14:32 INFO - Running post-action listener: _resource_record_post_action 22:14:32 INFO - Running post-run listener: _resource_record_post_run 22:14:33 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 510439424; Read time: 0; Write time: 523056 22:14:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 174743552; Read time: 0; Write time: 240332 22:14:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 335683584; Read time: 0; Write time: 282724 22:14:33 INFO - Running post-run listener: _upload_blobber_files 22:14:33 INFO - Blob upload gear active. 22:14:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:14:33 INFO - Copying logs to upload dir... 22:14:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.591600 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-15 22:14:32.803098) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:14:32.806277) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/tf6yiawBRomQVOsPvfO0nw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:14:32.857782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:14:32.858122) ========= 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=61fa6ed41387771909ec0f71000001b3-1447652922.52118-731348330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:14:32.907612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 22:14:32.907927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 22:14:32.908213) ========= ========= Total master_lag: 0.23 =========