builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1447594535.58 results: success (0) buildid: 20151115030440 builduid: f4b3eeeb55da4c30af41ec0891dd8451 revision: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.583145) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.583634) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.583982) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007066 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.626773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.627120) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.644662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.645004) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.696583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.696899) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.697302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.697610) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 05:35:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-11-15 05:35:35 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.812194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.812512) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.862549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:35.862955) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d --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 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d --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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 05:35:36,045 truncating revision to first 12 chars 2015-11-15 05:35:36,045 Setting DEBUG logging. 2015-11-15 05:35:36,046 attempt 1/10 2015-11-15 05:35:36,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51fa3e0d4f7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 05:35:36,291 unpacking tar archive at: mozilla-central-51fa3e0d4f7b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534516 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:36.412027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:36.412461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:36.420025) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:36.420352) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 05:35:36.420814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-15 05:35:36.421155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:36 INFO - MultiFileLogger online at 20151115 05:35:36 in /builds/slave/test-pgo 05:35:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 05:35:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:35:36 INFO - {'append_to_log': False, 05:35:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:35:36 INFO - 'blob_upload_branch': 'Firefox', 05:35:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:35:36 INFO - 'branch': 'Firefox', 05:35:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:36 INFO - 'config_files': ('talos/linux_config.py',), 05:35:36 INFO - 'default_actions': ('clobber', 05:35:36 INFO - 'read-buildbot-config', 05:35:36 INFO - 'download-and-extract', 05:35:36 INFO - 'populate-webroot', 05:35:36 INFO - 'create-virtualenv', 05:35:36 INFO - 'install', 05:35:36 INFO - 'run-tests'), 05:35:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:36 INFO - 'download_minidump_stackwalk': True, 05:35:36 INFO - 'download_symbols': 'ondemand', 05:35:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:36 INFO - 'installer_path': 'installer.exe', 05:35:36 INFO - 'log_level': 'info', 05:35:36 INFO - 'log_name': 'talos', 05:35:36 INFO - 'log_to_console': True, 05:35:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:36 INFO - 'opt_config_files': (), 05:35:36 INFO - 'pip_index': False, 05:35:36 INFO - 'sps_profile': False, 05:35:36 INFO - 'sps_profile_interval': 0, 05:35:36 INFO - 'suite': 'dromaeojs-e10s', 05:35:36 INFO - 'system_bits': '64', 05:35:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:36 INFO - 'title': 'talos-linux64-ix-036', 05:35:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:36 INFO - 'use_talos_json': True, 05:35:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:35:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:36 INFO - 'work_dir': 'build'} 05:35:36 INFO - ##### 05:35:36 INFO - ##### Running clobber step. 05:35:36 INFO - ##### 05:35:36 INFO - Running pre-action listener: _resource_record_pre_action 05:35:36 INFO - Running main action method: clobber 05:35:36 INFO - rmtree: /builds/slave/test-pgo/build 05:35:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running read-buildbot-config step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: read_buildbot_config 05:35:37 INFO - Using buildbot properties: 05:35:37 INFO - { 05:35:37 INFO - "properties": { 05:35:37 INFO - "buildnumber": 540, 05:35:37 INFO - "product": "firefox", 05:35:37 INFO - "script_repo_revision": "production", 05:35:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:35:37 INFO - "repository": "", 05:35:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:35:37 INFO - "buildid": "20151115030440", 05:35:37 INFO - "slavename": "talos-linux64-ix-036", 05:35:37 INFO - "stage_platform": "linux64-pgo", 05:35:37 INFO - "basedir": "/builds/slave/test-pgo", 05:35:37 INFO - "nightly_build": "True", 05:35:37 INFO - "project": "", 05:35:37 INFO - "platform": "ubuntu64_hw", 05:35:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:35:37 INFO - "slavebuilddir": "test", 05:35:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "branch": "mozilla-central", 05:35:37 INFO - "repo_path": "mozilla-central", 05:35:37 INFO - "pgo_build": "True", 05:35:37 INFO - "builduid": "f4b3eeeb55da4c30af41ec0891dd8451", 05:35:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 05:35:37 INFO - }, 05:35:37 INFO - "sourcestamp": { 05:35:37 INFO - "repository": "", 05:35:37 INFO - "hasPatch": false, 05:35:37 INFO - "project": "", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "changes": [ 05:35:37 INFO - { 05:35:37 INFO - "category": null, 05:35:37 INFO - "files": [ 05:35:37 INFO - { 05:35:37 INFO - "url": null, 05:35:37 INFO - "name": "https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "repository": "", 05:35:37 INFO - "rev": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d", 05:35:37 INFO - "who": "sendchange", 05:35:37 INFO - "when": 1447594458, 05:35:37 INFO - "number": 6663476, 05:35:37 INFO - "comments": "", 05:35:37 INFO - "project": "", 05:35:37 INFO - "at": "Sun 15 Nov 2015 05:34:18", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "revlink": "", 05:35:37 INFO - "properties": [ 05:35:37 INFO - [ 05:35:37 INFO - "buildid", 05:35:37 INFO - "20151115030440", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "builduid", 05:35:37 INFO - "f4b3eeeb55da4c30af41ec0891dd8451", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "nightly_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "pgo_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ] 05:35:37 INFO - ], 05:35:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d" 05:35:37 INFO - } 05:35:37 INFO - } 05:35:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running download-and-extract step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: download_and_extract 05:35:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:35: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')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/test_packages.json 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/test_packages.json 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:35:39 INFO - Downloaded 1302 bytes. 05:35:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:35:39 INFO - Using the following test package requirements: 05:35:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:35:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'jsshell-linux-x86_64.zip'], 05:35:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:35:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:35:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:35:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:35:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:35:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:35: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')]} 05:35:39 INFO - https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:42 INFO - Downloaded 22463758 bytes. 05:35:42 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 05:35:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:42 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 05:35:43 INFO - Return code: 0 05:35:43 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 05:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:43 INFO - https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:44 INFO - Downloaded 22463758 bytes. 05:35: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 05:35:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35: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 05:35:45 INFO - Return code: 0 05:35: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')]} 05:35:45 INFO - https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:46 INFO - Downloaded 11131693 bytes. 05:35: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 05:35:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35: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 05:35:46 INFO - Return code: 0 05:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:46 INFO - https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:35:47 INFO - Downloaded 57137228 bytes. 05:35:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:47 INFO - mkdir: /builds/slave/test-pgo/properties 05:35:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:35:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:35:47 INFO - Contents: 05:35:47 INFO - build_url:https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:47 INFO - Running post-action listener: _resource_record_post_action 05:35:47 INFO - Running post-action listener: set_extra_try_arguments 05:35:47 INFO - ##### 05:35:47 INFO - ##### Running populate-webroot step. 05:35:47 INFO - ##### 05:35:47 INFO - Running pre-action listener: _resource_record_pre_action 05:35:47 INFO - Running main action method: populate_webroot 05:35:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:35:47 INFO - '../fennec_ids.txt'], 05:35:47 INFO - 'tests': ['tcheck2']}, 05:35:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:47 INFO - '--tppagecycles', 05:35:47 INFO - '7'], 05:35:47 INFO - 'tests': ['tsvgm']}}, 05:35:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:47 INFO - 'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:47 INFO - 'tests': ['damp', 'tps']}, 05:35:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:47 INFO - 'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['damp', 'tps']}, 05:35:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:47 INFO - 'other': {'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'other_l64': {'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:47 INFO - 'ts_paint', 05:35:47 INFO - 'tpaint', 05:35:47 INFO - 'sessionrestore', 05:35:47 INFO - 'sessionrestore_no_auto_restore']}, 05:35:47 INFO - 'svgr': {'tests': ['tsvgx', 05:35:47 INFO - 'tsvgr_opacity', 05:35:47 INFO - 'tart', 05:35:47 INFO - 'tscrollx', 05:35:47 INFO - 'cart']}, 05:35:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:47 INFO - 'tests': ['tsvgx', 05:35:48 INFO - 'tsvgr_opacity', 05:35:48 INFO - 'tart', 05:35:48 INFO - 'tscrollx', 05:35:48 INFO - 'cart']}, 05:35:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'tests': ['tp5o']}, 05:35:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s'], 05:35:48 INFO - 'tests': ['tp5o']}, 05:35:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--xperf_path', 05:35:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:48 INFO - 'tests': ['tp5n']}, 05:35:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:48 INFO - 'talos_options': ['--e10s', 05:35:48 INFO - '--xperf_path', 05:35:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:48 INFO - 'tests': ['tp5n']}}, 05:35:48 INFO - 'talos.zip': {'path': '', 05:35:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:48 INFO - Running post-action listener: _resource_record_post_action 05:35:48 INFO - ##### 05:35:48 INFO - ##### Running create-virtualenv step. 05:35:48 INFO - ##### 05:35:48 INFO - Running pre-action listener: _resource_record_pre_action 05:35:48 INFO - Running main action method: create_virtualenv 05:35:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:35: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 05:35:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:35:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:48 INFO - Using real prefix '/usr' 05:35:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:35:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:50 INFO - Installing pip.................done. 05:35:50 INFO - Return code: 0 05:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:35: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')]} 05:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:35: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 05:35: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 05:35:50 INFO - Using env: {'DISPLAY': ':0', 05:35:50 INFO - 'HOME': '/home/cltbld', 05:35:50 INFO - 'LANG': 'en_US.UTF-8', 05:35:50 INFO - 'LANGUAGE': 'en_US:en', 05:35:50 INFO - 'LOGNAME': 'cltbld', 05:35:50 INFO - 'MAIL': '/var/mail/cltbld', 05:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:50 INFO - 'MOZ_NO_REMOTE': '1', 05:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:50 INFO - 'NO_EM_RESTART': '1', 05:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:50 INFO - 'SHELL': '/bin/bash', 05:35:50 INFO - 'SHLVL': '1', 05:35:50 INFO - 'TERM': 'linux', 05:35:50 INFO - 'TMOUT': '86400', 05:35:50 INFO - 'USER': 'cltbld', 05:35:50 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:50 INFO - '_': '/tools/buildbot/bin/python'} 05:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:50 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 05:35:50 INFO - Cleaning up... 05:35:50 INFO - Return code: 0 05:35:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:35: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')]} 05:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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', '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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:35: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:35: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 psutil>=0.7.1 05:35:50 INFO - Using env: {'DISPLAY': ':0', 05:35:50 INFO - 'HOME': '/home/cltbld', 05:35:50 INFO - 'LANG': 'en_US.UTF-8', 05:35:50 INFO - 'LANGUAGE': 'en_US:en', 05:35:50 INFO - 'LOGNAME': 'cltbld', 05:35:50 INFO - 'MAIL': '/var/mail/cltbld', 05:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:50 INFO - 'MOZ_NO_REMOTE': '1', 05:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:50 INFO - 'NO_EM_RESTART': '1', 05:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:50 INFO - 'SHELL': '/bin/bash', 05:35:50 INFO - 'SHLVL': '1', 05:35:50 INFO - 'TERM': 'linux', 05:35:50 INFO - 'TMOUT': '86400', 05:35:50 INFO - 'USER': 'cltbld', 05:35:50 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:50 INFO - '_': '/tools/buildbot/bin/python'} 05:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:51 INFO - Downloading/unpacking psutil>=0.7.1 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:35:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:35:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:52 INFO - Installing collected packages: psutil 05:35:52 INFO - Running setup.py install for psutil 05:35:52 INFO - building 'psutil._psutil_linux' extension 05:35:52 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 05:35: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 05:35:53 INFO - building 'psutil._psutil_posix' extension 05:35: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 05:35: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 05:35:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:53 INFO - Successfully installed psutil 05:35:53 INFO - Cleaning up... 05:35:53 INFO - Return code: 0 05:35:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:35: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')]} 05:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:35: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 05:35: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 05:35:53 INFO - Using env: {'DISPLAY': ':0', 05:35:53 INFO - 'HOME': '/home/cltbld', 05:35:53 INFO - 'LANG': 'en_US.UTF-8', 05:35:53 INFO - 'LANGUAGE': 'en_US:en', 05:35:53 INFO - 'LOGNAME': 'cltbld', 05:35:53 INFO - 'MAIL': '/var/mail/cltbld', 05:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:53 INFO - 'MOZ_NO_REMOTE': '1', 05:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:53 INFO - 'NO_EM_RESTART': '1', 05:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:53 INFO - 'SHELL': '/bin/bash', 05:35:53 INFO - 'SHLVL': '1', 05:35:53 INFO - 'TERM': 'linux', 05:35:53 INFO - 'TMOUT': '86400', 05:35:53 INFO - 'USER': 'cltbld', 05:35:53 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:53 INFO - '_': '/tools/buildbot/bin/python'} 05:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:35:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:35:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35: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) 05:35:55 INFO - Installing collected packages: mozsystemmonitor 05:35:55 INFO - Running setup.py install for mozsystemmonitor 05:35:55 INFO - Successfully installed mozsystemmonitor 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:35: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')]} 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:35: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 05:35: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 05:35:55 INFO - Using env: {'DISPLAY': ':0', 05:35:55 INFO - 'HOME': '/home/cltbld', 05:35:55 INFO - 'LANG': 'en_US.UTF-8', 05:35:55 INFO - 'LANGUAGE': 'en_US:en', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MAIL': '/var/mail/cltbld', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SHLVL': '1', 05:35:55 INFO - 'TERM': 'linux', 05:35:55 INFO - 'TMOUT': '86400', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:35:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:35:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:35:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:58 INFO - Downloading docopt-0.6.1.tar.gz 05:35:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:35:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:58 INFO - Running setup.py install for blobuploader 05:35:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:35:58 INFO - Running setup.py install for requests 05:35:58 INFO - Running setup.py install for docopt 05:35:58 INFO - Successfully installed blobuploader requests docopt 05:35:58 INFO - Cleaning up... 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:35: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')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:35: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 05:35: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 05:35:58 INFO - Using env: {'DISPLAY': ':0', 05:35:58 INFO - 'HOME': '/home/cltbld', 05:35:58 INFO - 'LANG': 'en_US.UTF-8', 05:35:58 INFO - 'LANGUAGE': 'en_US:en', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MAIL': '/var/mail/cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SHLVL': '1', 05:35:58 INFO - 'TERM': 'linux', 05:35:58 INFO - 'TMOUT': '86400', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - '_': '/tools/buildbot/bin/python'} 05:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:59 INFO - Running setup.py (path:/tmp/pip-VVrjCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:59 INFO - Running setup.py (path:/tmp/pip-Lm0atg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:59 INFO - Running setup.py (path:/tmp/pip-YM6TjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:59 INFO - Running setup.py (path:/tmp/pip-DW2fTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:59 INFO - Running setup.py (path:/tmp/pip-AAAyA6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:59 INFO - Running setup.py (path:/tmp/pip-fhaFCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:59 INFO - Running setup.py (path:/tmp/pip-xMGcG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:59 INFO - Running setup.py (path:/tmp/pip-qSMIGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:59 INFO - Running setup.py (path:/tmp/pip-t_7lAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:59 INFO - Running setup.py (path:/tmp/pip-N4e1nI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:59 INFO - Running setup.py (path:/tmp/pip-Ln8J2S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:59 INFO - Running setup.py (path:/tmp/pip-GjYXuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:35:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:35:59 INFO - Running setup.py (path:/tmp/pip-YU6TwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:00 INFO - Running setup.py (path:/tmp/pip-Nb4feo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:00 INFO - Running setup.py (path:/tmp/pip-elfX9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:00 INFO - Running setup.py (path:/tmp/pip-z7_eg0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:00 INFO - Running setup.py (path:/tmp/pip-jqPPJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:00 INFO - Running setup.py install for manifestparser 05:36:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:36:00 INFO - Running setup.py install for mozcrash 05:36:00 INFO - Running setup.py install for mozdebug 05:36:00 INFO - Running setup.py install for mozdevice 05:36:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:36:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:36:00 INFO - Running setup.py install for mozfile 05:36:00 INFO - Running setup.py install for mozhttpd 05:36:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:36:00 INFO - Running setup.py install for mozinfo 05:36:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for mozInstall 05:36:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for mozleak 05:36:01 INFO - Running setup.py install for mozlog 05:36:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for moznetwork 05:36:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for mozprocess 05:36:01 INFO - Running setup.py install for mozprofile 05:36:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for mozrunner 05:36:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:36:01 INFO - Running setup.py install for mozscreenshot 05:36:01 INFO - Running setup.py install for moztest 05:36:01 INFO - Running setup.py install for mozversion 05:36:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:36:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:02 INFO - Cleaning up... 05:36:02 INFO - Return code: 0 05:36:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:36: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 05:36: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 05:36:02 INFO - Using env: {'DISPLAY': ':0', 05:36:02 INFO - 'HOME': '/home/cltbld', 05:36:02 INFO - 'LANG': 'en_US.UTF-8', 05:36:02 INFO - 'LANGUAGE': 'en_US:en', 05:36:02 INFO - 'LOGNAME': 'cltbld', 05:36:02 INFO - 'MAIL': '/var/mail/cltbld', 05:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:02 INFO - 'MOZ_NO_REMOTE': '1', 05:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:02 INFO - 'NO_EM_RESTART': '1', 05:36:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:02 INFO - 'SHELL': '/bin/bash', 05:36:02 INFO - 'SHLVL': '1', 05:36:02 INFO - 'TERM': 'linux', 05:36:02 INFO - 'TMOUT': '86400', 05:36:02 INFO - 'USER': 'cltbld', 05:36:02 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:02 INFO - '_': '/tools/buildbot/bin/python'} 05:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:02 INFO - Running setup.py (path:/tmp/pip-gcHSrq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:02 INFO - Running setup.py (path:/tmp/pip-cITFAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:02 INFO - Running setup.py (path:/tmp/pip-n3aPH3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:02 INFO - Running setup.py (path:/tmp/pip-Dxevvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:02 INFO - Running setup.py (path:/tmp/pip-b70BBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:02 INFO - Running setup.py (path:/tmp/pip-cDluhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:02 INFO - Running setup.py (path:/tmp/pip-sEhvMG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:02 INFO - Running setup.py (path:/tmp/pip-VroF5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36: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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:02 INFO - Running setup.py (path:/tmp/pip-jbbchw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:02 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)) 05:36:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:02 INFO - Running setup.py (path:/tmp/pip-7MEFXh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:03 INFO - Running setup.py (path:/tmp/pip-VGhvjt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:03 INFO - Running setup.py (path:/tmp/pip-yVcvzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:03 INFO - Running setup.py (path:/tmp/pip-9XiDzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:03 INFO - Running setup.py (path:/tmp/pip-YbfnHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:03 INFO - Running setup.py (path:/tmp/pip-eFywLf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:03 INFO - Running setup.py (path:/tmp/pip-vO2B0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36: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)) 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:03 INFO - Running setup.py (path:/tmp/pip-md7tva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:05 INFO - Downloading blessings-1.5.1.tar.gz 05:36: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 05:36:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:05 INFO - Installing collected packages: blessings 05:36:05 INFO - Running setup.py install for blessings 05:36:05 INFO - Successfully installed blessings 05:36:05 INFO - Cleaning up... 05:36:05 INFO - Return code: 0 05:36:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:36:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:05 INFO - Reading from file tmpfile_stdout 05:36:05 INFO - Current package versions: 05:36:05 INFO - argparse == 1.2.1 05:36:05 INFO - blessings == 1.5.1 05:36:05 INFO - blobuploader == 1.2.4 05:36:05 INFO - docopt == 0.6.1 05:36:05 INFO - manifestparser == 1.1 05:36:05 INFO - mozInstall == 1.12 05:36:05 INFO - mozcrash == 0.16 05:36:05 INFO - mozdebug == 0.1 05:36:05 INFO - mozdevice == 0.47 05:36:05 INFO - mozfile == 1.2 05:36:05 INFO - mozhttpd == 0.7 05:36:05 INFO - mozinfo == 0.9 05:36:05 INFO - mozleak == 0.1 05:36:05 INFO - mozlog == 3.0 05:36:05 INFO - moznetwork == 0.27 05:36:05 INFO - mozprocess == 0.22 05:36:05 INFO - mozprofile == 0.27 05:36:05 INFO - mozrunner == 6.11 05:36:05 INFO - mozscreenshot == 0.1 05:36:05 INFO - mozsystemmonitor == 0.0 05:36:05 INFO - moztest == 0.7 05:36:05 INFO - mozversion == 1.4 05:36:05 INFO - psutil == 3.1.1 05:36:05 INFO - requests == 1.2.3 05:36:05 INFO - wsgiref == 0.1.2 05:36:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36: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')]} 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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 0x7f893d9d8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf003d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, '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': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', '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 05:36: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 05:36: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 05:36:05 INFO - Using env: {'DISPLAY': ':0', 05:36:05 INFO - 'HOME': '/home/cltbld', 05:36:05 INFO - 'LANG': 'en_US.UTF-8', 05:36:05 INFO - 'LANGUAGE': 'en_US:en', 05:36:05 INFO - 'LOGNAME': 'cltbld', 05:36:05 INFO - 'MAIL': '/var/mail/cltbld', 05:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:05 INFO - 'MOZ_NO_REMOTE': '1', 05:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:05 INFO - 'NO_EM_RESTART': '1', 05:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:05 INFO - 'SHELL': '/bin/bash', 05:36:05 INFO - 'SHLVL': '1', 05:36:05 INFO - 'TERM': 'linux', 05:36:05 INFO - 'TMOUT': '86400', 05:36:05 INFO - 'USER': 'cltbld', 05:36:05 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:05 INFO - '_': '/tools/buildbot/bin/python'} 05:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36: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)) 05:36:05 INFO - Cleaning up... 05:36:05 INFO - Return code: 0 05:36:05 INFO - Running post-action listener: _resource_record_post_action 05:36:05 INFO - Running post-action listener: _start_resource_monitoring 05:36:05 INFO - Starting resource monitoring. 05:36:05 INFO - ##### 05:36:05 INFO - ##### Running install step. 05:36:05 INFO - ##### 05:36:05 INFO - Running pre-action listener: _resource_record_pre_action 05:36:05 INFO - Running main action method: install 05:36:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:06 INFO - Reading from file tmpfile_stdout 05:36:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:36:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:36:06 INFO - Reading from file tmpfile_stdout 05:36:06 INFO - Output received: 05:36:06 INFO - Usage: mozinstall [options] installer 05:36:06 INFO - Options: 05:36:06 INFO - -h, --help show this help message and exit 05:36:06 INFO - -d DEST, --destination=DEST 05:36:06 INFO - Directory to install application into. [default: 05:36:06 INFO - "/builds/slave/test-pgo"] 05:36:06 INFO - --app=APP Application being installed. [default: firefox] 05:36:06 INFO - mkdir: /builds/slave/test-pgo/build/application 05:36: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'] 05:36: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 05:36:20 INFO - Reading from file tmpfile_stdout 05:36:20 INFO - Output received: 05:36:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:36:20 INFO - Running post-action listener: _resource_record_post_action 05:36:20 INFO - ##### 05:36:20 INFO - ##### Running run-tests step. 05:36:20 INFO - ##### 05:36:20 INFO - Running pre-action listener: _resource_record_pre_action 05:36:20 INFO - Running main action method: run_tests 05:36:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:36:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:36:20 INFO - Python 2.7.3 05:36:20 INFO - Return code: 0 05:36:20 INFO - grabbing minidump binary from tooltool 05:36: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')]} 05:36: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 0xf898c0>, '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 0xf36420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf368b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:36: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 05:36: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 05:36:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:20 INFO - Return code: 0 05:36:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:36:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:36:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:36:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:36: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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 05:36:20 INFO - Using env: {'DISPLAY': ':0', 05:36:20 INFO - 'HOME': '/home/cltbld', 05:36:20 INFO - 'LANG': 'en_US.UTF-8', 05:36:20 INFO - 'LANGUAGE': 'en_US:en', 05:36:20 INFO - 'LOGNAME': 'cltbld', 05:36:20 INFO - 'MAIL': '/var/mail/cltbld', 05:36:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:20 INFO - 'MOZ_NO_REMOTE': '1', 05:36:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:20 INFO - 'NO_EM_RESTART': '1', 05:36:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:36:20 INFO - 'SHELL': '/bin/bash', 05:36:20 INFO - 'SHLVL': '1', 05:36:20 INFO - 'TERM': 'linux', 05:36:20 INFO - 'TMOUT': '86400', 05:36:20 INFO - 'USER': 'cltbld', 05:36:20 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073', 05:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:20 INFO - '_': '/tools/buildbot/bin/python'} 05:36: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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 05:36:21 INFO - mozversion INFO | application_buildid: 20151115030440 05:36:21 INFO - mozversion INFO | application_changeset: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d 05:36:21 INFO - mozversion INFO | application_display_name: Nightly 05:36:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:21 INFO - mozversion INFO | application_name: Firefox 05:36:21 INFO - mozversion INFO | application_remotingname: firefox 05:36:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:36:21 INFO - mozversion INFO | application_vendor: Mozilla 05:36:21 INFO - mozversion INFO | application_version: 45.0a1 05:36:21 INFO - mozversion INFO | platform_buildid: 20151115030440 05:36:21 INFO - mozversion INFO | platform_changeset: 51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d 05:36:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:36:21 INFO - mozversion INFO | platform_version: 45.0a1 05:36:21 INFO - 2015-11-15 05:36:21,388 DEBUG : using testdate: 1447594581 05:36:21 INFO - 2015-11-15 05:36:21,388 DEBUG : actual date: 1447594581 05:36:21 INFO - 2015-11-15 05:36:21,395 INFO : starting webserver on 'localhost:53958' 05:36:21 INFO - 2015-11-15 05:36:21,396 INFO : Starting test suite talos-linux64-ix-036.e 05:36:21 INFO - 2015-11-15 05:36:21,396 INFO : Starting test dromaeo_css 05:36:21 INFO - 2015-11-15 05:36:21,396 DEBUG : operating with platform_type : linux_ 05:36:22 INFO - 2015-11-15 05:36:22,582 INFO : Initialising browser for dromaeo_css test... 05:36:22 INFO - 2015-11-15 05:36:22,592 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDlS8Bo/profile http://localhost:53958/getInfo.html 05:36:27 INFO - 2015-11-15 05:36:27,832 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:27 INFO - 2015-11-15 05:36:27,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:27 INFO - 2015-11-15 05:36:27,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:36:27 INFO - 2015-11-15 05:36:27,832 DEBUG : BROWSER_OUTPUT: __metrics 05:36:28 INFO - 2015-11-15 05:36:28,995 INFO : Browser initialized. 05:36:28 INFO - 2015-11-15 05:36:28,996 INFO : Running cycle 1/1 for dromaeo_css test... 05:36:28 INFO - 2015-11-15 05:36:28,996 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDlS8Bo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:36:40 INFO - 2015-11-15 05:36:40,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 141467648 05:36:40 INFO - 2015-11-15 05:36:40,800 DEBUG : BROWSER_OUTPUT: 05:37:30 INFO - 2015-11-15 05:37:30,436 DEBUG : BROWSER_OUTPUT: 1447594650432 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] 05:39:39 INFO - 2015-11-15 05:39:39,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53958/tests/dromaeo/cssquery-ext.html) 05:39:40 INFO - 2015-11-15 05:39:40,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 146104320 05:39:40 INFO - 2015-11-15 05:39:40,535 DEBUG : BROWSER_OUTPUT: 05:42:42 INFO - 2015-11-15 05:42:42,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-ext.html (next: http://localhost:53958/tests/dromaeo/cssquery-jquery.html) 05:42:43 INFO - 2015-11-15 05:42:43,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 05:42:43 INFO - 2015-11-15 05:42:43,029 DEBUG : BROWSER_OUTPUT: 05:45:44 INFO - 2015-11-15 05:45:44,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53958/tests/dromaeo/cssquery-mootools.html) 05:45:45 INFO - 2015-11-15 05:45:45,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 05:45:45 INFO - 2015-11-15 05:45:45,331 DEBUG : BROWSER_OUTPUT: 05:48:46 INFO - 2015-11-15 05:48:46,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53958/tests/dromaeo/cssquery-prototype.html) 05:48:47 INFO - 2015-11-15 05:48:47,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 140111872 05:48:47 INFO - 2015-11-15 05:48:47,585 DEBUG : BROWSER_OUTPUT: 05:51:49 INFO - 2015-11-15 05:51:49,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53958/tests/dromaeo/cssquery-yui.html) 05:51:50 INFO - 2015-11-15 05:51:50,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 141733888 05:51:50 INFO - 2015-11-15 05:51:50,559 DEBUG : BROWSER_OUTPUT: 05:54:52 INFO - 2015-11-15 05:54:52,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/dromaeo/cssquery-yui.html (next: http://localhost:53958/tests/dromaeo/cssquery-dojo.html) 05:54:53 INFO - 2015-11-15 05:54:53,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 144117760 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:54:53 INFO - 2015-11-15 05:54:53,027 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3242.4812030075186;3279.573655424796;3310.7847989880656;3312.022953228797;3318.8506517206724;5497.642653227537;5532.889342213153;5536.086545719952;5587.888242235158;5588.497035266831;5610.158476228567;5637.238972738679;5688.573356998221;5708.229389032479;5716.914246286298;4961.007798440309;5039.269305950635;5126.359205099363;5151.613628977823;5151.74241287936;5200.7399630018535;5217.530422261995;5250.028744682227;5261.289725886994;5285.656432331905;4968.850934471971;5084.211947148198;5161.638685292031;5189.403218629868;5245.606579506552;4998.150314446553;5081.79672813087;5082.3138876251605;5093.974530127362;5101.846944591668;5088.0332736780265;5091.745412729349;5098.515641014098;5150.845474635767;5155.53600175986;5191.091558977164;5397.730113494349;5434.864128396782;5451.727413629303;5483.643563168382;5954.583179177459;5955.464008239236;5986.281646202484;6002.2197114375285;6068.6662233577135;6079.544034197453;6094.8781024379705;6095.908561371583;6099.054646529795;6105.694715264219;5462.6995515246645;5556.527695145958;5557.888842223214;5659.122835960392;5669.489745922846;6147.508199344042;6153.261608606996;6164.167837341991;6174.876502470015;6186;5965.910511342333;5969.522438204933;5972.134040564094;5980.43185897339;6017.06735456005;5737.426257374313;5877;5890;6012.278526576839;6073.423024812636;6053.697315134225;6079.08813677943;6082.726277317532;6087.36082711309;6091.7563297467605;6078.45293923549;6079.088136779518;6080;6082.361352058058;6094.908576371358;4427.402300689366;4514.367988481616;4546.1135078659345;4611.1930412177735;4638.0955713636195;4087.5094988600963;4090.0592863641527;4126.195391898551;4130.008797888545;4163.02168990287;5616.634918730269;5776.855578610568;5780.624259423124;5804.158397032406;5834.824955251349;5918.46733793952;5993.101034844808;6082.482988945989;6095.664738439428;6111.694415279308;5735.942640573624;5750.741216645261;5756.884862302731;5763.308402991668;5765.3369862465515;5160.432352441228;5175.249588809602;5179.715115668599;5183.248428977777;5220.843374698765;6104.725287362079;6155.599886007395;6179.721912513947;6271.905921411182;6297.874042519124;6091.847703807441;6100.511959043355;6147.538934579835;6154.569180157346;6161.84595385119;6346.492280617632;6349.238091429058;6354.841128971812;6362.809115726535;6373.6175829450385;5716.314042314949;5841.32824725145;5897.9115313271195;6004.099385092271;6039;6063.333033366238;6063.969680151571;6143.170671959407;6156;6169.136320915165;5804;5930.644161350333;5950.137230101524;5986.820395388146;5993.430624090704;5796.1305804129715;5807.186993820953;5831.1253312001845;5833.708314584339;5838.416158384128;5810.564207684525;5855.970720146372;5867.119932010232;5880.26496687914;5898.233229680114;5953;5965.28416590012;5972.761089556369;5983.551233657406;6004.339522652592;5612.186232996274;5731.8567035824435;5764.798232061858;5836.620619659709;5893.086571581412 05:54:53 INFO - 2015-11-15 05:54:53,028 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.5792602699672;579.1544345255926;599.149208124463;613.2977740487145;613.9048447490635;37634;38201.61798382016;38610;38652.613473865254;38678.61321386785;42083;42647.78676106623;42841.78579107108;43094.784526077325;43189.54483641309;8735.432196907197;8849.115088491164;8854.690085846996;8875.289976801872;8879.467231966071;8655.17775811297;8758.649654013832;8763.649454021832;8767.167119123673;8772;8764.123587641248;8767.56162191891;8833.55832208387;8837.425567338103;8839;8766.386352955296;8832.425892316978;8835;8861.556922153932;8893.199612034949;8656.913430865674;8753.7811554711;8776.297896168291;8788.956055219747;8801.735947921572;40688.13462721037;40941.38587921183;41392.1721565567;41401;41462.585374146474;3139.670334614855;3379.053864917827;3437.6218615952225;3457.014750796011;3990.04238982645;28938.27654308659;29232.70767292321;29622.85188574065;29843.403131937455;29912.55131173034;2929.6630887448005;3001.9399612007637;3005.128512731327;3046.6039414875922;3135.216195951012;272436.6378168116;273281;275031;275098;275584;41578;41850.37224441575;41988.37017444741;42155.789221053696;42182.578174217866;41427;41442;41622.91885405718;41635.7918210407;41736.66106711456;11981.520739170335;12017.459214335377;12085.516579336903;12125.39373031345;12128.757424851454;9547.42715437076;9576.47329396876;9610.279229057849;9641.325107242566;9853.802923941481;14279.500217492337;14314.212718300594;14344.56966291013;14378.424863005363;14487;5812.651240925558;5832.679202643895;5904.6714489239575;5909.113632955091;6005.879882402328;937.128470522407;941.1576638908139;970.1559643110539;983.7786498037884;1027.019196667181;29167.854160729486;32563.51154732681;33306.167345816066;33629.83185084059;33759.493607595905;1001.3191030099457;1007.0734923870057;1034.255336157965;1042.3329069395593;1096.2326371539955;14659.853401466062;15052.849471505364;15085.3211605478;15211.61970950713;15306.464273750365;388261;388696;393196;395157;396211;54062.45937540653;54226;54441.72779136079;54488;54570.72714636481;1255.460152134591;1272.2620879889641;1278.9168704034394;1313.5796545105475;1340.0619566303626;28163.155105346872;28897.711022889504;28948.6704081481;29016;29221.41557168887;45715.31427028664;46209.537904621866;46431.07137857156;46543.767281164735;46621.76689116532;299642;299660;300456;301738.9130543508;302374;32381.19047023843;45776.54223457723;46037.30944035775;46178;46965.76517117392;44329.77835110804;44356.556434435246;44940.10119797651;44982;45336.54663453455;36723.44914826333;36809.81595092115;40002.799986001046;42307.576924231595;42866.78566607147;37138;37427.81286093552;38256.61743382642;38408.423873642474;38430.6156938427;37218;37361.62638373581;37374.439383409815;37591;38512;31349.946430696942;33265.501017484276;33928;34161.82919085389;34579.4813077799;23806.88096559506;23926.52146957086;24001.879990599937;24068.638970415108;24083.75916240815 05:54:53 INFO - 2015-11-15 05:54:53,029 DEBUG : BROWSER_OUTPUT: |2;jquery.html;350.4970367522605;352.3569485688618;355.8950109717633;355.91102224443887;358.52853497650585;12359.752804943895;12910.096293259476;16544;16981.405650802226;17641.117944102793;10855.565777368916;10906.61826836061;10953.123750099992;10959.287646303004;11033.558657653684;4004.2191772604356;4734.715917044971;4742.3123647071325;4773.403324584409;4777.952220477786;4650.302454631798;4689.155951928651;4747.548982846624;4749.358836557072;4758.1673207188605;4669.579737823595;4705.200115980291;4712.528747125294;4891.046245982035;5056.494350564951;4992.051510213066;5003.874903127415;5011.298418221434;5011.523905228997;5027.748612569375;4141.7100802943805;4220.683448741357;4334.566543345672;4341.06667066579;4351.8694439166875;13992.720145597032;14090.225037622926;14250.714985700228;14267.714645707132;14303.78544321836;1994.6210220058142;2027.3005812994493;2038.4801875521648;2048.3957232616267;2092.801183887528;9846.507674616241;9926.553305101288;9945.00549945007;10020.549075291628;10175.389476631426;1663.2265996311774;1669.4323929863783;1685.7134287171211;1709.333359989605;1733.9596242254547;55426.72286638581;55804;56776.716116419564;60476.39523604796;62267.37732622661;7083.256258092826;7108.68010939509;7142.035825163536;7165.713371465187;7200.963995179991;8441.493510389397;8447.873281900776;8466.534340611202;8479.745607631781;8527.829443411221;5374.731263436813;5426.728663566806;5434.375046869582;5442.8911421771345;5443.727813609304;5477.890442191134;5481;5510.862228444321;5511.421300763443;5549.916751248654;3357.462805951036;3374.4769560718128;3386.644402337719;3403.6426175251736;3405.2338223899424;1115.475726408603;1176.6587689569928;1187.2994932989577;1188.085174415695;1222.7860124478182;402.794574766871;419.90762032352836;425.2091110534404;476.74732391832384;521.1635325302834;10094.747631309276;11013.28796543847;11186.552537898555;11214.32714037144;11220.158488113424;445.6902452795341;451.4334510189691;453.4218870939512;457.636179237507;472.71164589601005;5796.797112101056;5916.822495325147;5971.19388882504;5975.910361344583;6136.018237082135;536134;543691;545807;560715;563926;79512;79529;80145;80301;80619.59690201629;444.44444444444446;447.3022085546558;447.7089891570505;447.92385294500014;449.12196655538344;9584.37701549397;9591.376560523544;9773.315867889463;9949.602015919281;9961.203103751828;37353.62646373502;37497.62502374942;37512;37832;37890.621093789814;48113;48637.5136248633;48871;49786.75106624444;50406.49593504165;6686.665666716742;6943.305669433218;6947.44420446353;6970.616616086164;7023.473239506955;12196.939015304866;12261.325627090595;12317.706640802588;12425.502979880703;12606.55877044299;10712;10966.396848173426;11040.061594764535;11062.22564420483;11079.390633515233;10634;10658.946705266735;10698.946505267424;10892.782144357227;11091.168162387692;10979.61571345031;11131.721706957067;11227;11325.093992480746;11327.904337697551;6880.449564034765;7069.646517673993;7084.504084714021;7102.680379382837;7102.680379383043;11128.721781955192;11170.329780213213;11461;11463.598774042868;11523.654290371302 05:54:53 INFO - 2015-11-15 05:54:53,030 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1510.6147932277268;1713.3831820544603;1763.567925858165;1775.698131317676;1786.2408476397527;6454.870902581945;6560.311167327433;6564.770233041839;7875.684972601103;7986.121526632066;7995.920040799605;8021.799455013627;8038.115807261212;8054.597270136484;8057.637406316715;2267.557826223891;2293.3463962770616;2296.1619009061656;2302.240260713969;2304.2280835919987;2260.672202530632;2314.0743702519044;2321.303608917318;2324.5234726881035;2342.379269493577;2244.517428752818;2289.839711220215;2307.596170670126;2308.7922087012166;2321.767823217673;2247.5617254635354;2334.5447637710654;2363.586372384843;2369.087901158049;2370.348154257584;2315.513742114158;2347.9530409391887;2352.7294361148515;2353.576356255873;2354.85870847748;7734.110577283628;7791.532508049535;7806.06327240729;7844.843103137905;7866.567338796364;4488.955110448886;4539.659525535565;4559.589636932659;4570.040291538781;4575.130725162208;2989.805662631922;3050.816950982948;3134.4044631520164;3136.4511210538294;3139.623245210589;874.4884242718017;875.0330884372804;900.2392977933636;926.3145272498302;966.6085235479642;10678.092362149227;10772;10788.352698838016;10796.5681372745;10891.183161262938;4127.876163715094;4189.601987811153;4205.1589682063095;4242.109157076987;4254.808533615995;8698.956505217433;8707.259882910024;8711.738647840575;8711.869321960176;8713.738587842376;4425.35832304314;4427.070315233773;4434.534373890695;4447.866564003085;4460.553944605514;4056.371262454324;4059.2287465381482;4067.389891516237;4072.511298644182;4100.2414553307135;3312.6521715220038;3338.165458635341;3365.6466071062678;3365.899023029313;3366.4108780963234;1081.221520505235;1125.139268459629;1126.8704099028553;1138.1407037686658;1148.8276758486295;1055.6621880998161;1068.1988508618535;1076.0315715855793;1247.2204871955028;1367.1865240182076;7345.485815992936;7351.191368949411;7473.177950425449;7474.925250747423;7480.401567874557;1009.9495025248708;1019.4494972714651;1121.6803211084964;1130.2370899642708;1139.8233273842568;5706.914396284059;5720.542356611461;5750.30996280449;5791.189233507313;5809.477147056785;9045.638174473079;9144.588493517675;9296.581653825595;9323.440593564272;9458.621655133855;9240.537973101318;9254.167124958785;9303.76740581491;9304.441733496013;9350.859737103949;7042.521070575237;7181.245969173266;7191.101112360955;7248.347648711641;7341;7175.820604484929;7201.891971620535;7215.134183897966;7239.348458638748;7272.709091636275;8149.959250203711;8206.58967051657;8217.83564328722;8239.258466738022;8251.628676709443;8420.95789521073;8464.534450605275;8468.153184681483;8517.659293628434;8622.78443038929;6486.837829054311;6928.272531384132;6943.340382663639;6962.651867406711;7021.297870212938;7446.664900079401;7572.734954276574;7597.164311925573;7598.924010759822;7619.504732192389;6487;7057.294270573107;7107.609081500567;7165.7850264492145;7285.307895749896;6622.867542649216;6713.697883595348;6755.93244067553;6772.525923185527;6829.282925292773;6646.102776125162;6808.625525595941;6810.523263371715;6823.078884350549;6838.897416538656;6072.392760723892;6073.271207455134;6073.969630151821;6077.392260773887;6085.756569737161;6273.090401891792;6288.465480434032;6328.177336946167;6577.506686998398;6722.260551339251 05:54:53 INFO - 2015-11-15 05:54:53,031 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.7079493058782;333.8430937459394;335.4783311949917;340.2327750921671;341.34461833280113;6309.716062777175;6415.45468635166;6465.741370345192;6471.0940468334475;6498.285188629253;6127;6364.840878978028;6364.886144924642;6364.904526432096;6403.903941440882;4823.083614113325;4836.274558816171;4842.443119041302;4848.127337079342;4851.417829860422;4845.878853028667;4848.830290939818;4851.175300198975;4860.4896485869;4866.026794641069;4718.363020992157;4788.521147885219;4806.182948898678;4807.711537307755;4818.518148185189;4769;4770;4772.2125849234835;4787.0904528139545;4793.544613261734;4149.087200815846;4159.9792001039805;4166.062635906927;4177.248095342837;4187.036981494243;5929.614575052651;5949.46454819064;5968;5977.551683623746;5980.671063091529;5337.199420086979;5489.231507588941;5494.43408628539;5498.477644623755;5503.2020357048;6654.534182607219;6662.400383965466;6699.162604674416;6699.464042876558;6709.731610735565;4465.732056076646;4466.3523789050405;4473.261911784552;4475.865724028285;4490.3488994096;6747.291534388867;6928.861422771516;6973.930260697379;7024;7047.506674532785;4678.064387122589;4694.929576056362;4695.436547614308;4696.788644511005;4699.741514216683;4758.666893317504;4767.713937163712;4768.7615619218905;4770.189067858472;4776.832810851603;5531.612787104864;5556.944430555724;5577.888442231214;5587.44125587438;5592.5805564582815;6592.934070659232;6852.143482064742;6862.416694580917;6863.313668633196;6872.62200578973;1661.7008938391205;1699.5836020175136;1750.5536088297404;1750.8861923975155;1752.7809023872016;1163.552032467506;1167.3637867362138;1178.6817559258952;1184.4788293150987;1184.6979020349756;6415.1981002374705;6470.838229044311;6478.838029049311;6485.805425837232;6490.707918143695;6899.103116594811;6899.758508452281;6941.514094013472;6943.062686537354;6943.583384996917;6449.129367535416;6456.51576131792;6462.870742585216;6469.902951455638;6469.967650161719;3832.6742226911024;3836.3286424875537;3866.3427217373114;3868.516435445569;3869.845206191721;7335.816604584928;7340.816479588053;7378.926210737824;7381.630918454163;7403.2226616204525;6937.167539895245;7134.8929766052515;7138.464615153885;7153.785386438415;7177.641117944082;7305;7321.926780732125;7364.9689043533945;7366.815829604303;7378.446616503784;7039.1553013638695;7047;7048.612326322102;7053.435725142079;7056.364927156581;6844.555103918229;6959;6968.616726080114;7004.789856304319;7065.328793764585;7394.741184058532;7402.111746590228;7404.814879628052;7416.555006699616;7441.218672039575;4650.302454631832;4677.041206552581;4678.69588476748;4697.859064228079;4704.50602686713;6916.51584389108;6955.8608827822145;7113.857722845618;7145.249748776304;7164.534305270141;6909.965450172717;6922.723091076301;6937.063496427918;6956.965215173892;6967.96516017437;6819.727210911508;6851.8972215415815;6907.378335949788;6909.412699920362;6923.688434020381;6626.53614246998;6711.496637752286;6747.662616869039;6765.8985115224295;6775.4240889524945;6936.895946560705;6936.930630693629;6956.095707557985;6964.721411143498;6967.54710943787;6727.226368967631;6737.865242695217;6756.493263005196;6781.2879647638265;6788.321167883172 05:54:53 INFO - 2015-11-15 05:54:53,032 DEBUG : BROWSER_OUTPUT: |5;yui.html;772.8956590860233;836.2390224895346;843.7721815109925;868.3617541107282;888.75114967809;13465;13557.389917453738;13670.316484175777;13849.446022159114;13899.652508687288;13526.93236533816;13692.315384230798;13808.102473339226;13854.653633659163;14300.71398572028;810.14934318965;838.421489172469;839.7396806989852;840.0465471689646;840.2227939156256;817.668844118133;825.9752207433756;829.2122483640535;831.501099340397;832.1719888710742;856.7900864288258;863.8358711844729;871.4727589808169;871.7428358634187;872.084311472954;864.7492227254089;865.4590880699562;866.1598249697784;866.7356456280863;869.0180096490957;626.1609443345939;628.6793735195038;633.0535848905869;633.7940169444903;633.9492840572743;12759.170653907466;12779;12926.224426534343;13010.089293749441;13022.893054090413;11191;11217.775644487147;11300.660980170607;11553.595624153115;11638.243514171552;10106.545205465773;10223.693289201336;10275.588976440933;10289.073983341535;10482.58069677212;3372.15696075981;3385.4752513360468;3548.8048157351336;3587.1032241939515;3613.1509095362567;44110.77944610256;45496;45540.178392864575;45645.543544564796;48458.757706211596;7549.7357592483995;7564.735234266775;7932.960335198287;8044.316233120133;8053.516788992679;12993.155444896052;13006.934965325112;13056.21662700241;13081.869181308255;13111.934440327928;6607.966960165265;6872.862542749117;6981.89527157093;7074.080369551925;7198.352148306678;4290.849820256276;4344.391785150082;4360.324149756792;4419.46966364032;4471.955280447219;2787.567926971323;2807.073665690358;2807.7332653397893;2814.2260878258644;2820.8166469179437;440.73115399606854;446.0387864152756;450.85572616762323;453.36981595582165;454.18020473045806;541.8807862270294;603.9909401358983;625.9843503912348;639.3318981664172;667.0784434836319;8057.395695322874;8505.31957443403;8626.223639872316;8704.6518139275;8778.429402088845;480.9110314591812;586.9354371019184;624.406813527151;647.9254885688206;662.2715013485224;4021.678265738734;4114.814833332507;4116.732412393185;4125.731827431207;4178.623923846869;57013.71493142591;58580.12129818056;59159.704201478715;59245;59531;50236.24645630318;50379.74810125926;50398.49601504012;50521;50554.74722626437;47245;47256;48549.5145048545;49026.50973490362;49679.75160124176;8253.33973282148;8257.463264887763;8532.744017679479;8551.444156129832;9078.81842363136;35530.46704299489;35846.46230306495;36110;36422.4536631956;37032.62967370292;46431.30353044639;46660.53339466562;46686;47252.29121563248;47436.7628161857;10699.197560182862;10772.622958196425;10872.532208152115;10914.672559823219;11232;12207.084468665063;12255.877441225473;12323.75352492963;12953.805692914426;12955.481780729042;10698.518566664674;10843.837342439712;10875.40185289785;10975.176861735243;11285.548578056785;11277.32336059839;11438.94280528592;11539;11547.307161570332;12012.159148859846;10708.73228169302;10886.67339979802;10965.067969222706;10968.890311096788;11341.943290283496;9930.503474826086;9940.801183976424;9962.452065136487;9962.913014160462;10093.495325233856;8609.274802545198;8891.777705557153;9200.861987070333;9288.860667090134;9440.622375104918 05:54:53 INFO - 2015-11-15 05:54:53,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:54:53 INFO - 2015-11-15 05:54:53,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:54:53 INFO - 2015-11-15 05:54:53,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 05:54:53 INFO - 2015-11-15 05:54:53,032 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: __startTimestamp1447595693025__endTimestamp 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5603.83 Median:5810.56 stddev:647.01 (11.1%) stddev-sans-first:621.91 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: Values: 3242.5 3279.6 3310.8 3312.0 3318.9 5497.6 5532.9 5536.1 5587.9 5588.5 5610.2 5637.2 5688.6 5708.2 5716.9 4961.0 5039.3 5126.4 5151.6 5151.7 5200.7 5217.5 5250.0 5261.3 5285.7 4968.9 5084.2 5161.6 5189.4 5245.6 4998.2 5081.8 5082.3 5094.0 5101.8 5088.0 5091.7 5098.5 5150.8 5155.5 5191.1 5397.7 5434.9 5451.7 5483.6 5954.6 5955.5 5986.3 6002.2 6068.7 6079.5 6094.9 6095.9 6099.1 6105.7 5462.7 5556.5 5557.9 5659.1 5669.5 6147.5 6153.3 6164.2 6174.9 6186.0 5965.9 5969.5 5972.1 5980.4 6017.1 5737.4 5877.0 5890.0 6012.3 6073.4 6053.7 6079.1 6082.7 6087.4 6091.8 6078.5 6079.1 6080.0 6082.4 6094.9 4427.4 4514.4 4546.1 4611.2 4638.1 4087.5 4090.1 4126.2 4130.0 4163.0 5616.6 5776.9 5780.6 5804.2 5834.8 5918.5 5993.1 6082.5 6095.7 6111.7 5735.9 5750.7 5756.9 5763.3 5765.3 5160.4 5175.2 5179.7 5183.2 5220.8 6104.7 6155.6 6179.7 6271.9 6297.9 6091.8 6100.5 6147.5 6154.6 6161.8 6346.5 6349.2 6354.8 6362.8 6373.6 5716.3 5841.3 5897.9 6004.1 6039.0 6063.3 6064.0 6143.2 6156.0 6169.1 5804.0 5930.6 5950.1 5986.8 5993.4 5796.1 5807.2 5831.1 5833.7 5838.4 5810.6 5856.0 5867.1 5880.3 5898.2 5953.0 5965.3 5972.8 5983.6 6004.3 5612.2 5731.9 5764.8 5836.6 5893.1 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48252.41 Median:394176.50 stddev:85763.42 (21.8%) stddev-sans-first:85929.23 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: Values: 553.6 579.2 599.1 613.3 613.9 37634.0 38201.6 38610.0 38652.6 38678.6 42083.0 42647.8 42841.8 43094.8 43189.5 8735.4 8849.1 8854.7 8875.3 8879.5 8655.2 8758.6 8763.6 8767.2 8772.0 8764.1 8767.6 8833.6 8837.4 8839.0 8766.4 8832.4 8835.0 8861.6 8893.2 8656.9 8753.8 8776.3 8789.0 8801.7 40688.1 40941.4 41392.2 41401.0 41462.6 3139.7 3379.1 3437.6 3457.0 3990.0 28938.3 29232.7 29622.9 29843.4 29912.6 2929.7 3001.9 3005.1 3046.6 3135.2 272436.6 273281.0 275031.0 275098.0 275584.0 41578.0 41850.4 41988.4 42155.8 42182.6 41427.0 41442.0 41622.9 41635.8 41736.7 11981.5 12017.5 12085.5 12125.4 12128.8 9547.4 9576.5 9610.3 9641.3 9853.8 14279.5 14314.2 14344.6 14378.4 14487.0 5812.7 5832.7 5904.7 5909.1 6005.9 937.1 941.2 970.2 983.8 1027.0 29167.9 32563.5 33306.2 33629.8 33759.5 1001.3 1007.1 1034.3 1042.3 1096.2 14659.9 15052.8 15085.3 15211.6 15306.5 388261.0 388696.0 393196.0 395157.0 396211.0 54062.5 54226.0 54441.7 54488.0 54570.7 1255.5 1272.3 1278.9 1313.6 1340.1 28163.2 28897.7 28948.7 29016.0 29221.4 45715.3 46209.5 46431.1 46543.8 46621.8 299642.0 299660.0 300456.0 301738.9 302374.0 32381.2 45776.5 46037.3 46178.0 46965.8 44329.8 44356.6 44940.1 44982.0 45336.5 36723.4 36809.8 40002.8 42307.6 42866.8 37138.0 37427.8 38256.6 38408.4 38430.6 37218.0 37361.6 37374.4 37591.0 38512.0 31349.9 33265.5 33928.0 34161.8 34579.5 23806.9 23926.5 24001.9 24068.6 24083.8 05:54:53 INFO - 2015-11-15 05:54:53,033 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,034 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27296.71 Median:448.52 stddev:90225.96 (20116.2%) stddev-sans-first:90456.38 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: Values: 350.5 352.4 355.9 355.9 358.5 12359.8 12910.1 16544.0 16981.4 17641.1 10855.6 10906.6 10953.1 10959.3 11033.6 4004.2 4734.7 4742.3 4773.4 4778.0 4650.3 4689.2 4747.5 4749.4 4758.2 4669.6 4705.2 4712.5 4891.0 5056.5 4992.1 5003.9 5011.3 5011.5 5027.7 4141.7 4220.7 4334.6 4341.1 4351.9 13992.7 14090.2 14250.7 14267.7 14303.8 1994.6 2027.3 2038.5 2048.4 2092.8 9846.5 9926.6 9945.0 10020.5 10175.4 1663.2 1669.4 1685.7 1709.3 1734.0 55426.7 55804.0 56776.7 60476.4 62267.4 7083.3 7108.7 7142.0 7165.7 7201.0 8441.5 8447.9 8466.5 8479.7 8527.8 5374.7 5426.7 5434.4 5442.9 5443.7 5477.9 5481.0 5510.9 5511.4 5549.9 3357.5 3374.5 3386.6 3403.6 3405.2 1115.5 1176.7 1187.3 1188.1 1222.8 402.8 419.9 425.2 476.7 521.2 10094.7 11013.3 11186.6 11214.3 11220.2 445.7 451.4 453.4 457.6 472.7 5796.8 5916.8 5971.2 5975.9 6136.0 536134.0 543691.0 545807.0 560715.0 563926.0 79512.0 79529.0 80145.0 80301.0 80619.6 444.4 447.3 447.7 447.9 449.1 9584.4 9591.4 9773.3 9949.6 9961.2 37353.6 37497.6 37512.0 37832.0 37890.6 48113.0 48637.5 48871.0 49786.8 50406.5 6686.7 6943.3 6947.4 6970.6 7023.5 12196.9 12261.3 12317.7 12425.5 12606.6 10712.0 10966.4 11040.1 11062.2 11079.4 10634.0 10658.9 10698.9 10892.8 11091.2 10979.6 11131.7 11227.0 11325.1 11327.9 6880.4 7069.6 7084.5 7102.7 7102.7 11128.7 11170.3 11461.0 11463.6 11523.7 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5390.29 Median:6280.78 stddev:2795.98 (44.5%) stddev-sans-first:2788.62 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: Values: 1510.6 1713.4 1763.6 1775.7 1786.2 6454.9 6560.3 6564.8 7875.7 7986.1 7995.9 8021.8 8038.1 8054.6 8057.6 2267.6 2293.3 2296.2 2302.2 2304.2 2260.7 2314.1 2321.3 2324.5 2342.4 2244.5 2289.8 2307.6 2308.8 2321.8 2247.6 2334.5 2363.6 2369.1 2370.3 2315.5 2348.0 2352.7 2353.6 2354.9 7734.1 7791.5 7806.1 7844.8 7866.6 4489.0 4539.7 4559.6 4570.0 4575.1 2989.8 3050.8 3134.4 3136.5 3139.6 874.5 875.0 900.2 926.3 966.6 10678.1 10772.0 10788.4 10796.6 10891.2 4127.9 4189.6 4205.2 4242.1 4254.8 8699.0 8707.3 8711.7 8711.9 8713.7 4425.4 4427.1 4434.5 4447.9 4460.6 4056.4 4059.2 4067.4 4072.5 4100.2 3312.7 3338.2 3365.6 3365.9 3366.4 1081.2 1125.1 1126.9 1138.1 1148.8 1055.7 1068.2 1076.0 1247.2 1367.2 7345.5 7351.2 7473.2 7474.9 7480.4 1009.9 1019.4 1121.7 1130.2 1139.8 5706.9 5720.5 5750.3 5791.2 5809.5 9045.6 9144.6 9296.6 9323.4 9458.6 9240.5 9254.2 9303.8 9304.4 9350.9 7042.5 7181.2 7191.1 7248.3 7341.0 7175.8 7201.9 7215.1 7239.3 7272.7 8150.0 8206.6 8217.8 8239.3 8251.6 8421.0 8464.5 8468.2 8517.7 8622.8 6486.8 6928.3 6943.3 6962.7 7021.3 7446.7 7572.7 7597.2 7598.9 7619.5 6487.0 7057.3 7107.6 7165.8 7285.3 6622.9 6713.7 6755.9 6772.5 6829.3 6646.1 6808.6 6810.5 6823.1 6838.9 6072.4 6073.3 6074.0 6077.4 6085.8 6273.1 6288.5 6328.2 6577.5 6722.3 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5659.72 Median:6464.31 stddev:1738.87 (26.9%) stddev-sans-first:1696.98 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: Values: 322.7 333.8 335.5 340.2 341.3 6309.7 6415.5 6465.7 6471.1 6498.3 6127.0 6364.8 6364.9 6364.9 6403.9 4823.1 4836.3 4842.4 4848.1 4851.4 4845.9 4848.8 4851.2 4860.5 4866.0 4718.4 4788.5 4806.2 4807.7 4818.5 4769.0 4770.0 4772.2 4787.1 4793.5 4149.1 4160.0 4166.1 4177.2 4187.0 5929.6 5949.5 5968.0 5977.6 5980.7 5337.2 5489.2 5494.4 5498.5 5503.2 6654.5 6662.4 6699.2 6699.5 6709.7 4465.7 4466.4 4473.3 4475.9 4490.3 6747.3 6928.9 6973.9 7024.0 7047.5 4678.1 4694.9 4695.4 4696.8 4699.7 4758.7 4767.7 4768.8 4770.2 4776.8 5531.6 5556.9 5577.9 5587.4 5592.6 6592.9 6852.1 6862.4 6863.3 6872.6 1661.7 1699.6 1750.6 1750.9 1752.8 1163.6 1167.4 1178.7 1184.5 1184.7 6415.2 6470.8 6478.8 6485.8 6490.7 6899.1 6899.8 6941.5 6943.1 6943.6 6449.1 6456.5 6462.9 6469.9 6470.0 3832.7 3836.3 3866.3 3868.5 3869.8 7335.8 7340.8 7378.9 7381.6 7403.2 6937.2 7134.9 7138.5 7153.8 7177.6 7305.0 7321.9 7365.0 7366.8 7378.4 7039.2 7047.0 7048.6 7053.4 7056.4 6844.6 6959.0 6968.6 7004.8 7065.3 7394.7 7402.1 7404.8 7416.6 7441.2 4650.3 4677.0 4678.7 4697.9 4704.5 6916.5 6955.9 7113.9 7145.2 7164.5 6910.0 6922.7 6937.1 6957.0 6968.0 6819.7 6851.9 6907.4 6909.4 6923.7 6626.5 6711.5 6747.7 6765.9 6775.4 6936.9 6936.9 6956.1 6964.7 6967.5 6727.2 6737.9 6756.5 6781.3 6788.3 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,035 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13630.22 Median:46545.92 stddev:16163.19 (34.7%) stddev-sans-first:16179.70 05:54:53 INFO - 2015-11-15 05:54:53,037 DEBUG : BROWSER_OUTPUT: Values: 772.9 836.2 843.8 868.4 888.8 13465.0 13557.4 13670.3 13849.4 13899.7 13526.9 13692.3 13808.1 13854.7 14300.7 810.1 838.4 839.7 840.0 840.2 817.7 826.0 829.2 831.5 832.2 856.8 863.8 871.5 871.7 872.1 864.7 865.5 866.2 866.7 869.0 626.2 628.7 633.1 633.8 633.9 12759.2 12779.0 12926.2 13010.1 13022.9 11191.0 11217.8 11300.7 11553.6 11638.2 10106.5 10223.7 10275.6 10289.1 10482.6 3372.2 3385.5 3548.8 3587.1 3613.2 44110.8 45496.0 45540.2 45645.5 48458.8 7549.7 7564.7 7933.0 8044.3 8053.5 12993.2 13006.9 13056.2 13081.9 13111.9 6608.0 6872.9 6981.9 7074.1 7198.4 4290.8 4344.4 4360.3 4419.5 4472.0 2787.6 2807.1 2807.7 2814.2 2820.8 440.7 446.0 450.9 453.4 454.2 541.9 604.0 626.0 639.3 667.1 8057.4 8505.3 8626.2 8704.7 8778.4 480.9 586.9 624.4 647.9 662.3 4021.7 4114.8 4116.7 4125.7 4178.6 57013.7 58580.1 59159.7 59245.0 59531.0 50236.2 50379.7 50398.5 50521.0 50554.7 47245.0 47256.0 48549.5 49026.5 49679.8 8253.3 8257.5 8532.7 8551.4 9078.8 35530.5 35846.5 36110.0 36422.5 37032.6 46431.3 46660.5 46686.0 47252.3 47436.8 10699.2 10772.6 10872.5 10914.7 11232.0 12207.1 12255.9 12323.8 12953.8 12955.5 10698.5 10843.8 10875.4 10975.2 11285.5 11277.3 11438.9 11539.0 11547.3 12012.2 10708.7 10886.7 10965.1 10968.9 11341.9 9930.5 9940.8 9962.5 9962.9 10093.5 8609.3 8891.8 9200.9 9288.9 9440.6 05:54:53 INFO - 2015-11-15 05:54:53,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:54:53 INFO - 2015-11-15 05:54:53,037 DEBUG : BROWSER_OUTPUT: 05:54:53 INFO - 2015-11-15 05:54:53,731 INFO : Browser exited with error code: 0 05:54:53 INFO - 2015-11-15 05:54:53,748 INFO : Completed test dromaeo_css (00:18:32) 05:54:53 INFO - 2015-11-15 05:54:53,748 INFO : Starting test kraken 05:54:53 INFO - 2015-11-15 05:54:53,748 DEBUG : operating with platform_type : linux_ 05:54:53 INFO - 2015-11-15 05:54:53,748 INFO : Initialising browser for kraken test... 05:54:53 INFO - 2015-11-15 05:54:53,754 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpd16AA5/profile http://localhost:53958/getInfo.html 05:54:58 INFO - 2015-11-15 05:54:58,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:54:58 INFO - 2015-11-15 05:54:58,519 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:54:58 INFO - 2015-11-15 05:54:58,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:54:58 INFO - 2015-11-15 05:54:58,519 DEBUG : BROWSER_OUTPUT: __metrics 05:54:59 INFO - 2015-11-15 05:54:59,595 INFO : Browser initialized. 05:54:59 INFO - 2015-11-15 05:54:59,596 INFO : Running cycle 1/1 for kraken test... 05:54:59 INFO - 2015-11-15 05:54:59,596 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpd16AA5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:11 INFO - 2015-11-15 05:55:11,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 141672448 05:55:11 INFO - 2015-11-15 05:55:11,383 DEBUG : BROWSER_OUTPUT: 05:55:13 INFO - 2015-11-15 05:55:13,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53958/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:14 INFO - 2015-11-15 05:55:14,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 05:55:14 INFO - 2015-11-15 05:55:14,485 DEBUG : BROWSER_OUTPUT: 05:55:17 INFO - 2015-11-15 05:55:17,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53958/tests/kraken/driver.html?testName=audio-dft) 05:55:17 INFO - 2015-11-15 05:55:17,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 05:55:17 INFO - 2015-11-15 05:55:17,709 DEBUG : BROWSER_OUTPUT: 05:55:20 INFO - 2015-11-15 05:55:20,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53958/tests/kraken/driver.html?testName=audio-fft) 05:55:21 INFO - 2015-11-15 05:55:21,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 136826880 05:55:21 INFO - 2015-11-15 05:55:21,141 DEBUG : BROWSER_OUTPUT: 05:55:23 INFO - 2015-11-15 05:55:23,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53958/tests/kraken/driver.html?testName=audio-oscillator) 05:55:23 INFO - 2015-11-15 05:55:23,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 136585216 05:55:23 INFO - 2015-11-15 05:55:23,761 DEBUG : BROWSER_OUTPUT: 05:55:25 INFO - 2015-11-15 05:55:25,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:26 INFO - 2015-11-15 05:55:26,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 137216000 05:55:26 INFO - 2015-11-15 05:55:26,536 DEBUG : BROWSER_OUTPUT: 05:55:29 INFO - 2015-11-15 05:55:29,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53958/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:30 INFO - 2015-11-15 05:55:30,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 137273344 05:55:30 INFO - 2015-11-15 05:55:30,101 DEBUG : BROWSER_OUTPUT: 05:55:33 INFO - 2015-11-15 05:55:33,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53958/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:34 INFO - 2015-11-15 05:55:34,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 138596352 05:55:34 INFO - 2015-11-15 05:55:34,109 DEBUG : BROWSER_OUTPUT: 05:55:36 INFO - 2015-11-15 05:55:36,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53958/tests/kraken/driver.html?testName=json-parse-financial) 05:55:37 INFO - 2015-11-15 05:55:37,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 139300864 05:55:37 INFO - 2015-11-15 05:55:37,522 DEBUG : BROWSER_OUTPUT: 05:55:39 INFO - 2015-11-15 05:55:39,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:39 INFO - 2015-11-15 05:55:39,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 139329536 05:55:39 INFO - 2015-11-15 05:55:39,684 DEBUG : BROWSER_OUTPUT: 05:55:41 INFO - 2015-11-15 05:55:41,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:42 INFO - 2015-11-15 05:55:42,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 139431936 05:55:42 INFO - 2015-11-15 05:55:42,142 DEBUG : BROWSER_OUTPUT: 05:55:44 INFO - 2015-11-15 05:55:44,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:44 INFO - 2015-11-15 05:55:44,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 139665408 05:55:44 INFO - 2015-11-15 05:55:44,812 DEBUG : BROWSER_OUTPUT: 05:55:47 INFO - 2015-11-15 05:55:47,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:47 INFO - 2015-11-15 05:55:47,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 139993088 05:55:47 INFO - 2015-11-15 05:55:47,853 DEBUG : BROWSER_OUTPUT: 05:55:50 INFO - 2015-11-15 05:55:50,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:51 INFO - 2015-11-15 05:55:51,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 05:55:51 INFO - 2015-11-15 05:55:51,001 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53958/tests/kraken/driver.html?testName=ai-astar) 05:55:52 INFO - 2015-11-15 05:55:52,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 139493376 05:55:52 INFO - 2015-11-15 05:55:52,934 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,934 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:52 INFO - 2015-11-15 05:55:52,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;108;112;111;111;123;111;110;112;111 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;126;153;170;127;147;158;128;171;126 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;162;163;162;163;164;165;171;161 05:55:52 INFO - 2015-11-15 05:55:52,935 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;72;142;74;73;72;73;166;72 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;90;136;89;92;91;133;91;89;140 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;110;110;109;110;112;110;111 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;146;148;147;147;146;147;148 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;97;96;97;96;96;96;97 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;61;60;61;69;61;67;59;58 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;70;70;72;70;70;70;72 05:55:52 INFO - 2015-11-15 05:55:52,936 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;95;85;83;83;83;83;83;87 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;122;117;121;124;122;120;125;124;122 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;151;150;148;161;147;146;150;147;138 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;68;69;67;66;70;68;67;66 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,737 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: __startTimestamp1447595752933__endTimestamp 05:55:52 INFO - 2015-11-15 05:55:52,937 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.07 (3.7%) stddev-sans-first:4.26 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: Values: 110.0 108.0 112.0 111.0 111.0 123.0 111.0 110.0 112.0 111.0 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,939 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.00 stddev:17.96 (11.8%) stddev-sans-first:18.95 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: Values: 151.0 126.0 153.0 170.0 127.0 147.0 158.0 128.0 171.0 126.0 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.91 (1.8%) stddev-sans-first:2.93 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 162.0 163.0 162.0 163.0 164.0 165.0 171.0 161.0 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.50 stddev:34.78 (48.0%) stddev-sans-first:36.35 05:55:52 INFO - 2015-11-15 05:55:52,940 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 72.0 142.0 74.0 73.0 72.0 73.0 166.0 72.0 05:55:52 INFO - 2015-11-15 05:55:52,941 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,941 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.50 stddev:22.08 (24.4%) stddev-sans-first:23.09 05:55:52 INFO - 2015-11-15 05:55:52,941 DEBUG : BROWSER_OUTPUT: Values: 94.0 90.0 136.0 89.0 92.0 91.0 133.0 91.0 89.0 140.0 05:55:52 INFO - 2015-11-15 05:55:52,941 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,941 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 05:55:52 INFO - 2015-11-15 05:55:52,942 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 110.0 110.0 109.0 110.0 112.0 110.0 111.0 05:55:52 INFO - 2015-11-15 05:55:52,942 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,942 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:55:52 INFO - 2015-11-15 05:55:52,942 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 146.0 148.0 147.0 147.0 146.0 147.0 148.0 05:55:52 INFO - 2015-11-15 05:55:52,942 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,943 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:55:52 INFO - 2015-11-15 05:55:52,943 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 97.0 05:55:52 INFO - 2015-11-15 05:55:52,943 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,943 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:3.50 (5.7%) stddev-sans-first:3.70 05:55:52 INFO - 2015-11-15 05:55:52,944 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 60.0 61.0 69.0 61.0 67.0 59.0 58.0 05:55:52 INFO - 2015-11-15 05:55:52,944 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,944 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 05:55:52 INFO - 2015-11-15 05:55:52,944 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 70.0 72.0 70.0 70.0 70.0 72.0 05:55:52 INFO - 2015-11-15 05:55:52,944 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.74 (4.5%) stddev-sans-first:3.95 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 95.0 85.0 83.0 83.0 83.0 83.0 83.0 87.0 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.00 stddev:2.63 (2.1%) stddev-sans-first:2.42 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: Values: 126.0 122.0 117.0 121.0 124.0 122.0 120.0 125.0 124.0 122.0 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:149.00 stddev:6.75 (4.5%) stddev-sans-first:6.00 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: Values: 137.0 151.0 150.0 148.0 161.0 147.0 146.0 150.0 147.0 138.0 05:55:52 INFO - 2015-11-15 05:55:52,945 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-15 05:55:52,946 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 05:55:52 INFO - 2015-11-15 05:55:52,946 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 68.0 69.0 67.0 66.0 70.0 68.0 67.0 66.0 05:55:52 INFO - 2015-11-15 05:55:52,946 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:52 INFO - 2015-11-15 05:55:52,946 DEBUG : BROWSER_OUTPUT: 05:55:53 INFO - 2015-11-15 05:55:53,911 INFO : Browser exited with error code: 0 05:55:53 INFO - 2015-11-15 05:55:53,962 INFO : Completed test kraken (00:01:00) 05:55:53 INFO - 2015-11-15 05:55:53,962 INFO : Starting test v8_7 05:55:53 INFO - 2015-11-15 05:55:53,962 DEBUG : operating with platform_type : linux_ 05:55:53 INFO - 2015-11-15 05:55:53,962 INFO : Initialising browser for v8_7 test... 05:55:53 INFO - 2015-11-15 05:55:53,968 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQoZsg7/profile http://localhost:53958/getInfo.html 05:55:58 INFO - 2015-11-15 05:55:58,966 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:58 INFO - 2015-11-15 05:55:58,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:58 INFO - 2015-11-15 05:55:58,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:55:58 INFO - 2015-11-15 05:55:58,967 DEBUG : BROWSER_OUTPUT: __metrics 05:56:00 INFO - 2015-11-15 05:55:59,999 INFO : Browser initialized. 05:56:00 INFO - 2015-11-15 05:56:00,000 INFO : Running cycle 1/1 for v8_7 test... 05:56:00 INFO - 2015-11-15 05:56:00,000 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQoZsg7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:11 INFO - 2015-11-15 05:56:11,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 05:56:11 INFO - 2015-11-15 05:56:11,824 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53958/tests/v8_7/run.html (next: http://localhost:53958/tests/v8_7/run.html) 05:56:33 INFO - 2015-11-15 05:56:33,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 137551872 05:56:33 INFO - 2015-11-15 05:56:33,421 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,421 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:33 INFO - 2015-11-15 05:56:33,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:33 INFO - 2015-11-15 05:56:33,422 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:33 INFO - 2015-11-15 05:56:33,422 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:33 INFO - 2015-11-15 05:56:33,422 DEBUG : BROWSER_OUTPUT: |0;Richards;167.42005692281936 05:56:33 INFO - 2015-11-15 05:56:33,422 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.09937888198758 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.2524161455372 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |5;Earley;729.3946024799417 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 05:56:33 INFO - 2015-11-15 05:56:33,423 DEBUG : BROWSER_OUTPUT: |7;RegExp;25075 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: |8;Splay;597.1394517282479 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: __startTimestamp1447595793420__endTimestamp 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:56:33 INFO - 2015-11-15 05:56:33,424 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,425 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,426 DEBUG : BROWSER_OUTPUT: Values: 167.4 05:56:33 INFO - 2015-11-15 05:56:33,426 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,426 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.10 Median:194.10 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,426 DEBUG : BROWSER_OUTPUT: Values: 194.1 05:56:33 INFO - 2015-11-15 05:56:33,426 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.25 Median:284.25 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: Values: 284.3 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: Values: 5035.2 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: Values: 1060.4 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:729.39 Median:729.39 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,427 DEBUG : BROWSER_OUTPUT: Values: 729.4 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: Values: 12207.3 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: Values: 25075.0 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,428 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.14 Median:597.14 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: Values: 597.1 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: Values: 4835.7 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:33 INFO - 2015-11-15 05:56:33,429 DEBUG : BROWSER_OUTPUT: 05:56:34 INFO - 2015-11-15 05:56:34,271 INFO : Browser exited with error code: 0 05:56:34 INFO - 2015-11-15 05:56:34,288 INFO : Completed test v8_7 (00:00:40) 05:56:34 INFO - 2015-11-15 05:56:34,466 INFO : Completed test suite (00:20:13) 05:56:34 INFO - 2015-11-15 05:56:34,466 DEBUG : Working with test: dromaeo_css 05:56:34 INFO - 2015-11-15 05:56:34,466 DEBUG : Generating results file: dromaeo_css 05:56:34 INFO - 2015-11-15 05:56:34,467 DEBUG : Working with test: kraken 05:56:34 INFO - 2015-11-15 05:56:34,467 DEBUG : Generating results file: kraken 05:56:34 INFO - 2015-11-15 05:56:34,467 INFO : javascript benchmark 05:56:34 INFO - 2015-11-15 05:56:34,468 DEBUG : Working with test: v8_7 05:56:34 INFO - 2015-11-15 05:56:34,468 DEBUG : Generating results file: v8_7 05:56:34 INFO - 2015-11-15 05:56:34,468 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:34 INFO - 2015-11-15 05:56:34,616 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:56:34 INFO - 2015-11-15 05:56:34,616 DEBUG : process_Request line: dromaeo_css 6752.25 graph.html#tests=[[72,1,43]] 05:56:34 INFO - 2015-11-15 05:56:34,617 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:34 INFO - 2015-11-15 05:56:34,740 DEBUG : process_Request line: kraken 1522.80 graph.html#tests=[[232,1,43]] 05:56:34 INFO - 2015-11-15 05:56:34,740 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:34 INFO - 2015-11-15 05:56:34,842 DEBUG : process_Request line: v8_7 21339.71 graph.html#tests=[[230,1,43]] 05:56:34 INFO - 2015-11-15 05:56:34,843 INFO : javascript benchmark 05:56:34 INFO - 2015-11-15 05:56:34,847 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [350.4970367522605, 352.3569485688618, 355.8950109717633, 355.91102224443887, 358.52853497650585, 12359.752804943895, 12910.096293259476, 16544.0, 16981.405650802226, 17641.117944102793, 10855.565777368916, 10906.61826836061, 10953.123750099992, 10959.287646303004, 11033.558657653684, 4004.2191772604356, 4734.715917044971, 4742.3123647071325, 4773.403324584409, 4777.952220477786, 4650.302454631798, 4689.155951928651, 4747.548982846624, 4749.358836557072, 4758.1673207188605, 4669.579737823595, 4705.200115980291, 4712.528747125294, 4891.046245982035, 5056.494350564951, 4992.051510213066, 5003.874903127415, 5011.298418221434, 5011.523905228997, 5027.748612569375, 4141.7100802943805, 4220.683448741357, 4334.566543345672, 4341.06667066579, 4351.8694439166875, 13992.720145597032, 14090.225037622926, 14250.714985700228, 14267.714645707132, 14303.78544321836, 1994.6210220058142, 2027.3005812994493, 2038.4801875521648, 2048.3957232616267, 2092.801183887528, 9846.507674616241, 9926.553305101288, 9945.00549945007, 10020.549075291628, 10175.389476631426, 1663.2265996311774, 1669.4323929863783, 1685.7134287171211, 1709.333359989605, 1733.9596242254547, 55426.72286638581, 55804.0, 56776.716116419564, 60476.39523604796, 62267.37732622661, 7083.256258092826, 7108.68010939509, 7142.035825163536, 7165.713371465187, 7200.963995179991, 8441.493510389397, 8447.873281900776, 8466.534340611202, 8479.745607631781, 8527.829443411221, 5374.731263436813, 5426.728663566806, 5434.375046869582, 5442.8911421771345, 5443.727813609304, 5477.890442191134, 5481.0, 5510.862228444321, 5511.421300763443, 5549.916751248654, 3357.462805951036, 3374.4769560718128, 3386.644402337719, 3403.6426175251736, 3405.2338223899424, 1115.475726408603, 1176.6587689569928, 1187.2994932989577, 1188.085174415695, 1222.7860124478182, 402.794574766871, 419.90762032352836, 425.2091110534404, 476.74732391832384, 521.1635325302834, 10094.747631309276, 11013.28796543847, 11186.552537898555, 11214.32714037144, 11220.158488113424, 445.6902452795341, 451.4334510189691, 453.4218870939512, 457.636179237507, 472.71164589601005, 5796.797112101056, 5916.822495325147, 5971.19388882504, 5975.910361344583, 6136.018237082135, 536134.0, 543691.0, 545807.0, 560715.0, 563926.0, 79512.0, 79529.0, 80145.0, 80301.0, 80619.59690201629, 444.44444444444446, 447.3022085546558, 447.7089891570505, 447.92385294500014, 449.12196655538344, 9584.37701549397, 9591.376560523544, 9773.315867889463, 9949.602015919281, 9961.203103751828, 37353.62646373502, 37497.62502374942, 37512.0, 37832.0, 37890.621093789814, 48113.0, 48637.5136248633, 48871.0, 49786.75106624444, 50406.49593504165, 6686.665666716742, 6943.305669433218, 6947.44420446353, 6970.616616086164, 7023.473239506955, 12196.939015304866, 12261.325627090595, 12317.706640802588, 12425.502979880703, 12606.55877044299, 10712.0, 10966.396848173426, 11040.061594764535, 11062.22564420483, 11079.390633515233, 10634.0, 10658.946705266735, 10698.946505267424, 10892.782144357227, 11091.168162387692, 10979.61571345031, 11131.721706957067, 11227.0, 11325.093992480746, 11327.904337697551, 6880.449564034765, 7069.646517673993, 7084.504084714021, 7102.680379382837, 7102.680379383043, 11128.721781955192, 11170.329780213213, 11461.0, 11463.598774042868, 11523.654290371302], "dojo.html": [3242.4812030075186, 3279.573655424796, 3310.7847989880656, 3312.022953228797, 3318.8506517206724, 5497.642653227537, 5532.889342213153, 5536.086545719952, 5587.888242235158, 5588.497035266831, 5610.158476228567, 5637.238972738679, 5688.573356998221, 5708.229389032479, 5716.914246286298, 4961.007798440309, 5039.269305950635, 5126.359205099363, 5151.613628977823, 5151.74241287936, 5200.7399630018535, 5217.530422261995, 5250.028744682227, 5261.289725886994, 5285.656432331905, 4968.850934471971, 5084.211947148198, 5161.638685292031, 5189.403218629868, 5245.606579506552, 4998.150314446553, 5081.79672813087, 5082.3138876251605, 5093.974530127362, 5101.846944591668, 5088.0332736780265, 5091.745412729349, 5098.515641014098, 5150.845474635767, 5155.53600175986, 5191.091558977164, 5397.730113494349, 5434.864128396782, 5451.727413629303, 5483.643563168382, 5954.583179177459, 5955.464008239236, 5986.281646202484, 6002.2197114375285, 6068.6662233577135, 6079.544034197453, 6094.8781024379705, 6095.908561371583, 6099.054646529795, 6105.694715264219, 5462.6995515246645, 5556.527695145958, 5557.888842223214, 5659.122835960392, 5669.489745922846, 6147.508199344042, 6153.261608606996, 6164.167837341991, 6174.876502470015, 6186.0, 5965.910511342333, 5969.522438204933, 5972.134040564094, 5980.43185897339, 6017.06735456005, 5737.426257374313, 5877.0, 5890.0, 6012.278526576839, 6073.423024812636, 6053.697315134225, 6079.08813677943, 6082.726277317532, 6087.36082711309, 6091.7563297467605, 6078.45293923549, 6079.088136779518, 6080.0, 6082.361352058058, 6094.908576371358, 4427.402300689366, 4514.367988481616, 4546.1135078659345, 4611.1930412177735, 4638.0955713636195, 4087.5094988600963, 4090.0592863641527, 4126.195391898551, 4130.008797888545, 4163.02168990287, 5616.634918730269, 5776.855578610568, 5780.624259423124, 5804.158397032406, 5834.824955251349, 5918.46733793952, 5993.101034844808, 6082.482988945989, 6095.664738439428, 6111.694415279308, 5735.942640573624, 5750.741216645261, 5756.884862302731, 5763.308402991668, 5765.3369862465515, 5160.432352441228, 5175.249588809602, 5179.715115668599, 5183.248428977777, 5220.843374698765, 6104.725287362079, 6155.599886007395, 6179.721912513947, 6271.905921411182, 6297.874042519124, 6091.847703807441, 6100.511959043355, 6147.538934579835, 6154.569180157346, 6161.84595385119, 6346.492280617632, 6349.238091429058, 6354.841128971812, 6362.809115726535, 6373.6175829450385, 5716.314042314949, 5841.32824725145, 5897.9115313271195, 6004.099385092271, 6039.0, 6063.333033366238, 6063.969680151571, 6143.170671959407, 6156.0, 6169.136320915165, 5804.0, 5930.644161350333, 5950.137230101524, 5986.820395388146, 5993.430624090704, 5796.1305804129715, 5807.186993820953, 5831.1253312001845, 5833.708314584339, 5838.416158384128, 5810.564207684525, 5855.970720146372, 5867.119932010232, 5880.26496687914, 5898.233229680114, 5953.0, 5965.28416590012, 5972.761089556369, 5983.551233657406, 6004.339522652592, 5612.186232996274, 5731.8567035824435, 5764.798232061858, 5836.620619659709, 5893.086571581412], "mootools.html": [1510.6147932277268, 1713.3831820544603, 1763.567925858165, 1775.698131317676, 1786.2408476397527, 6454.870902581945, 6560.311167327433, 6564.770233041839, 7875.684972601103, 7986.121526632066, 7995.920040799605, 8021.799455013627, 8038.115807261212, 8054.597270136484, 8057.637406316715, 2267.557826223891, 2293.3463962770616, 2296.1619009061656, 2302.240260713969, 2304.2280835919987, 2260.672202530632, 2314.0743702519044, 2321.303608917318, 2324.5234726881035, 2342.379269493577, 2244.517428752818, 2289.839711220215, 2307.596170670126, 2308.7922087012166, 2321.767823217673, 2247.5617254635354, 2334.5447637710654, 2363.586372384843, 2369.087901158049, 2370.348154257584, 2315.513742114158, 2347.9530409391887, 2352.7294361148515, 2353.576356255873, 2354.85870847748, 7734.110577283628, 7791.532508049535, 7806.06327240729, 7844.843103137905, 7866.567338796364, 4488.955110448886, 4539.659525535565, 4559.589636932659, 4570.040291538781, 4575.130725162208, 2989.805662631922, 3050.816950982948, 3134.4044631520164, 3136.4511210538294, 3139.623245210589, 874.4884242718017, 875.0330884372804, 900.2392977933636, 926.3145272498302, 966.6085235479642, 10678.092362149227, 10772.0, 10788.352698838016, 10796.5681372745, 10891.183161262938, 4127.876163715094, 4189.601987811153, 4205.1589682063095, 4242.109157076987, 4254.808533615995, 8698.956505217433, 8707.259882910024, 8711.738647840575, 8711.869321960176, 8713.738587842376, 4425.35832304314, 4427.070315233773, 4434.534373890695, 4447.866564003085, 4460.553944605514, 4056.371262454324, 4059.2287465381482, 4067.389891516237, 4072.511298644182, 4100.2414553307135, 3312.6521715220038, 3338.165458635341, 3365.6466071062678, 3365.899023029313, 3366.4108780963234, 1081.221520505235, 1125.139268459629, 1126.8704099028553, 1138.1407037686658, 1148.8276758486295, 1055.6621880998161, 1068.1988508618535, 1076.0315715855793, 1247.2204871955028, 1367.1865240182076, 7345.485815992936, 7351.191368949411, 7473.177950425449, 7474.925250747423, 7480.401567874557, 1009.9495025248708, 1019.4494972714651, 1121.6803211084964, 1130.2370899642708, 1139.8233273842568, 5706.914396284059, 5720.542356611461, 5750.30996280449, 5791.189233507313, 5809.477147056785, 9045.638174473079, 9144.588493517675, 9296.581653825595, 9323.440593564272, 9458.621655133855, 9240.537973101318, 9254.167124958785, 9303.76740581491, 9304.441733496013, 9350.859737103949, 7042.521070575237, 7181.245969173266, 7191.101112360955, 7248.347648711641, 7341.0, 7175.820604484929, 7201.891971620535, 7215.134183897966, 7239.348458638748, 7272.709091636275, 8149.959250203711, 8206.58967051657, 8217.83564328722, 8239.258466738022, 8251.628676709443, 8420.95789521073, 8464.534450605275, 8468.153184681483, 8517.659293628434, 8622.78443038929, 6486.837829054311, 6928.272531384132, 6943.340382663639, 6962.651867406711, 7021.297870212938, 7446.664900079401, 7572.734954276574, 7597.164311925573, 7598.924010759822, 7619.504732192389, 6487.0, 7057.294270573107, 7107.609081500567, 7165.7850264492145, 7285.307895749896, 6622.867542649216, 6713.697883595348, 6755.93244067553, 6772.525923185527, 6829.282925292773, 6646.102776125162, 6808.625525595941, 6810.523263371715, 6823.078884350549, 6838.897416538656, 6072.392760723892, 6073.271207455134, 6073.969630151821, 6077.392260773887, 6085.756569737161, 6273.090401891792, 6288.465480434032, 6328.177336946167, 6577.506686998398, 6722.260551339251], "ext.html": [553.5792602699672, 579.1544345255926, 599.149208124463, 613.2977740487145, 613.9048447490635, 37634.0, 38201.61798382016, 38610.0, 38652.613473865254, 38678.61321386785, 42083.0, 42647.78676106623, 42841.78579107108, 43094.784526077325, 43189.54483641309, 8735.432196907197, 8849.115088491164, 8854.690085846996, 8875.289976801872, 8879.467231966071, 8655.17775811297, 8758.649654013832, 8763.649454021832, 8767.167119123673, 8772.0, 8764.123587641248, 8767.56162191891, 8833.55832208387, 8837.425567338103, 8839.0, 8766.386352955296, 8832.425892316978, 8835.0, 8861.556922153932, 8893.199612034949, 8656.913430865674, 8753.7811554711, 8776.297896168291, 8788.956055219747, 8801.735947921572, 40688.13462721037, 40941.38587921183, 41392.1721565567, 41401.0, 41462.585374146474, 3139.670334614855, 3379.053864917827, 3437.6218615952225, 3457.014750796011, 3990.04238982645, 28938.27654308659, 29232.70767292321, 29622.85188574065, 29843.403131937455, 29912.55131173034, 2929.6630887448005, 3001.9399612007637, 3005.128512731327, 3046.6039414875922, 3135.216195951012, 272436.6378168116, 273281.0, 275031.0, 275098.0, 275584.0, 41578.0, 41850.37224441575, 41988.37017444741, 42155.789221053696, 42182.578174217866, 41427.0, 41442.0, 41622.91885405718, 41635.7918210407, 41736.66106711456, 11981.520739170335, 12017.459214335377, 12085.516579336903, 12125.39373031345, 12128.757424851454, 9547.42715437076, 9576.47329396876, 9610.279229057849, 9641.325107242566, 9853.802923941481, 14279.500217492337, 14314.212718300594, 14344.56966291013, 14378.424863005363, 14487.0, 5812.651240925558, 5832.679202643895, 5904.6714489239575, 5909.113632955091, 6005.879882402328, 937.128470522407, 941.1576638908139, 970.1559643110539, 983.7786498037884, 1027.019196667181, 29167.854160729486, 32563.51154732681, 33306.167345816066, 33629.83185084059, 33759.493607595905, 1001.3191030099457, 1007.0734923870057, 1034.255336157965, 1042.3329069395593, 1096.2326371539955, 14659.853401466062, 15052.849471505364, 15085.3211605478, 15211.61970950713, 15306.464273750365, 388261.0, 388696.0, 393196.0, 395157.0, 396211.0, 54062.45937540653, 54226.0, 54441.72779136079, 54488.0, 54570.72714636481, 1255.460152134591, 1272.2620879889641, 1278.9168704034394, 1313.5796545105475, 1340.0619566303626, 28163.155105346872, 28897.711022889504, 28948.6704081481, 29016.0, 29221.41557168887, 45715.31427028664, 46209.537904621866, 46431.07137857156, 46543.767281164735, 46621.76689116532, 299642.0, 299660.0, 300456.0, 301738.9130543508, 302374.0, 32381.19047023843, 45776.54223457723, 46037.30944035775, 46178.0, 46965.76517117392, 44329.77835110804, 44356.556434435246, 44940.10119797651, 44982.0, 45336.54663453455, 36723.44914826333, 36809.81595092115, 40002.799986001046, 42307.576924231595, 42866.78566607147, 37138.0, 37427.81286093552, 38256.61743382642, 38408.423873642474, 38430.6156938427, 37218.0, 37361.62638373581, 37374.439383409815, 37591.0, 38512.0, 31349.946430696942, 33265.501017484276, 33928.0, 34161.82919085389, 34579.4813077799, 23806.88096559506, 23926.52146957086, 24001.879990599937, 24068.638970415108, 24083.75916240815], "prototype.html": [322.7079493058782, 333.8430937459394, 335.4783311949917, 340.2327750921671, 341.34461833280113, 6309.716062777175, 6415.45468635166, 6465.741370345192, 6471.0940468334475, 6498.285188629253, 6127.0, 6364.840878978028, 6364.886144924642, 6364.904526432096, 6403.903941440882, 4823.083614113325, 4836.274558816171, 4842.443119041302, 4848.127337079342, 4851.417829860422, 4845.878853028667, 4848.830290939818, 4851.175300198975, 4860.4896485869, 4866.026794641069, 4718.363020992157, 4788.521147885219, 4806.182948898678, 4807.711537307755, 4818.518148185189, 4769.0, 4770.0, 4772.2125849234835, 4787.0904528139545, 4793.544613261734, 4149.087200815846, 4159.9792001039805, 4166.062635906927, 4177.248095342837, 4187.036981494243, 5929.614575052651, 5949.46454819064, 5968.0, 5977.551683623746, 5980.671063091529, 5337.199420086979, 5489.231507588941, 5494.43408628539, 5498.477644623755, 5503.2020357048, 6654.534182607219, 6662.400383965466, 6699.162604674416, 6699.464042876558, 6709.731610735565, 4465.732056076646, 4466.3523789050405, 4473.261911784552, 4475.865724028285, 4490.3488994096, 6747.291534388867, 6928.861422771516, 6973.930260697379, 7024.0, 7047.506674532785, 4678.064387122589, 4694.929576056362, 4695.436547614308, 4696.788644511005, 4699.741514216683, 4758.666893317504, 4767.713937163712, 4768.7615619218905, 4770.189067858472, 4776.832810851603, 5531.612787104864, 5556.944430555724, 5577.888442231214, 5587.44125587438, 5592.5805564582815, 6592.934070659232, 6852.143482064742, 6862.416694580917, 6863.313668633196, 6872.62200578973, 1661.7008938391205, 1699.5836020175136, 1750.5536088297404, 1750.8861923975155, 1752.7809023872016, 1163.552032467506, 1167.3637867362138, 1178.6817559258952, 1184.4788293150987, 1184.6979020349756, 6415.1981002374705, 6470.838229044311, 6478.838029049311, 6485.805425837232, 6490.707918143695, 6899.103116594811, 6899.758508452281, 6941.514094013472, 6943.062686537354, 6943.583384996917, 6449.129367535416, 6456.51576131792, 6462.870742585216, 6469.902951455638, 6469.967650161719, 3832.6742226911024, 3836.3286424875537, 3866.3427217373114, 3868.516435445569, 3869.845206191721, 7335.816604584928, 7340.816479588053, 7378.926210737824, 7381.630918454163, 7403.2226616204525, 6937.167539895245, 7134.8929766052515, 7138.464615153885, 7153.785386438415, 7177.641117944082, 7305.0, 7321.926780732125, 7364.9689043533945, 7366.815829604303, 7378.446616503784, 7039.1553013638695, 7047.0, 7048.612326322102, 7053.435725142079, 7056.364927156581, 6844.555103918229, 6959.0, 6968.616726080114, 7004.789856304319, 7065.328793764585, 7394.741184058532, 7402.111746590228, 7404.814879628052, 7416.555006699616, 7441.218672039575, 4650.302454631832, 4677.041206552581, 4678.69588476748, 4697.859064228079, 4704.50602686713, 6916.51584389108, 6955.8608827822145, 7113.857722845618, 7145.249748776304, 7164.534305270141, 6909.965450172717, 6922.723091076301, 6937.063496427918, 6956.965215173892, 6967.96516017437, 6819.727210911508, 6851.8972215415815, 6907.378335949788, 6909.412699920362, 6923.688434020381, 6626.53614246998, 6711.496637752286, 6747.662616869039, 6765.8985115224295, 6775.4240889524945, 6936.895946560705, 6936.930630693629, 6956.095707557985, 6964.721411143498, 6967.54710943787, 6727.226368967631, 6737.865242695217, 6756.493263005196, 6781.2879647638265, 6788.321167883172], "yui.html": [772.8956590860233, 836.2390224895346, 843.7721815109925, 868.3617541107282, 888.75114967809, 13465.0, 13557.389917453738, 13670.316484175777, 13849.446022159114, 13899.652508687288, 13526.93236533816, 13692.315384230798, 13808.102473339226, 13854.653633659163, 14300.71398572028, 810.14934318965, 838.421489172469, 839.7396806989852, 840.0465471689646, 840.2227939156256, 817.668844118133, 825.9752207433756, 829.2122483640535, 831.501099340397, 832.1719888710742, 856.7900864288258, 863.8358711844729, 871.4727589808169, 871.7428358634187, 872.084311472954, 864.7492227254089, 865.4590880699562, 866.1598249697784, 866.7356456280863, 869.0180096490957, 626.1609443345939, 628.6793735195038, 633.0535848905869, 633.7940169444903, 633.9492840572743, 12759.170653907466, 12779.0, 12926.224426534343, 13010.089293749441, 13022.893054090413, 11191.0, 11217.775644487147, 11300.660980170607, 11553.595624153115, 11638.243514171552, 10106.545205465773, 10223.693289201336, 10275.588976440933, 10289.073983341535, 10482.58069677212, 3372.15696075981, 3385.4752513360468, 3548.8048157351336, 3587.1032241939515, 3613.1509095362567, 44110.77944610256, 45496.0, 45540.178392864575, 45645.543544564796, 48458.757706211596, 7549.7357592483995, 7564.735234266775, 7932.960335198287, 8044.316233120133, 8053.516788992679, 12993.155444896052, 13006.934965325112, 13056.21662700241, 13081.869181308255, 13111.934440327928, 6607.966960165265, 6872.862542749117, 6981.89527157093, 7074.080369551925, 7198.352148306678, 4290.849820256276, 4344.391785150082, 4360.324149756792, 4419.46966364032, 4471.955280447219, 2787.567926971323, 2807.073665690358, 2807.7332653397893, 2814.2260878258644, 2820.8166469179437, 440.73115399606854, 446.0387864152756, 450.85572616762323, 453.36981595582165, 454.18020473045806, 541.8807862270294, 603.9909401358983, 625.9843503912348, 639.3318981664172, 667.0784434836319, 8057.395695322874, 8505.31957443403, 8626.223639872316, 8704.6518139275, 8778.429402088845, 480.9110314591812, 586.9354371019184, 624.406813527151, 647.9254885688206, 662.2715013485224, 4021.678265738734, 4114.814833332507, 4116.732412393185, 4125.731827431207, 4178.623923846869, 57013.71493142591, 58580.12129818056, 59159.704201478715, 59245.0, 59531.0, 50236.24645630318, 50379.74810125926, 50398.49601504012, 50521.0, 50554.74722626437, 47245.0, 47256.0, 48549.5145048545, 49026.50973490362, 49679.75160124176, 8253.33973282148, 8257.463264887763, 8532.744017679479, 8551.444156129832, 9078.81842363136, 35530.46704299489, 35846.46230306495, 36110.0, 36422.4536631956, 37032.62967370292, 46431.30353044639, 46660.53339466562, 46686.0, 47252.29121563248, 47436.7628161857, 10699.197560182862, 10772.622958196425, 10872.532208152115, 10914.672559823219, 11232.0, 12207.084468665063, 12255.877441225473, 12323.75352492963, 12953.805692914426, 12955.481780729042, 10698.518566664674, 10843.837342439712, 10875.40185289785, 10975.176861735243, 11285.548578056785, 11277.32336059839, 11438.94280528592, 11539.0, 11547.307161570332, 12012.159148859846, 10708.73228169302, 10886.67339979802, 10965.067969222706, 10968.890311096788, 11341.943290283496, 9930.503474826086, 9940.801183976424, 9962.452065136487, 9962.913014160462, 10093.495325233856, 8609.274802545198, 8891.777705557153, 9200.861987070333, 9288.860667090134, 9440.622375104918]}, "summary": {"lowerIsBetter": false, "suite": 6752.247571703647, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6845.084013736153, "unit": "ms", "value": 6845.084013736153}, "dojo.html": {"lowerIsBetter": false, "filtered": 5559.927332452596, "unit": "ms", "value": 5559.927332452596}, "mootools.html": {"lowerIsBetter": false, "filtered": 4433.17006375823, "unit": "ms", "value": 4433.17006375823}, "ext.html": {"lowerIsBetter": false, "filtered": 17982.78870478178, "unit": "ms", "value": 17982.78870478178}, "prototype.html": {"lowerIsBetter": false, "filtered": 5090.474629311263, "unit": "ms", "value": 5090.474629311263}, "yui.html": {"lowerIsBetter": false, "filtered": 6135.905860159885, "unit": "ms", "value": 6135.905860159885}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-036.e"}, "testrun": {"date": 1447594581, "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": "20151115030440", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 164.0, 162.0, 163.0, 162.0, 163.0, 164.0, 165.0, 171.0, 161.0], "ai-astar": [110.0, 108.0, 112.0, 111.0, 111.0, 123.0, 111.0, 110.0, 112.0, 111.0], "imaging-gaussian-blur": [110.0, 111.0, 109.0, 110.0, 110.0, 109.0, 110.0, 112.0, 110.0, 111.0], "audio-beat-detection": [151.0, 126.0, 153.0, 170.0, 127.0, 147.0, 158.0, 128.0, 171.0, 126.0], "json-stringify-tinderbox": [70.0, 70.0, 70.0, 70.0, 70.0, 72.0, 70.0, 70.0, 70.0, 72.0], "stanford-crypto-pbkdf2": [137.0, 151.0, 150.0, 148.0, 161.0, 147.0, 146.0, 150.0, 147.0, 138.0], "json-parse-financial": [61.0, 60.0, 61.0, 60.0, 61.0, 69.0, 61.0, 67.0, 59.0, 58.0], "stanford-crypto-sha256-iterative": [68.0, 66.0, 68.0, 69.0, 67.0, 66.0, 70.0, 68.0, 67.0, 66.0], "audio-fft": [72.0, 73.0, 72.0, 142.0, 74.0, 73.0, 72.0, 73.0, 166.0, 72.0], "imaging-darkroom": [147.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 148.0], "stanford-crypto-ccm": [126.0, 122.0, 117.0, 121.0, 124.0, 122.0, 120.0, 125.0, 124.0, 122.0], "audio-oscillator": [94.0, 90.0, 136.0, 89.0, 92.0, 91.0, 133.0, 91.0, 89.0, 140.0], "stanford-crypto-aes": [84.0, 84.0, 95.0, 85.0, 83.0, 83.0, 83.0, 83.0, 83.0, 87.0], "imaging-desaturate": [96.0, 98.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1522.8000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 88.9, "unit": "ms", "value": 88.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.5, "unit": "ms", "value": 147.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.3, "unit": "ms", "value": 122.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 61.7, "unit": "ms", "value": 61.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.5, "unit": "ms", "value": 104.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.9, "unit": "ms", "value": 111.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.6, "unit": "ms", "value": 163.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.5, "unit": "ms", "value": 67.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.4, "unit": "ms", "value": 70.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.2, "unit": "ms", "value": 110.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-036.e"}, "testrun": {"date": 1447594581, "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": "20151115030440", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.09937888198758], "Encrypt": [284.2524161455372], "NavierStokes": [4835.748792270531], "Decrypt": [5035.175879396985], "Splay": [597.1394517282479], "Richards": [167.42005692281936], "RegExp": [25075.0], "Earley": [729.3946024799417], "Boyer": [12207.317073170732], "RayTrace": [1060.4453870625662]}, "summary": {"lowerIsBetter": false, "suite": 21339.710148198614, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.63993600000003, "unit": "score", "value": 340.63993600000003}, "Encrypt": {"lowerIsBetter": false, "filtered": 936.4247580000001, "unit": "score", "value": 936.4247580000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 136.46896007984037, "unit": "score", "value": 136.46896007984037}, "RegExp": {"lowerIsBetter": false, "filtered": 36.33040877367896, "unit": "score", "value": 36.33040877367896}, "Richards": {"lowerIsBetter": false, "filtered": 210.8588460000001, "unit": "score", "value": 210.8588460000001}, "Earley": {"lowerIsBetter": false, "filtered": 913.7207730000002, "unit": "score", "value": 913.7207730000002}, "Boyer": {"lowerIsBetter": false, "filtered": 54.595370629370635, "unit": "score", "value": 54.595370629370635}, "RayTrace": {"lowerIsBetter": false, "filtered": 697.809627, "unit": "score", "value": 697.809627}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-036.e"}, "testrun": {"date": 1447594581, "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": "20151115030440", "branch": "Firefox", "revision": "51fa3e0d4f7bb2bf3457261091b1cb7a75e1255d"}}] 05:56:34 INFO - RETURN: dromaeo_css: 6752.25 05:56:34 INFO - RETURN: kraken: 1522.80 05:56:34 INFO - RETURN: v8_7: 21339.71 05:56:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21339.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1522.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6752.25"}}} 05:56:34 INFO - Return code: 0 05:56:34 INFO - # TBPL SUCCESS # 05:56:34 INFO - Running post-action listener: _resource_record_post_action 05:56:34 INFO - Running post-run listener: _resource_record_post_run 05:56:36 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 32768; Write bytes: 525475840; Read time: 68; Write time: 1136276 05:56:36 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 185155584; Read time: 0; Write time: 514960 05:56:36 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 32768; Write bytes: 297328640; Read time: 68; Write time: 535208 05:56:36 INFO - Running post-run listener: _upload_blobber_files 05:56:36 INFO - Blob upload gear active. 05:56:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:56:36 INFO - Copying logs to upload dir... 05:56:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.514443 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-15 05:56:35.961508) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 05:56:35.965334) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010021 build_url: 'https://queue.taskcluster.net/v1/task/cJaAQ0nuTlGzlH4dKo-nww/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 05:56:36.016002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:56:36.016340) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1447590687.444223-907211073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 05:56:36.065729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 05:56:36.066078) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 05:56:36.066527) ========= ========= Total master_lag: 0.25 =========