builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1447836575.23 results: success (0) buildid: 20151117223006 builduid: da3b9537e9f34aa5bc1f493a39f0db43 revision: eb3016abd37db2e6a6d923265047e84b12c0af61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.230279) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.230713) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.231012) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006523 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.269011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.269333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.311962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.312246) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.361805) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.362115) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.362532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.362843) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 00:49: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-18 00:49:35 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177738 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.553548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.553842) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022757 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.604408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:35.604713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb3016abd37db2e6a6d923265047e84b12c0af61 --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 eb3016abd37db2e6a6d923265047e84b12c0af61 --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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 00:49:36,080 truncating revision to first 12 chars 2015-11-18 00:49:36,081 Setting DEBUG logging. 2015-11-18 00:49:36,081 attempt 1/10 2015-11-18 00:49:36,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb3016abd37d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 00:49:36,338 unpacking tar archive at: mozilla-central-eb3016abd37d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553071 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:36.172394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:36.172844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:36.183902) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:36.184372) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:49:36.184985) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-18 00:49:36.185477) ========= /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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:49:36 INFO - MultiFileLogger online at 20151118 00:49:36 in /builds/slave/test-pgo 00:49: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 00:49:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:49:36 INFO - {'append_to_log': False, 00:49:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:49:36 INFO - 'blob_upload_branch': 'Firefox', 00:49:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:49:36 INFO - 'branch': 'Firefox', 00:49:36 INFO - 'buildbot_json_path': 'buildprops.json', 00:49:36 INFO - 'config_files': ('talos/linux_config.py',), 00:49:36 INFO - 'default_actions': ('clobber', 00:49:36 INFO - 'read-buildbot-config', 00:49:36 INFO - 'download-and-extract', 00:49:36 INFO - 'populate-webroot', 00:49:36 INFO - 'create-virtualenv', 00:49:36 INFO - 'install', 00:49:36 INFO - 'run-tests'), 00:49:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:49:36 INFO - 'download_minidump_stackwalk': True, 00:49:36 INFO - 'download_symbols': 'ondemand', 00:49:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:49:36 INFO - 'tooltool.py': '/tools/tooltool.py', 00:49:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:49:36 INFO - '/tools/misc-python/virtualenv.py')}, 00:49:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:49:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:49:36 INFO - 'installer_path': 'installer.exe', 00:49:36 INFO - 'log_level': 'info', 00:49:36 INFO - 'log_name': 'talos', 00:49:36 INFO - 'log_to_console': True, 00:49:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:49:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:49:36 INFO - 'opt_config_files': (), 00:49:36 INFO - 'pip_index': False, 00:49:36 INFO - 'sps_profile': False, 00:49:36 INFO - 'sps_profile_interval': 0, 00:49:36 INFO - 'suite': 'dromaeojs-e10s', 00:49:36 INFO - 'system_bits': '64', 00:49:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:49:36 INFO - 'title': 'talos-linux64-ix-009', 00:49:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:49:36 INFO - 'use_talos_json': True, 00:49:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:49:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:49:36 INFO - 'work_dir': 'build'} 00:49:36 INFO - ##### 00:49:36 INFO - ##### Running clobber step. 00:49:36 INFO - ##### 00:49:36 INFO - Running pre-action listener: _resource_record_pre_action 00:49:36 INFO - Running main action method: clobber 00:49:36 INFO - rmtree: /builds/slave/test-pgo/build 00:49:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:49:37 INFO - Running post-action listener: _resource_record_post_action 00:49:37 INFO - ##### 00:49:37 INFO - ##### Running read-buildbot-config step. 00:49:37 INFO - ##### 00:49:37 INFO - Running pre-action listener: _resource_record_pre_action 00:49:37 INFO - Running main action method: read_buildbot_config 00:49:37 INFO - Using buildbot properties: 00:49:37 INFO - { 00:49:37 INFO - "properties": { 00:49:37 INFO - "buildnumber": 547, 00:49:37 INFO - "product": "firefox", 00:49:37 INFO - "script_repo_revision": "production", 00:49:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:49:37 INFO - "repository": "", 00:49:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 00:49:37 INFO - "buildid": "20151117223006", 00:49:37 INFO - "slavename": "talos-linux64-ix-009", 00:49:37 INFO - "pgo_build": "True", 00:49:37 INFO - "basedir": "/builds/slave/test-pgo", 00:49:37 INFO - "project": "", 00:49:37 INFO - "platform": "ubuntu64_hw", 00:49:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:49:37 INFO - "slavebuilddir": "test", 00:49:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 00:49:37 INFO - "branch": "mozilla-central", 00:49:37 INFO - "repo_path": "mozilla-central", 00:49:37 INFO - "stage_platform": "linux64-pgo", 00:49:37 INFO - "builduid": "da3b9537e9f34aa5bc1f493a39f0db43", 00:49:37 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 00:49:37 INFO - }, 00:49:37 INFO - "sourcestamp": { 00:49:37 INFO - "repository": "", 00:49:37 INFO - "hasPatch": false, 00:49:37 INFO - "project": "", 00:49:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:49:37 INFO - "changes": [ 00:49:37 INFO - { 00:49:37 INFO - "category": null, 00:49:37 INFO - "files": [ 00:49:37 INFO - { 00:49:37 INFO - "url": null, 00:49:37 INFO - "name": "https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:49:37 INFO - } 00:49:37 INFO - ], 00:49:37 INFO - "repository": "", 00:49:37 INFO - "rev": "eb3016abd37db2e6a6d923265047e84b12c0af61", 00:49:37 INFO - "who": "sendchange", 00:49:37 INFO - "when": 1447836505, 00:49:37 INFO - "number": 6676408, 00:49:37 INFO - "comments": "", 00:49:37 INFO - "project": "", 00:49:37 INFO - "at": "Wed 18 Nov 2015 00:48:25", 00:49:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 00:49:37 INFO - "revlink": "", 00:49:37 INFO - "properties": [ 00:49:37 INFO - [ 00:49:37 INFO - "buildid", 00:49:37 INFO - "20151117223006", 00:49:37 INFO - "Change" 00:49:37 INFO - ], 00:49:37 INFO - [ 00:49:37 INFO - "builduid", 00:49:37 INFO - "da3b9537e9f34aa5bc1f493a39f0db43", 00:49:37 INFO - "Change" 00:49:37 INFO - ], 00:49:37 INFO - [ 00:49:37 INFO - "pgo_build", 00:49:37 INFO - "True", 00:49:37 INFO - "Change" 00:49:37 INFO - ] 00:49:37 INFO - ], 00:49:37 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 00:49:37 INFO - } 00:49:37 INFO - ], 00:49:37 INFO - "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61" 00:49:37 INFO - } 00:49:37 INFO - } 00:49:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:49:37 INFO - Running post-action listener: _resource_record_post_action 00:49:37 INFO - ##### 00:49:37 INFO - ##### Running download-and-extract step. 00:49:37 INFO - ##### 00:49:37 INFO - Running pre-action listener: _resource_record_pre_action 00:49:37 INFO - Running main action method: download_and_extract 00:49:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:49: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')]} 00:49:37 INFO - https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/test_packages.json 00:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/test_packages.json 00:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:49:41 INFO - Downloaded 1302 bytes. 00:49:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:49:41 INFO - Using the following test package requirements: 00:49:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:49:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'jsshell-linux-x86_64.zip'], 00:49:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:49:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:49:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:49:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:49:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:49:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:49:41 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')]} 00:49:41 INFO - https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:44 INFO - Downloaded 22461357 bytes. 00:49: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 00:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49: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 00:49:45 INFO - Return code: 0 00:49:45 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 00:49: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')]} 00:49:45 INFO - https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:47 INFO - Downloaded 22461357 bytes. 00:49:47 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 00:49:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:49:47 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 00:49:48 INFO - Return code: 0 00:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:48 INFO - https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:50 INFO - Downloaded 11131693 bytes. 00:49:50 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 00:49:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:50 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 00:49:50 INFO - Return code: 0 00:49: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')]} 00:49:50 INFO - https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/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 00:49:52 INFO - Downloaded 57191911 bytes. 00:49:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:52 INFO - mkdir: /builds/slave/test-pgo/properties 00:49:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:49:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:49:52 INFO - Contents: 00:49:52 INFO - build_url:https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:49:52 INFO - Running post-action listener: _resource_record_post_action 00:49:52 INFO - Running post-action listener: set_extra_try_arguments 00:49:52 INFO - ##### 00:49:52 INFO - ##### Running populate-webroot step. 00:49:52 INFO - ##### 00:49:52 INFO - Running pre-action listener: _resource_record_pre_action 00:49:52 INFO - Running main action method: populate_webroot 00:49:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:49:52 INFO - '../fennec_ids.txt'], 00:49:52 INFO - 'tests': ['tcheck2']}, 00:49:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:52 INFO - '--tppagecycles', 00:49:52 INFO - '7'], 00:49:52 INFO - 'tests': ['tsvgm']}}, 00:49:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:49:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:49:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'tests': ['damp', 'tps']}, 00:49:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['damp', 'tps']}, 00:49:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:49:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:52 INFO - 'other': {'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'other_l64': {'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'other_nol64': {'tests': ['a11yr', 00:49:52 INFO - 'ts_paint', 00:49:52 INFO - 'tpaint', 00:49:52 INFO - 'sessionrestore', 00:49:52 INFO - 'sessionrestore_no_auto_restore']}, 00:49:52 INFO - 'svgr': {'tests': ['tsvgx', 00:49:52 INFO - 'tsvgr_opacity', 00:49:52 INFO - 'tart', 00:49:52 INFO - 'tscrollx', 00:49:52 INFO - 'cart']}, 00:49:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['tsvgx', 00:49:52 INFO - 'tsvgr_opacity', 00:49:52 INFO - 'tart', 00:49:52 INFO - 'tscrollx', 00:49:52 INFO - 'cart']}, 00:49:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'tests': ['tp5o']}, 00:49:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'talos_options': ['--e10s'], 00:49:52 INFO - 'tests': ['tp5o']}, 00:49:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'talos_options': ['--xperf_path', 00:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:52 INFO - 'tests': ['tp5n']}, 00:49:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:52 INFO - 'talos_options': ['--e10s', 00:49:52 INFO - '--xperf_path', 00:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:52 INFO - 'tests': ['tp5n']}}, 00:49:52 INFO - 'talos.zip': {'path': '', 00:49:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:52 INFO - Running post-action listener: _resource_record_post_action 00:49:52 INFO - ##### 00:49:52 INFO - ##### Running create-virtualenv step. 00:49:52 INFO - ##### 00:49:52 INFO - Running pre-action listener: _resource_record_pre_action 00:49:52 INFO - Running main action method: create_virtualenv 00:49:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:49:52 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 00:49:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:49:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:52 INFO - Using real prefix '/usr' 00:49:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:49:52 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:54 INFO - Installing pip.................done. 00:49:54 INFO - Return code: 0 00:49:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:54 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:49:54 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 00:49:54 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 00:49:54 INFO - Using env: {'DISPLAY': ':0', 00:49:54 INFO - 'HOME': '/home/cltbld', 00:49:54 INFO - 'LANG': 'en_US.UTF-8', 00:49:54 INFO - 'LANGUAGE': 'en_US:en', 00:49:54 INFO - 'LOGNAME': 'cltbld', 00:49:54 INFO - 'MAIL': '/var/mail/cltbld', 00:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:54 INFO - 'MOZ_NO_REMOTE': '1', 00:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:54 INFO - 'NO_EM_RESTART': '1', 00:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:54 INFO - 'SHELL': '/bin/bash', 00:49:54 INFO - 'SHLVL': '1', 00:49:54 INFO - 'TERM': 'linux', 00:49:54 INFO - 'TMOUT': '86400', 00:49:54 INFO - 'USER': 'cltbld', 00:49:54 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:54 INFO - '_': '/tools/buildbot/bin/python'} 00:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:55 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 00:49:55 INFO - Cleaning up... 00:49:55 INFO - Return code: 0 00:49:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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', '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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:49: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:49: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 psutil>=0.7.1 00:49:55 INFO - Using env: {'DISPLAY': ':0', 00:49:55 INFO - 'HOME': '/home/cltbld', 00:49:55 INFO - 'LANG': 'en_US.UTF-8', 00:49:55 INFO - 'LANGUAGE': 'en_US:en', 00:49:55 INFO - 'LOGNAME': 'cltbld', 00:49:55 INFO - 'MAIL': '/var/mail/cltbld', 00:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:55 INFO - 'MOZ_NO_REMOTE': '1', 00:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:55 INFO - 'NO_EM_RESTART': '1', 00:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:55 INFO - 'SHELL': '/bin/bash', 00:49:55 INFO - 'SHLVL': '1', 00:49:55 INFO - 'TERM': 'linux', 00:49:55 INFO - 'TMOUT': '86400', 00:49:55 INFO - 'USER': 'cltbld', 00:49:55 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:55 INFO - '_': '/tools/buildbot/bin/python'} 00:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:55 INFO - Downloading/unpacking psutil>=0.7.1 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:49:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:57 INFO - Installing collected packages: psutil 00:49:57 INFO - Running setup.py install for psutil 00:49:57 INFO - building 'psutil._psutil_linux' extension 00:49:57 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 00:49:57 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 00:49:57 INFO - building 'psutil._psutil_posix' extension 00:49:57 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 00:49:57 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 00:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:57 INFO - Successfully installed psutil 00:49:57 INFO - Cleaning up... 00:49:57 INFO - Return code: 0 00:49:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:49:57 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')]} 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 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')]} 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:49:57 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 00:49:57 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 00:49:57 INFO - Using env: {'DISPLAY': ':0', 00:49:57 INFO - 'HOME': '/home/cltbld', 00:49:57 INFO - 'LANG': 'en_US.UTF-8', 00:49:57 INFO - 'LANGUAGE': 'en_US:en', 00:49:57 INFO - 'LOGNAME': 'cltbld', 00:49:57 INFO - 'MAIL': '/var/mail/cltbld', 00:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:57 INFO - 'MOZ_NO_REMOTE': '1', 00:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:57 INFO - 'NO_EM_RESTART': '1', 00:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:57 INFO - 'SHELL': '/bin/bash', 00:49:57 INFO - 'SHLVL': '1', 00:49:57 INFO - 'TERM': 'linux', 00:49:57 INFO - 'TMOUT': '86400', 00:49:57 INFO - 'USER': 'cltbld', 00:49:57 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:57 INFO - '_': '/tools/buildbot/bin/python'} 00:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:49:59 INFO - Installing collected packages: mozsystemmonitor 00:49:59 INFO - Running setup.py install for mozsystemmonitor 00:49:59 INFO - Successfully installed mozsystemmonitor 00:49:59 INFO - Cleaning up... 00:49:59 INFO - Return code: 0 00:49:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:59 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:49:59 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 00:49:59 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 00:49:59 INFO - Using env: {'DISPLAY': ':0', 00:49:59 INFO - 'HOME': '/home/cltbld', 00:49:59 INFO - 'LANG': 'en_US.UTF-8', 00:49:59 INFO - 'LANGUAGE': 'en_US:en', 00:49:59 INFO - 'LOGNAME': 'cltbld', 00:49:59 INFO - 'MAIL': '/var/mail/cltbld', 00:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:59 INFO - 'MOZ_NO_REMOTE': '1', 00:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:59 INFO - 'NO_EM_RESTART': '1', 00:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:59 INFO - 'SHELL': '/bin/bash', 00:49:59 INFO - 'SHLVL': '1', 00:49:59 INFO - 'TERM': 'linux', 00:49:59 INFO - 'TMOUT': '86400', 00:49:59 INFO - 'USER': 'cltbld', 00:49:59 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:59 INFO - '_': '/tools/buildbot/bin/python'} 00:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:59 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - Downloading blobuploader-1.2.4.tar.gz 00:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:50:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:50:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:50:02 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 00:50:02 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 00:50:02 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 00:50:02 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 00:50:02 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 00:50:02 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 00:50:02 INFO - Downloading docopt-0.6.1.tar.gz 00:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:50:02 INFO - Installing collected packages: blobuploader, requests, docopt 00:50:02 INFO - Running setup.py install for blobuploader 00:50:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:50:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:50:02 INFO - Running setup.py install for requests 00:50:02 INFO - Running setup.py install for docopt 00:50:02 INFO - Successfully installed blobuploader requests docopt 00:50:02 INFO - Cleaning up... 00:50:02 INFO - Return code: 0 00:50:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:50: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')]} 00:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50: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')]} 00:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:02 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:50:02 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 00:50:02 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 00:50:02 INFO - Using env: {'DISPLAY': ':0', 00:50:02 INFO - 'HOME': '/home/cltbld', 00:50:02 INFO - 'LANG': 'en_US.UTF-8', 00:50:02 INFO - 'LANGUAGE': 'en_US:en', 00:50:02 INFO - 'LOGNAME': 'cltbld', 00:50:02 INFO - 'MAIL': '/var/mail/cltbld', 00:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:02 INFO - 'MOZ_NO_REMOTE': '1', 00:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:02 INFO - 'NO_EM_RESTART': '1', 00:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:02 INFO - 'SHELL': '/bin/bash', 00:50:02 INFO - 'SHLVL': '1', 00:50:02 INFO - 'TERM': 'linux', 00:50:02 INFO - 'TMOUT': '86400', 00:50:02 INFO - 'USER': 'cltbld', 00:50:02 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:02 INFO - '_': '/tools/buildbot/bin/python'} 00:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:50:03 INFO - Running setup.py (path:/tmp/pip-oYC0Wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:50:03 INFO - Running setup.py (path:/tmp/pip-7Fs7PB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:50:03 INFO - Running setup.py (path:/tmp/pip-MTVKKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:50:03 INFO - Running setup.py (path:/tmp/pip-ZWqbX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:50:03 INFO - Running setup.py (path:/tmp/pip-AApKto-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:50:03 INFO - Running setup.py (path:/tmp/pip-m3aD70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:50:03 INFO - Running setup.py (path:/tmp/pip-HkXMJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:50:03 INFO - Running setup.py (path:/tmp/pip-Xk3A2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:50:03 INFO - Running setup.py (path:/tmp/pip-Ny7FU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:50:03 INFO - Running setup.py (path:/tmp/pip-0ZHLZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:50:03 INFO - Running setup.py (path:/tmp/pip-UVr7gP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:50:03 INFO - Running setup.py (path:/tmp/pip-nUpHpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:50:03 INFO - Running setup.py (path:/tmp/pip-lisG1Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:50:04 INFO - Running setup.py (path:/tmp/pip-W9Yq7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:50:04 INFO - Running setup.py (path:/tmp/pip-7CpcP_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:50:04 INFO - Running setup.py (path:/tmp/pip-0Ef5pE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:50:04 INFO - Running setup.py (path:/tmp/pip-B1sIZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:50:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:50:04 INFO - Running setup.py install for manifestparser 00:50:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:50:04 INFO - Running setup.py install for mozcrash 00:50:04 INFO - Running setup.py install for mozdebug 00:50:04 INFO - Running setup.py install for mozdevice 00:50:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:50:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:50:04 INFO - Running setup.py install for mozfile 00:50:04 INFO - Running setup.py install for mozhttpd 00:50:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:50:04 INFO - Running setup.py install for mozinfo 00:50:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for mozInstall 00:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for mozleak 00:50:05 INFO - Running setup.py install for mozlog 00:50:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for moznetwork 00:50:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for mozprocess 00:50:05 INFO - Running setup.py install for mozprofile 00:50:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for mozrunner 00:50:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:50:05 INFO - Running setup.py install for mozscreenshot 00:50:05 INFO - Running setup.py install for moztest 00:50:05 INFO - Running setup.py install for mozversion 00:50:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:50:06 INFO - Cleaning up... 00:50:06 INFO - Return code: 0 00:50:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:06 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:50:06 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 00:50:06 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 00:50:06 INFO - Using env: {'DISPLAY': ':0', 00:50:06 INFO - 'HOME': '/home/cltbld', 00:50:06 INFO - 'LANG': 'en_US.UTF-8', 00:50:06 INFO - 'LANGUAGE': 'en_US:en', 00:50:06 INFO - 'LOGNAME': 'cltbld', 00:50:06 INFO - 'MAIL': '/var/mail/cltbld', 00:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:06 INFO - 'MOZ_NO_REMOTE': '1', 00:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:06 INFO - 'NO_EM_RESTART': '1', 00:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:06 INFO - 'SHELL': '/bin/bash', 00:50:06 INFO - 'SHLVL': '1', 00:50:06 INFO - 'TERM': 'linux', 00:50:06 INFO - 'TMOUT': '86400', 00:50:06 INFO - 'USER': 'cltbld', 00:50:06 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:06 INFO - '_': '/tools/buildbot/bin/python'} 00:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:50:06 INFO - Running setup.py (path:/tmp/pip-k1Q5R_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:50:06 INFO - Running setup.py (path:/tmp/pip-UR7KU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:50:06 INFO - Running setup.py (path:/tmp/pip-HSdDay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:50:06 INFO - Running setup.py (path:/tmp/pip-_AxXW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:50:06 INFO - Running setup.py (path:/tmp/pip-alxVQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:50:06 INFO - Running setup.py (path:/tmp/pip-2jAwPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:50:06 INFO - Running setup.py (path:/tmp/pip-Xc0Bbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:50:06 INFO - Running setup.py (path:/tmp/pip-1PcJRA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:50:06 INFO - Running setup.py (path:/tmp/pip-IWFXiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:50:06 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)) 00:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:50:06 INFO - Running setup.py (path:/tmp/pip-khG6hL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:50:07 INFO - Running setup.py (path:/tmp/pip-JvTm4y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:50:07 INFO - Running setup.py (path:/tmp/pip-4nIi8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:50:07 INFO - Running setup.py (path:/tmp/pip-dl2GZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:50:07 INFO - Running setup.py (path:/tmp/pip-6efsK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:50:07 INFO - Running setup.py (path:/tmp/pip-Cip8xp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:50:07 INFO - Running setup.py (path:/tmp/pip-t1AR2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:50:07 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)) 00:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:50:07 INFO - Running setup.py (path:/tmp/pip-uuzTxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:50:07 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)) 00:50:07 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)) 00:50:07 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)) 00:50:07 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)) 00:50:07 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)) 00:50:07 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)) 00:50:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:50:07 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 00:50:07 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 00:50:07 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 00:50:07 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 00:50:07 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 00:50:07 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 00:50:09 INFO - Downloading blessings-1.5.1.tar.gz 00:50:09 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 00:50:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:50:09 INFO - Installing collected packages: blessings 00:50:09 INFO - Running setup.py install for blessings 00:50:09 INFO - Successfully installed blessings 00:50:09 INFO - Cleaning up... 00:50:09 INFO - Return code: 0 00:50:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:50:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:50:09 INFO - Reading from file tmpfile_stdout 00:50:09 INFO - Current package versions: 00:50:09 INFO - argparse == 1.2.1 00:50:09 INFO - blessings == 1.5.1 00:50:09 INFO - blobuploader == 1.2.4 00:50:09 INFO - docopt == 0.6.1 00:50:09 INFO - manifestparser == 1.1 00:50:09 INFO - mozInstall == 1.12 00:50:09 INFO - mozcrash == 0.16 00:50:09 INFO - mozdebug == 0.1 00:50:09 INFO - mozdevice == 0.47 00:50:09 INFO - mozfile == 1.2 00:50:09 INFO - mozhttpd == 0.7 00:50:09 INFO - mozinfo == 0.9 00:50:09 INFO - mozleak == 0.1 00:50:09 INFO - mozlog == 3.0 00:50:09 INFO - moznetwork == 0.27 00:50:09 INFO - mozprocess == 0.22 00:50:09 INFO - mozprofile == 0.27 00:50:09 INFO - mozrunner == 6.11 00:50:09 INFO - mozscreenshot == 0.1 00:50:09 INFO - mozsystemmonitor == 0.0 00:50:09 INFO - moztest == 0.7 00:50:09 INFO - mozversion == 1.4 00:50:09 INFO - psutil == 3.1.1 00:50:09 INFO - requests == 1.2.3 00:50:09 INFO - wsgiref == 0.1.2 00:50:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:50:09 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')]} 00:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:09 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')]} 00:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:09 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 0x7f6267cbac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16386c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f93d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', '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 00:50:09 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 00:50:09 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 00:50:09 INFO - Using env: {'DISPLAY': ':0', 00:50:09 INFO - 'HOME': '/home/cltbld', 00:50:09 INFO - 'LANG': 'en_US.UTF-8', 00:50:09 INFO - 'LANGUAGE': 'en_US:en', 00:50:09 INFO - 'LOGNAME': 'cltbld', 00:50:09 INFO - 'MAIL': '/var/mail/cltbld', 00:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:09 INFO - 'MOZ_NO_REMOTE': '1', 00:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:09 INFO - 'NO_EM_RESTART': '1', 00:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:09 INFO - 'SHELL': '/bin/bash', 00:50:09 INFO - 'SHLVL': '1', 00:50:09 INFO - 'TERM': 'linux', 00:50:09 INFO - 'TMOUT': '86400', 00:50:09 INFO - 'USER': 'cltbld', 00:50:09 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:09 INFO - '_': '/tools/buildbot/bin/python'} 00:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 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)) 00:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:50:09 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)) 00:50:09 INFO - Cleaning up... 00:50:09 INFO - Return code: 0 00:50:09 INFO - Running post-action listener: _resource_record_post_action 00:50:09 INFO - Running post-action listener: _start_resource_monitoring 00:50:09 INFO - Starting resource monitoring. 00:50:09 INFO - ##### 00:50:09 INFO - ##### Running install step. 00:50:09 INFO - ##### 00:50:09 INFO - Running pre-action listener: _resource_record_pre_action 00:50:09 INFO - Running main action method: install 00:50:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:50:10 INFO - Reading from file tmpfile_stdout 00:50:10 INFO - Detecting whether we're running mozinstall >=1.0... 00:50:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:50:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:50:10 INFO - Reading from file tmpfile_stdout 00:50:10 INFO - Output received: 00:50:10 INFO - Usage: mozinstall [options] installer 00:50:10 INFO - Options: 00:50:10 INFO - -h, --help show this help message and exit 00:50:10 INFO - -d DEST, --destination=DEST 00:50:10 INFO - Directory to install application into. [default: 00:50:10 INFO - "/builds/slave/test-pgo"] 00:50:10 INFO - --app=APP Application being installed. [default: firefox] 00:50:10 INFO - mkdir: /builds/slave/test-pgo/build/application 00:50:10 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'] 00:50:10 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 00:50:24 INFO - Reading from file tmpfile_stdout 00:50:24 INFO - Output received: 00:50:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:50:24 INFO - Running post-action listener: _resource_record_post_action 00:50:24 INFO - ##### 00:50:24 INFO - ##### Running run-tests step. 00:50:24 INFO - ##### 00:50:24 INFO - Running pre-action listener: _resource_record_pre_action 00:50:24 INFO - Running main action method: run_tests 00:50:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:50:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:50:24 INFO - Python 2.7.3 00:50:24 INFO - Return code: 0 00:50:24 INFO - grabbing minidump binary from tooltool 00:50:24 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')]} 00:50:24 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 0x17828c0>, '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 0x172f420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172f8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:50:24 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 00:50:24 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 00:50:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:50:24 INFO - Return code: 0 00:50:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:50:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:50:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:50:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:24 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/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:50:24 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/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 00:50:24 INFO - Using env: {'DISPLAY': ':0', 00:50:24 INFO - 'HOME': '/home/cltbld', 00:50:24 INFO - 'LANG': 'en_US.UTF-8', 00:50:24 INFO - 'LANGUAGE': 'en_US:en', 00:50:24 INFO - 'LOGNAME': 'cltbld', 00:50:24 INFO - 'MAIL': '/var/mail/cltbld', 00:50:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:24 INFO - 'MOZ_NO_REMOTE': '1', 00:50:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:24 INFO - 'NO_EM_RESTART': '1', 00:50:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:24 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:50:24 INFO - 'SHELL': '/bin/bash', 00:50:24 INFO - 'SHLVL': '1', 00:50:24 INFO - 'TERM': 'linux', 00:50:24 INFO - 'TMOUT': '86400', 00:50:24 INFO - 'USER': 'cltbld', 00:50:24 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334', 00:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:24 INFO - '_': '/tools/buildbot/bin/python'} 00:50:24 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/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 00:50:24 INFO - mozversion INFO | application_buildid: 20151117223006 00:50:24 INFO - mozversion INFO | application_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 00:50:24 INFO - mozversion INFO | application_display_name: Nightly 00:50:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:50:24 INFO - mozversion INFO | application_name: Firefox 00:50:24 INFO - mozversion INFO | application_remotingname: firefox 00:50:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 00:50:24 INFO - mozversion INFO | application_vendor: Mozilla 00:50:24 INFO - mozversion INFO | application_version: 45.0a1 00:50:24 INFO - mozversion INFO | platform_buildid: 20151117223006 00:50:24 INFO - mozversion INFO | platform_changeset: eb3016abd37db2e6a6d923265047e84b12c0af61 00:50:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 00:50:24 INFO - mozversion INFO | platform_version: 45.0a1 00:50:24 INFO - 2015-11-18 00:50:24,848 DEBUG : using testdate: 1447836624 00:50:24 INFO - 2015-11-18 00:50:24,848 DEBUG : actual date: 1447836624 00:50:24 INFO - 2015-11-18 00:50:24,926 INFO : starting webserver on 'localhost:54964' 00:50:24 INFO - 2015-11-18 00:50:24,927 INFO : Starting test suite talos-linux64-ix-009.e 00:50:24 INFO - 2015-11-18 00:50:24,927 INFO : Starting test dromaeo_css 00:50:24 INFO - 2015-11-18 00:50:24,927 DEBUG : operating with platform_type : linux_ 00:50:24 INFO - 2015-11-18 00:50:24,928 INFO : Initialising browser for dromaeo_css test... 00:50:24 INFO - 2015-11-18 00:50:24,944 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB5nQ1Q/profile http://localhost:54964/getInfo.html 00:50:29 INFO - 2015-11-18 00:50:29,307 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:50:29 INFO - 2015-11-18 00:50:29,308 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:50:29 INFO - 2015-11-18 00:50:29,308 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:50:29 INFO - 2015-11-18 00:50:29,308 DEBUG : BROWSER_OUTPUT: __metrics 00:50:30 INFO - 2015-11-18 00:50:30,261 INFO : Browser initialized. 00:50:30 INFO - 2015-11-18 00:50:30,262 INFO : Running cycle 1/1 for dromaeo_css test... 00:50:30 INFO - 2015-11-18 00:50:30,262 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB5nQ1Q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:50:42 INFO - 2015-11-18 00:50:42,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 141869056 00:50:42 INFO - 2015-11-18 00:50:42,105 DEBUG : BROWSER_OUTPUT: 00:51:31 INFO - 2015-11-18 00:51:31,744 DEBUG : BROWSER_OUTPUT: 1447836691743 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] 00:53:40 INFO - 2015-11-18 00:53:40,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54964/tests/dromaeo/cssquery-ext.html) 00:53:41 INFO - 2015-11-18 00:53:41,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 145514496 00:53:41 INFO - 2015-11-18 00:53:41,283 DEBUG : BROWSER_OUTPUT: 00:56:43 INFO - 2015-11-18 00:56:43,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-ext.html (next: http://localhost:54964/tests/dromaeo/cssquery-jquery.html) 00:56:43 INFO - 2015-11-18 00:56:43,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 140746752 00:56:43 INFO - 2015-11-18 00:56:43,762 DEBUG : BROWSER_OUTPUT: 00:59:45 INFO - 2015-11-18 00:59:45,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54964/tests/dromaeo/cssquery-mootools.html) 00:59:46 INFO - 2015-11-18 00:59:46,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 00:59:46 INFO - 2015-11-18 00:59:46,072 DEBUG : BROWSER_OUTPUT: 01:02:47 INFO - 2015-11-18 01:02:47,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54964/tests/dromaeo/cssquery-prototype.html) 01:02:48 INFO - 2015-11-18 01:02:48,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 140611584 01:02:48 INFO - 2015-11-18 01:02:48,382 DEBUG : BROWSER_OUTPUT: 01:05:50 INFO - 2015-11-18 01:05:50,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54964/tests/dromaeo/cssquery-yui.html) 01:05:51 INFO - 2015-11-18 01:05:51,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 140353536 01:05:51 INFO - 2015-11-18 01:05:51,395 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/dromaeo/cssquery-yui.html (next: http://localhost:54964/tests/dromaeo/cssquery-dojo.html) 01:08:53 INFO - 2015-11-18 01:08:53,862 DEBUG : BROWSER_OUTPUT: RSS: Main: 144084992 01:08:53 INFO - 2015-11-18 01:08:53,862 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,864 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:08:53 INFO - 2015-11-18 01:08:53,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:08:53 INFO - 2015-11-18 01:08:53,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:08:53 INFO - 2015-11-18 01:08:53,864 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:08:53 INFO - 2015-11-18 01:08:53,865 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3178.475551533996;3234.935301293974;3258.820764857935;3275.279438523524;3276.524903888936;5113.769880355384;5364.758585863636;5379.38137114232;5390.487903649157;5398.730063496829;5243.292155558998;5349.839504814861;5353.304070470834;5358.517733403993;5375.543078838294;4847.878803029926;4948.2330238812865;5002.424721157077;5016.824411145611;5040.067587496306;4897.314375987365;4962.982588569334;4988.102141614508;5075.238714192864;5095.6178286628465;4784.210605250129;4900.681455705368;4903.583195428393;4976.253561965716;4988.2766998785155;4950.232713929347;4999.775010124553;5015.749212539358;5032.7735251913755;5041.72270525121;4959.82640607577;4990.201567749179;5009.298698182258;5019.949800501985;5042.319286896259;5068.315777370045;5106.5659418949435;5159.509846564571;5268.130758424855;5296.867578310573;5819.243498345188;5848.97075514624;5849.2980842298775;5897.911531327033;5904.232449781501;5882.411758824083;5892.292924849003;5900.43945825146;5914;5930.7034648267845;5207.713575753332;5308.893822123536;5375.166849138351;5465.180222966507;5515.448455154493;5901.852453688606;5971.58198926071;5975.4024597540765;5997.610155339889;6022.1870047543025;5727.4845263926445;5806.622569532967;5809.854753631109;5813.709314534256;5815.505682016991;5683.9715801420725;5733.082706766897;5813.854653633608;5821.126830975303;5833.591648584558;5729.684867332337;5821.79623713168;5822.592418530662;5841.795537156179;5842.2405087338375;5701.572382071278;5769.307683078057;5779.624324418899;5809.738561764731;5813;4410.6030457259;4487;4489.775511224426;4510.323451482304;4538.228501154812;3968.6428221460205;3987.900302492461;3991.7604943703473;4004.1591265833918;4029.4560234367987;5314.149736042292;5384.542313903362;5488.094464413407;5488.56091512678;5500.119980803132;5706.686132262766;5711.657300561979;5802.303723553201;5803.7388317524965;5852.7658893643775;5461.098918678374;5543.334799824047;5558.166275058774;5562.805301814498;5572.247746554244;4952.5542701157065;5057.266696329012;5075.923861142012;5078.162103252922;5135.589152867761;5878.206442130343;5941.613795103304;5984.162217289496;6002.609830361012;6031.2159419276095;5816.767329306949;5840.94159058421;5874.765009399576;5899.734511946886;5909.763609455574;5875.529957603467;6044;6075.756969721162;6082.118092876596;6084.452399284086;5654.6324488908085;5747.913781293368;5760.855978600569;5764.308283006066;5806.796762113306;5696.088625820014;5720.256366672473;5735.197072409783;5767.509761670305;5769.74036168365;5445.782168713207;5595.132754423071;5624.606277560531;5638.802641907513;5639.548836093185;5589.5807814413265;5654.378018418053;5676.659400435987;5677.943220567741;5721.22763426932;5562.137868630369;5580.888382232414;5580.916286255629;5592.86017849557;5594.664320140804;5612.971935140298;5634.464725851038;5647.802326918538;5695.1457281406465;5735.885282294247;5486.698231597141;5508.476694713996;5556.777728890799;5567.387587365306;5575.358833734173 01:08:53 INFO - 2015-11-18 01:08:53,867 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.3261620822598;602.5360472436224;605.6941244671443;609.0559632569517;615.532195531396;38711.80644096779;39730.40404393933;39813.40279895797;39876;39890.202195956066;40815.79592102043;41639.37540936881;41661;41757.164856702926;41989.37015944756;8638.65445382184;8767.824643507127;8808.075152109033;8815.911840881574;8828.161324674145;8450.957745211266;8621.61202745878;8633.611487483078;8643.956780216091;8662.956685216564;8730;8745.7813554661;8768.34237432192;8785.472871627722;8811.867821982676;8722.956385218065;8755.737327880142;8779.078196789342;8793.912060879373;8823.294136469067;8637.740867773977;8726.86909696355;8751.606177722018;8770.649174033031;8771.956140219321;38104.80947595244;38284.617153828665;38445.423318650246;38555.80722096372;38677;3206.70086486753;3292.818894960776;3960.3465428204313;3965.167314863882;3970.4838371011874;28687.84841136902;28872.711272887213;29012.854935725187;30046.84976575103;30060.8496957516;3244.205169733407;3279.5736554248033;3295.47272436409;3309.420851351004;3382.3573521030926;276279;276513;276994;277116;277845;41336.37995430071;41808.74573762792;52926.20610690843;53121.468785311656;53267.40692227338;43338.78330608327;43412.56587434085;43509.78245108754;43543.34684979728;43782.56217437849;13483.247177866815;13526.120802147829;13550.254735989614;13626.523071692642;13636.113652612548;12168.026557875348;12182.634520964386;12203.14577979533;12259.632211033504;12265.816012759815;13878.861211387959;13886.93056534711;13957.441702331997;13977.930110349384;13996.370163342674;5898.734556944948;5903.439173278532;5907.497862681635;5971.671558064349;5986.7904623338845;922.0410772796217;932.4545141092401;951.9809603808023;965.1603105298435;1078.4823284823171;26784.732152678225;27302.453950921266;27412.45175096527;27428.588571171447;27807.58288625672;1062.8830828608848;1069.3316677076828;1092.4974511724536;1102.795982743195;1182.9526818927318;14404.207768572829;14414;14509.637259068608;14598.63503412402;14741.115533067836;393743;395723;396623.0168849195;397352;398256;52720;53380.466195338326;53529.1970620441;53543.464565354625;53555.46444535505;1333.999500374719;1334.9199048057149;1349.3118509560195;1350.770369037266;1357.545222350504;26511.867440662674;27381.589276160474;27584.586231206948;27675.86162069177;27953.860230698716;43735;43837;43905;43963.56036439723;44210;302940;303260;304026;304665;305689;32430.189245269055;44562.77718611386;44970.77514612537;45431.7728411369;45456.31815522704;42643.36034959416;42731.3590296152;42755.35866961936;42901;42935.570644293155;35761;35904.28191436209;36173.638263617024;36253.27493450169;36562.63437365592;35953;36146.63853361433;36171;36368.636313636525;36640;35116.29767404689;35571;35587.288254234256;35665;35666.10834729153;31122.377552449278;32313.35373292568;32747.83626081854;32998.83500582482;33361.83319083389;24195.516089677756;24537.509249814546;24562.63156052625;24715.50568988574;24984.250472485855 01:08:53 INFO - 2015-11-18 01:08:53,867 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.78189522496046;353.1013570463173;356.24831605312767;358.7201982453685;362.298951528792;11230.719232019204;11598.130140239473;16621.584460388498;17009.31962721491;17527.123643817806;16961.830381696178;17000.744988825147;17037.82962170378;17315.22081506332;17429.651406971854;5727.198192253088;6007.549433792461;6014.428629280212;6025.216721826157;6033.577649564532;6083.482903953147;6093.146959425684;6099.664518451484;6104.084387341912;6749.325067493236;6274.560780745327;6444;6899.44804415648;6910.585364878123;6919.273476284993;6398.840028999289;6399.392057754506;6427.807165784987;6457.096006559062;6848.452123830081;6541.836454088686;6570.868582628368;6586.341365863424;6595.241547222083;6595.769148079842;20581.38255852327;21908.23321183751;22144.446388840246;22187.778122218893;22795.658065129035;2157.590057888996;2162;2189.419803752007;2199.714037175173;2255.7405898321576;14046.789298160536;14059;14231.715365692628;14603.634909127357;14642.121472711671;1749.1953701297418;1841.3279153109152;2040.6530889748778;2059.7116403703344;2066.276803118911;64937;66281.33718662849;66535;66911.330886691;68286;15943.681126377407;16018.519444416686;16132.596685082966;16145.112018839076;16164.272607732444;23516.529669406515;23517.17689880846;23520.294391168292;23748.406289842547;23776.762232377456;8718.476891386537;8725.127487251224;8773.736787896374;8778.341624378198;8925.821483570293;7354.338109570164;7595.734149304748;7606.125295590967;7632.274933881273;7736.497127686683;7931.405144614177;7959.721409750747;8011.238932301422;8058.597070146587;8073.7577872663915;1215.671768622467;3103.8603262853226;3127.5308703694172;3194.8242846643193;3279.426100432415;472.17840956735034;491.4863967154332;503.4889587069128;511.2944137090791;513.3249776543832;11758;11821.763564728657;11881.287122772661;12011.159218854596;12093.939530302292;517.4334104155943;526.5287567626953;528.5586535243038;535.5501378841792;544.1185279846595;6540.9345906541275;6855.951553658374;6888.655567221619;6947.7220911163995;6960.269171736996;542943;544716;550753;584685;592362;72699;75109;75884;76599.61700191464;77255.61372193103;559.1221781802612;572.4533070917264;573.1231216239161;573.5411670663452;574.1731906055351;10744.785104297714;10814.243002989715;11158.051565616688;11302.547898083985;11498.310101393943;32716.50925236171;32902.83548582242;33852.66147338594;33922.49116263209;33965.3206935855;41257.79371103246;46310;48320.75839620779;48609.756951215015;48977.2653410192;6882.724691012504;6904.378605925491;6922.826929326807;6987.580745155307;6987.615681137586;12508.624741257778;12627.30549819732;12779.680507987374;12801;12952.093353465167;9102.681406150752;10805.243632945618;10899.891001090205;11096.167787415814;11267.492962816857;10471.738206544896;10567.52446139941;10570.471476426303;10650.627228046982;10687.091597214323;10398.636047738293;10650.881657425858;10782.460876955964;10791.730206744895;11117.83323250168;6788.558743681645;6813.4889883257965;6824.044633751378;6849;6850.657467126524;10621.256512044083;10639.787204256027;10899.400532970763;10900.291481054024;11092.889071109508 01:08:53 INFO - 2015-11-18 01:08:53,868 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.2652886821024;1677.8070521889981;1738.8261173882613;1745.711957527008;1747.685416625007;6552.705128269227;6659.067730517731;7374.483786134972;7736.613169341538;7744.4966077204945;7207.53151045183;7379.335859772619;7440.330370266675;7444.739434119807;7490.250974902507;2261.0390584001816;2301.4016355747544;2306.3772781349026;2308.73449553301;2313.363824948144;2240.115154513974;2279.7150356205475;2328.1269523928527;2344.202970989863;2347.1784875293683;2210.071769856656;2219.9556008879895;2240.6863039174527;2312.2600767754325;2328.499372634883;2277.9772202278014;2294.2314324701247;2320.663503791949;2326.8603883767028;2344.120954642001;2350.0952133428755;2366.0181024874655;2368.3723813189517;2375.7386687464364;2384.237044145874;7560.886586701204;7630.656620452093;7639.274268944441;7641.465097443125;7687.500312479671;4636.142313671948;4709.646776491777;4715.033418149271;4757.024809913959;4757.26262429324;2974.6579143398353;3004.4141392428487;3052.450558899397;3068;3072.9078127656207;1057.3391630231106;1059.1791361694748;1107.7341438054889;1138.3852719531444;1142.6686260984304;10384.221183411199;10441.738956526071;10448.05967462932;10450.216233782498;10471.528781204865;4225.556316586775;4295;4331.6318112960125;4334.934975975363;4351.956480435155;8952.552372381355;8960.103989600988;8972.506512141765;8980.146886045815;8992.100789921087;4629.305604159403;4640.373549570832;4647.070585882837;4685.390899183152;4701.1537923174155;4180.770057646859;4233.153369326147;4255.340422234559;4277.443932288845;4279.144171165779;3488.843002064913;3576.481410195507;3593.5148754918273;3629.927401451956;3662.6154253802965;1037.8547003419528;1047.450088703437;1053.0991560233851;1053.6048981631889;1081.4106312059946;1273.1279073834453;1280.8142819291152;1288.7422515496937;1310.194230548206;1320.9009324300523;6959.930400696029;6968.731328420654;6982.47631427645;7009.684564194624;7071.434285257167;499.7576175554853;509.081108598975;511.41443047710163;512.6667666017045;518.1967949678059;5597.524210442077;5604.355499117572;5621.156826476062;5621.381648018714;5682.374938756733;8755.168259015383;9032.548372581476;9168.954155229181;9275.76810579741;9356.204722598655;9017.954910225408;9067.501287429255;9159.313051521163;9203.907960920305;9236.353455258068;7087.078679771596;7155.570665760071;7171.820704482326;7232.276772322831;7237.927620723831;6941.861162776615;6951.9304806953305;6961.61711105894;6977.232504424611;6986.720531178696;7989.362180752815;8052.114267430695;8092.514449133071;8094.311983481234;8279.544625045439;8290.917090829014;8293.751187464386;8312.25189732927;8340.624671889658;8431.662733490592;6072.939270607414;6319.210098737658;6444.9033264502;6474.741010359533;6509.4792416605615;7046.753363632249;7262.963685181751;7312.96343518279;7320.743773967885;7345.485815992829;6741.966290168518;6933;6943.479239057192;6956.5478243916;7058.294170582901;6592.044153597605;6647.069410282661;6726;6776.254611992578;6810.693518791567;6704.296048914794;6829.726810927507;6832.0435139081565;6869.347411996052;6902.723891044302;6354.459870911024;6378.74485020594;6391.424771770563;6391.936080639134;6394.680265986589;6328.208973878265;6347.460465860454;6368.395002474757;6372;6374.776882809079 01:08:53 INFO - 2015-11-18 01:08:53,869 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.8045172896264;331.3952037531504;345.8789423701705;347.19450873972386;348.2964411887986;6273.184486016818;6286.811395658132;6310;6389.329120442357;6536.901946470807;6276.686165691709;6325.355407594024;6354.14219080424;6360.427561519462;6386.744530218785;4804.231322988314;4812.278158276269;4822.445418776851;4824.710517368969;4830.227163653816;4782.473927867949;4814.566688997989;4817.78319975602;4829.420469543659;4831.251156070814;4678.8596342109795;4736.9341898072835;4746.477887432379;4751.3585665935;4784.928226076611;4749.216379297412;4751.738654374008;4759.071980963713;4773.140834649779;4782.7608619569055;4115.773632450214;4124.319487284594;4127.566605506408;4128;4137.924139723664;6050.909236361458;6054.606450580698;6056.9697151513965;6059.2728872535135;6060;5422.864428389322;5541.33503979521;5562.721863906829;5564.86087847803;5568.248286481355;6720.025596288559;6745.886928656766;6749.595024298509;6756.4932630052945;6765.458763298973;4576.222042252792;4577.473590537097;4588.541145885418;4588.862334129982;4594.448666160049;6848.657567121624;6899.517033807636;6977.720891164347;7025.367716905452;7030.683619237096;4660.370849935215;4707.529247075265;4711.269753188261;4726.503717109723;4733.124371991193;4744.810207591658;4764.499727528629;4766.356541866873;4783.6651434399255;4791.760411979387;5526.751296191681;5557.694326812064;5558;5559.833205003856;5570.61005729595;6567.868642627121;6757.898631520531;6765.797026089225;6813.7955861324235;6814.318568143245;1641.9507414777577;1653.7188677924541;1683.293016932891;1684.8904821186584;1687.7721507596318;1100.5542755184163;1105.8451816745662;1123.152020224725;1123.9831402528969;1127.887211278882;6391.169148010729;6394.904076438857;6398.232212134573;6421.068945002949;6426.068220108058;6828.795136145924;6840.760573379908;6842;6851.760188393482;6877.277885822016;6374.960012795954;6379.266384365765;6425.3574642536305;6431.035344698239;6432.4532414744335;3789.7536660117003;3793.9241215175543;3821.2739579479808;3826.674732647756;3829;7247.275272472816;7262.20115787263;7287.380572651278;7301.123865136112;7313;7058.223595404502;7225.710971561184;7244.058272424656;7244.529105608119;7251.23861994483;7245.384142347854;7271.200167981624;7285.4171666266575;7290.489665723455;7299.854002919912;6975.6163411012885;6985.057017302599;7013.2986701329455;7018.6490675465;7049.682764275723;6762.154730658668;6937.410320122644;6953.965230173817;6975.511714179958;7010.824729381806;7291;7318.1949985502615;7325.267473252632;7326.04761381017;7327.2672732726305;4699.060187962353;4735.408073990751;4739.360186374795;4740.336352910526;4740.407449068866;6836.17965844082;6853.554518956451;7046.189688185719;7046.894296585658;7050.647467626701;6810.761623343159;6813.4889883257965;6839.2818754032105;6846.5892046477375;6854.828629284308;6778.288279730755;6788.898166527605;6789.660516974231;6799.93200067993;6800.727970881109;6527.9020814688765;6637.303083176197;6679.8664026718225;6689.2307384651385;6706.295838936841;6782.355676210949;6807.863842723019;6819.147606549182;6828;6831.45348372139;6583.604983700993;6601.3728695773825;6642.767503137367;6653.1018312527185;6660.733570657313 01:08:53 INFO - 2015-11-18 01:08:53,870 DEBUG : BROWSER_OUTPUT: |5;yui.html;690.8894576867699;698.4035782038641;763.9197884222157;813.4224700462671;823.2590668398441;12329.938350308246;12677.366131693412;12680.682982925431;12705.682357941056;12723.681907952283;12628.052896032812;12792.808107878389;12811.487540498392;12814.615561533168;12825.615231543068;783.0681489028067;807.547773246982;821.9301359384459;825.3768404854327;829.2909562324186;822.8230930349973;824.579464473117;825.8761185822144;826.2687521543447;830.5515021888173;831.9043310019365;833.2417500074934;836.5148214035875;840.64272684109;841.2008591837779;824.1881746479683;834.7412302186342;836.0636087581947;836.5273620404482;836.782436566491;609.4271384898182;610.7343305662051;612.0268772651461;612.4365583662997;612.4702132655266;12886.613401597968;12981.026423018311;12985.675358116028;12986.155899866479;12986.675333116747;8818.426802257833;9225.953870230673;9438.858417123749;9913.851292230622;10240.28318017739;9847.842997359188;9984.650537231162;10045.69862904114;10116.89883101167;10176.898231017669;3178.523221516768;3190.8245046522666;3217.3886961477247;3250.6313477219173;3300.2079500919845;41586.37620435696;42302.78848605768;45941;46424.53575464236;46491;6860.759873404407;6985.476089293324;6991.93008069923;7057.18842333128;7145;11446.14153938458;11553.942230288794;11569.710757231136;11574;11588.246763960316;6541.803745887631;6760.695768690421;6800.591964482147;6857.9657101715175;6865.9313406866295;4275.337322714984;4416.293393057095;4468.4637843458995;4569.383133277031;4594.287885377772;2723.6731592208666;2724.9046283380385;2727.972720272812;2764.5714914188334;2803.5934789455414;442.8937055106751;455.3238440915238;455.61500532050366;459.2697610798846;461.87991122308443;654.5745265577413;662.1458318768831;673.3737624009718;677.6103740349221;737.3990197988729;8767.12328767131;9085.273178145733;9283.953580232055;9362.765930851783;9725.9027409725;612.6691586543217;690.6063543779998;693.38635307753;709.2411120101546;709.5139829217003;4001.519817621904;4176.519700234512;4279.293916503804;4305.418768466279;4386.692931494828;61193;61291.693541532004;61440.69279653573;61491.692541537006;61560.69219653873;54389.45610543923;54434.72782636061;54589.454105459234;55145.172822407694;55745.721271393384;49081;49103.75448122808;49455.50544494581;50567.74716126396;50796;8611.181937715906;8657.653693852428;8785.385023048326;8806.691765788166;8892.377533572846;35645.287094258485;35855.28289434144;36468.635313646526;36523.08692282608;37053.81473092617;42062;42210.78894605507;45622.54377456316;46856.765716172566;46928.530714693785;10960.835587466036;11022.669319920415;11028.834567481656;11092.057175140204;11146.275492093313;11804.232724872856;11864.466099025392;11965.880341196476;12088.879111208775;12334.81497777552;10331.121854642439;10430.739231519272;10490.160787137163;10508.894911050791;10881.347119172875;10119.311751185473;10180.643677471253;10197.388156710622;10217.540210690686;10853.294535855144;9842.409455432697;9919.900800991898;10136.18910487174;10611.151107911503;10637.840432393676;8997;9165.816683666422;9176.311776616647;9372;9454;8462.547709923527;8672;8955.283577313669;9378.812423751351;9459.38513996588 01:08:53 INFO - 2015-11-18 01:08:53,870 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837733862__endTimestamp 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:08:53 INFO - 2015-11-18 01:08:53,871 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,872 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5392.36 Median:5580.89 stddev:594.34 (10.6%) stddev-sans-first:570.22 01:08:53 INFO - 2015-11-18 01:08:53,872 DEBUG : BROWSER_OUTPUT: Values: 3178.5 3234.9 3258.8 3275.3 3276.5 5113.8 5364.8 5379.4 5390.5 5398.7 5243.3 5349.8 5353.3 5358.5 5375.5 4847.9 4948.2 5002.4 5016.8 5040.1 4897.3 4963.0 4988.1 5075.2 5095.6 4784.2 4900.7 4903.6 4976.3 4988.3 4950.2 4999.8 5015.7 5032.8 5041.7 4959.8 4990.2 5009.3 5019.9 5042.3 5068.3 5106.6 5159.5 5268.1 5296.9 5819.2 5849.0 5849.3 5897.9 5904.2 5882.4 5892.3 5900.4 5914.0 5930.7 5207.7 5308.9 5375.2 5465.2 5515.4 5901.9 5971.6 5975.4 5997.6 6022.2 5727.5 5806.6 5809.9 5813.7 5815.5 5684.0 5733.1 5813.9 5821.1 5833.6 5729.7 5821.8 5822.6 5841.8 5842.2 5701.6 5769.3 5779.6 5809.7 5813.0 4410.6 4487.0 4489.8 4510.3 4538.2 3968.6 3987.9 3991.8 4004.2 4029.5 5314.1 5384.5 5488.1 5488.6 5500.1 5706.7 5711.7 5802.3 5803.7 5852.8 5461.1 5543.3 5558.2 5562.8 5572.2 4952.6 5057.3 5075.9 5078.2 5135.6 5878.2 5941.6 5984.2 6002.6 6031.2 5816.8 5840.9 5874.8 5899.7 5909.8 5875.5 6044.0 6075.8 6082.1 6084.5 5654.6 5747.9 5760.9 5764.3 5806.8 5696.1 5720.3 5735.2 5767.5 5769.7 5445.8 5595.1 5624.6 5638.8 5639.5 5589.6 5654.4 5676.7 5677.9 5721.2 5562.1 5580.9 5580.9 5592.9 5594.7 5613.0 5634.5 5647.8 5695.1 5735.9 5486.7 5508.5 5556.8 5567.4 5575.4 01:08:53 INFO - 2015-11-18 01:08:53,872 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,872 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48211.03 Median:38365.02 stddev:86713.07 (226.0%) stddev-sans-first:86882.49 01:08:53 INFO - 2015-11-18 01:08:53,873 DEBUG : BROWSER_OUTPUT: Values: 552.3 602.5 605.7 609.1 615.5 38711.8 39730.4 39813.4 39876.0 39890.2 40815.8 41639.4 41661.0 41757.2 41989.4 8638.7 8767.8 8808.1 8815.9 8828.2 8451.0 8621.6 8633.6 8644.0 8663.0 8730.0 8745.8 8768.3 8785.5 8811.9 8723.0 8755.7 8779.1 8793.9 8823.3 8637.7 8726.9 8751.6 8770.6 8772.0 38104.8 38284.6 38445.4 38555.8 38677.0 3206.7 3292.8 3960.3 3965.2 3970.5 28687.8 28872.7 29012.9 30046.8 30060.8 3244.2 3279.6 3295.5 3309.4 3382.4 276279.0 276513.0 276994.0 277116.0 277845.0 41336.4 41808.7 52926.2 53121.5 53267.4 43338.8 43412.6 43509.8 43543.3 43782.6 13483.2 13526.1 13550.3 13626.5 13636.1 12168.0 12182.6 12203.1 12259.6 12265.8 13878.9 13886.9 13957.4 13977.9 13996.4 5898.7 5903.4 5907.5 5971.7 5986.8 922.0 932.5 952.0 965.2 1078.5 26784.7 27302.5 27412.5 27428.6 27807.6 1062.9 1069.3 1092.5 1102.8 1183.0 14404.2 14414.0 14509.6 14598.6 14741.1 393743.0 395723.0 396623.0 397352.0 398256.0 52720.0 53380.5 53529.2 53543.5 53555.5 1334.0 1334.9 1349.3 1350.8 1357.5 26511.9 27381.6 27584.6 27675.9 27953.9 43735.0 43837.0 43905.0 43963.6 44210.0 302940.0 303260.0 304026.0 304665.0 305689.0 32430.2 44562.8 44970.8 45431.8 45456.3 42643.4 42731.4 42755.4 42901.0 42935.6 35761.0 35904.3 36173.6 36253.3 36562.6 35953.0 36146.6 36171.0 36368.6 36640.0 35116.3 35571.0 35587.3 35665.0 35666.1 31122.4 32313.4 32747.8 32998.8 33361.8 24195.5 24537.5 24562.6 24715.5 24984.3 01:08:53 INFO - 2015-11-18 01:08:53,873 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,873 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29378.28 Median:23391.09 stddev:92053.97 (393.5%) stddev-sans-first:92286.41 01:08:53 INFO - 2015-11-18 01:08:53,874 DEBUG : BROWSER_OUTPUT: Values: 351.8 353.1 356.2 358.7 362.3 11230.7 11598.1 16621.6 17009.3 17527.1 16961.8 17000.7 17037.8 17315.2 17429.7 5727.2 6007.5 6014.4 6025.2 6033.6 6083.5 6093.1 6099.7 6104.1 6749.3 6274.6 6444.0 6899.4 6910.6 6919.3 6398.8 6399.4 6427.8 6457.1 6848.5 6541.8 6570.9 6586.3 6595.2 6595.8 20581.4 21908.2 22144.4 22187.8 22795.7 2157.6 2162.0 2189.4 2199.7 2255.7 14046.8 14059.0 14231.7 14603.6 14642.1 1749.2 1841.3 2040.7 2059.7 2066.3 64937.0 66281.3 66535.0 66911.3 68286.0 15943.7 16018.5 16132.6 16145.1 16164.3 23516.5 23517.2 23520.3 23748.4 23776.8 8718.5 8725.1 8773.7 8778.3 8925.8 7354.3 7595.7 7606.1 7632.3 7736.5 7931.4 7959.7 8011.2 8058.6 8073.8 1215.7 3103.9 3127.5 3194.8 3279.4 472.2 491.5 503.5 511.3 513.3 11758.0 11821.8 11881.3 12011.2 12093.9 517.4 526.5 528.6 535.6 544.1 6540.9 6856.0 6888.7 6947.7 6960.3 542943.0 544716.0 550753.0 584685.0 592362.0 72699.0 75109.0 75884.0 76599.6 77255.6 559.1 572.5 573.1 573.5 574.2 10744.8 10814.2 11158.1 11302.5 11498.3 32716.5 32902.8 33852.7 33922.5 33965.3 41257.8 46310.0 48320.8 48609.8 48977.3 6882.7 6904.4 6922.8 6987.6 6987.6 12508.6 12627.3 12779.7 12801.0 12952.1 9102.7 10805.2 10899.9 11096.2 11267.5 10471.7 10567.5 10570.5 10650.6 10687.1 10398.6 10650.9 10782.5 10791.7 11117.8 6788.6 6813.5 6824.0 6849.0 6850.7 10621.3 10639.8 10899.4 10900.3 11092.9 01:08:53 INFO - 2015-11-18 01:08:53,875 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,875 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5324.26 Median:6196.07 stddev:2730.95 (44.1%) stddev-sans-first:2723.36 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: Values: 1484.3 1677.8 1738.8 1745.7 1747.7 6552.7 6659.1 7374.5 7736.6 7744.5 7207.5 7379.3 7440.3 7444.7 7490.3 2261.0 2301.4 2306.4 2308.7 2313.4 2240.1 2279.7 2328.1 2344.2 2347.2 2210.1 2220.0 2240.7 2312.3 2328.5 2278.0 2294.2 2320.7 2326.9 2344.1 2350.1 2366.0 2368.4 2375.7 2384.2 7560.9 7630.7 7639.3 7641.5 7687.5 4636.1 4709.6 4715.0 4757.0 4757.3 2974.7 3004.4 3052.5 3068.0 3072.9 1057.3 1059.2 1107.7 1138.4 1142.7 10384.2 10441.7 10448.1 10450.2 10471.5 4225.6 4295.0 4331.6 4334.9 4352.0 8952.6 8960.1 8972.5 8980.1 8992.1 4629.3 4640.4 4647.1 4685.4 4701.2 4180.8 4233.2 4255.3 4277.4 4279.1 3488.8 3576.5 3593.5 3629.9 3662.6 1037.9 1047.5 1053.1 1053.6 1081.4 1273.1 1280.8 1288.7 1310.2 1320.9 6959.9 6968.7 6982.5 7009.7 7071.4 499.8 509.1 511.4 512.7 518.2 5597.5 5604.4 5621.2 5621.4 5682.4 8755.2 9032.5 9169.0 9275.8 9356.2 9018.0 9067.5 9159.3 9203.9 9236.4 7087.1 7155.6 7171.8 7232.3 7237.9 6941.9 6951.9 6961.6 6977.2 6986.7 7989.4 8052.1 8092.5 8094.3 8279.5 8290.9 8293.8 8312.3 8340.6 8431.7 6072.9 6319.2 6444.9 6474.7 6509.5 7046.8 7263.0 7313.0 7320.7 7345.5 6742.0 6933.0 6943.5 6956.5 7058.3 6592.0 6647.1 6726.0 6776.3 6810.7 6704.3 6829.7 6832.0 6869.3 6902.7 6354.5 6378.7 6391.4 6391.9 6394.7 6328.2 6347.5 6368.4 6372.0 6374.8 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5629.18 Median:6390.25 stddev:1725.40 (27.0%) stddev-sans-first:1683.69 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: Values: 325.8 331.4 345.9 347.2 348.3 6273.2 6286.8 6310.0 6389.3 6536.9 6276.7 6325.4 6354.1 6360.4 6386.7 4804.2 4812.3 4822.4 4824.7 4830.2 4782.5 4814.6 4817.8 4829.4 4831.3 4678.9 4736.9 4746.5 4751.4 4784.9 4749.2 4751.7 4759.1 4773.1 4782.8 4115.8 4124.3 4127.6 4128.0 4137.9 6050.9 6054.6 6057.0 6059.3 6060.0 5422.9 5541.3 5562.7 5564.9 5568.2 6720.0 6745.9 6749.6 6756.5 6765.5 4576.2 4577.5 4588.5 4588.9 4594.4 6848.7 6899.5 6977.7 7025.4 7030.7 4660.4 4707.5 4711.3 4726.5 4733.1 4744.8 4764.5 4766.4 4783.7 4791.8 5526.8 5557.7 5558.0 5559.8 5570.6 6567.9 6757.9 6765.8 6813.8 6814.3 1642.0 1653.7 1683.3 1684.9 1687.8 1100.6 1105.8 1123.2 1124.0 1127.9 6391.2 6394.9 6398.2 6421.1 6426.1 6828.8 6840.8 6842.0 6851.8 6877.3 6375.0 6379.3 6425.4 6431.0 6432.5 3789.8 3793.9 3821.3 3826.7 3829.0 7247.3 7262.2 7287.4 7301.1 7313.0 7058.2 7225.7 7244.1 7244.5 7251.2 7245.4 7271.2 7285.4 7290.5 7299.9 6975.6 6985.1 7013.3 7018.6 7049.7 6762.2 6937.4 6954.0 6975.5 7010.8 7291.0 7318.2 7325.3 7326.0 7327.3 4699.1 4735.4 4739.4 4740.3 4740.4 6836.2 6853.6 7046.2 7046.9 7050.6 6810.8 6813.5 6839.3 6846.6 6854.8 6778.3 6788.9 6789.7 6799.9 6800.7 6527.9 6637.3 6679.9 6689.2 6706.3 6782.4 6807.9 6819.1 6828.0 6831.5 6583.6 6601.4 6642.8 6653.1 6660.7 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13511.49 Median:50681.87 stddev:16620.91 (32.8%) stddev-sans-first:16639.65 01:08:53 INFO - 2015-11-18 01:08:53,876 DEBUG : BROWSER_OUTPUT: Values: 690.9 698.4 763.9 813.4 823.3 12329.9 12677.4 12680.7 12705.7 12723.7 12628.1 12792.8 12811.5 12814.6 12825.6 783.1 807.5 821.9 825.4 829.3 822.8 824.6 825.9 826.3 830.6 831.9 833.2 836.5 840.6 841.2 824.2 834.7 836.1 836.5 836.8 609.4 610.7 612.0 612.4 612.5 12886.6 12981.0 12985.7 12986.2 12986.7 8818.4 9226.0 9438.9 9913.9 10240.3 9847.8 9984.7 10045.7 10116.9 10176.9 3178.5 3190.8 3217.4 3250.6 3300.2 41586.4 42302.8 45941.0 46424.5 46491.0 6860.8 6985.5 6991.9 7057.2 7145.0 11446.1 11553.9 11569.7 11574.0 11588.2 6541.8 6760.7 6800.6 6858.0 6865.9 4275.3 4416.3 4468.5 4569.4 4594.3 2723.7 2724.9 2728.0 2764.6 2803.6 442.9 455.3 455.6 459.3 461.9 654.6 662.1 673.4 677.6 737.4 8767.1 9085.3 9284.0 9362.8 9725.9 612.7 690.6 693.4 709.2 709.5 4001.5 4176.5 4279.3 4305.4 4386.7 61193.0 61291.7 61440.7 61491.7 61560.7 54389.5 54434.7 54589.5 55145.2 55745.7 49081.0 49103.8 49455.5 50567.7 50796.0 8611.2 8657.7 8785.4 8806.7 8892.4 35645.3 35855.3 36468.6 36523.1 37053.8 42062.0 42210.8 45622.5 46856.8 46928.5 10960.8 11022.7 11028.8 11092.1 11146.3 11804.2 11864.5 11965.9 12088.9 12334.8 10331.1 10430.7 10490.2 10508.9 10881.3 10119.3 10180.6 10197.4 10217.5 10853.3 9842.4 9919.9 10136.2 10611.2 10637.8 8997.0 9165.8 9176.3 9372.0 9454.0 8462.5 8672.0 8955.3 9378.8 9459.4 01:08:53 INFO - 2015-11-18 01:08:53,877 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:08:53 INFO - 2015-11-18 01:08:53,877 DEBUG : BROWSER_OUTPUT: 01:08:54 INFO - 2015-11-18 01:08:54,586 INFO : Browser exited with error code: 0 01:08:54 INFO - 2015-11-18 01:08:54,604 INFO : Completed test dromaeo_css (00:18:29) 01:08:54 INFO - 2015-11-18 01:08:54,604 INFO : Starting test kraken 01:08:54 INFO - 2015-11-18 01:08:54,604 DEBUG : operating with platform_type : linux_ 01:08:54 INFO - 2015-11-18 01:08:54,605 INFO : Initialising browser for kraken test... 01:08:54 INFO - 2015-11-18 01:08:54,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIvAAfd/profile http://localhost:54964/getInfo.html 01:08:58 INFO - 2015-11-18 01:08:58,536 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:58 INFO - 2015-11-18 01:08:58,537 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:58 INFO - 2015-11-18 01:08:58,537 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:08:58 INFO - 2015-11-18 01:08:58,537 DEBUG : BROWSER_OUTPUT: __metrics 01:08:59 INFO - 2015-11-18 01:08:59,449 INFO : Browser initialized. 01:08:59 INFO - 2015-11-18 01:08:59,450 INFO : Running cycle 1/1 for kraken test... 01:08:59 INFO - 2015-11-18 01:08:59,450 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIvAAfd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:09:11 INFO - 2015-11-18 01:09:11,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 141668352 01:09:11 INFO - 2015-11-18 01:09:11,263 DEBUG : BROWSER_OUTPUT: 01:09:13 INFO - 2015-11-18 01:09:13,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54964/tests/kraken/driver.html?testName=audio-beat-detection) 01:09:14 INFO - 2015-11-18 01:09:14,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 01:09:14 INFO - 2015-11-18 01:09:14,324 DEBUG : BROWSER_OUTPUT: 01:09:16 INFO - 2015-11-18 01:09:16,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54964/tests/kraken/driver.html?testName=audio-dft) 01:09:17 INFO - 2015-11-18 01:09:17,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 141721600 01:09:17 INFO - 2015-11-18 01:09:17,554 DEBUG : BROWSER_OUTPUT: 01:09:20 INFO - 2015-11-18 01:09:20,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54964/tests/kraken/driver.html?testName=audio-fft) 01:09:20 INFO - 2015-11-18 01:09:20,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 136626176 01:09:20 INFO - 2015-11-18 01:09:20,986 DEBUG : BROWSER_OUTPUT: 01:09:22 INFO - 2015-11-18 01:09:22,962 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54964/tests/kraken/driver.html?testName=audio-oscillator) 01:09:23 INFO - 2015-11-18 01:09:23,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 137052160 01:09:23 INFO - 2015-11-18 01:09:23,584 DEBUG : BROWSER_OUTPUT: 01:09:25 INFO - 2015-11-18 01:09:25,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:09:26 INFO - 2015-11-18 01:09:26,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 137289728 01:09:26 INFO - 2015-11-18 01:09:26,311 DEBUG : BROWSER_OUTPUT: 01:09:29 INFO - 2015-11-18 01:09:29,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54964/tests/kraken/driver.html?testName=imaging-darkroom) 01:09:29 INFO - 2015-11-18 01:09:29,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 137211904 01:09:29 INFO - 2015-11-18 01:09:29,894 DEBUG : BROWSER_OUTPUT: 01:09:33 INFO - 2015-11-18 01:09:33,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54964/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:33 INFO - 2015-11-18 01:09:33,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 01:09:33 INFO - 2015-11-18 01:09:33,917 DEBUG : BROWSER_OUTPUT: 01:09:36 INFO - 2015-11-18 01:09:36,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54964/tests/kraken/driver.html?testName=json-parse-financial) 01:09:37 INFO - 2015-11-18 01:09:37,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 138661888 01:09:37 INFO - 2015-11-18 01:09:37,369 DEBUG : BROWSER_OUTPUT: 01:09:38 INFO - 2015-11-18 01:09:38,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:39 INFO - 2015-11-18 01:09:39,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 01:09:39 INFO - 2015-11-18 01:09:39,551 DEBUG : BROWSER_OUTPUT: 01:09:41 INFO - 2015-11-18 01:09:41,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:42 INFO - 2015-11-18 01:09:42,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 01:09:42 INFO - 2015-11-18 01:09:42,000 DEBUG : BROWSER_OUTPUT: 01:09:44 INFO - 2015-11-18 01:09:44,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:44 INFO - 2015-11-18 01:09:44,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 138985472 01:09:44 INFO - 2015-11-18 01:09:44,671 DEBUG : BROWSER_OUTPUT: 01:09:47 INFO - 2015-11-18 01:09:47,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:47 INFO - 2015-11-18 01:09:47,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 139120640 01:09:47 INFO - 2015-11-18 01:09:47,694 DEBUG : BROWSER_OUTPUT: 01:09:50 INFO - 2015-11-18 01:09:50,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:50 INFO - 2015-11-18 01:09:50,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 01:09:50 INFO - 2015-11-18 01:09:50,878 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54964/tests/kraken/driver.html?testName=ai-astar) 01:09:52 INFO - 2015-11-18 01:09:52,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 01:09:52 INFO - 2015-11-18 01:09:52,801 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,801 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:52 INFO - 2015-11-18 01:09:52,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;103;110;111;109;121;112;109;109;108 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;126;159;168;127;151;148;126;166;127 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;165;163;161;162;165;166;172;163 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;72;73;75;73;149;72;73;72 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;135;90;91;89;132;89;90;133 01:09:52 INFO - 2015-11-18 01:09:52,802 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;109;110;110;111;110 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;147;147;146;147;147;147 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;97;97;97;96;96;96;97 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;64;63;65;63;64;61;61 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;69;69;70;70;70;71;70;69 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;92;85;84;85;87;86;86;84 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;126;125;130;118;116;120;118;117;117 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;151;153;151;150;149;153;152;148;142 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;67;69;66;66;66;66;67 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:52 INFO - 2015-11-18 01:09:52,803 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:09:52 INFO - 2015-11-18 01:09:52,804 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 01:09:52 INFO - 2015-11-18 01:09:52,804 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:09:52 INFO - 2015-11-18 01:09:52,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837792800__endTimestamp 01:09:52 INFO - 2015-11-18 01:09:52,804 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,805 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:52 INFO - 2015-11-18 01:09:52,805 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:09:52 INFO - 2015-11-18 01:09:52,806 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,806 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:109.50 stddev:4.51 (4.1%) stddev-sans-first:4.76 01:09:52 INFO - 2015-11-18 01:09:52,806 DEBUG : BROWSER_OUTPUT: Values: 109.0 103.0 110.0 111.0 109.0 121.0 112.0 109.0 109.0 108.0 01:09:52 INFO - 2015-11-18 01:09:52,806 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,807 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:17.14 (11.3%) stddev-sans-first:17.94 01:09:52 INFO - 2015-11-18 01:09:52,807 DEBUG : BROWSER_OUTPUT: Values: 153.0 126.0 159.0 168.0 127.0 151.0 148.0 126.0 166.0 127.0 01:09:52 INFO - 2015-11-18 01:09:52,807 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,807 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:3.22 (2.0%) stddev-sans-first:3.21 01:09:52 INFO - 2015-11-18 01:09:52,808 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 165.0 163.0 161.0 162.0 165.0 166.0 172.0 163.0 01:09:52 INFO - 2015-11-18 01:09:52,808 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,808 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:73.00 stddev:24.05 (32.9%) stddev-sans-first:25.35 01:09:52 INFO - 2015-11-18 01:09:52,808 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 73.0 75.0 73.0 149.0 72.0 73.0 72.0 01:09:52 INFO - 2015-11-18 01:09:52,808 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,809 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:89.00 stddev:21.16 (23.8%) stddev-sans-first:21.86 01:09:52 INFO - 2015-11-18 01:09:52,809 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 135.0 90.0 91.0 89.0 132.0 89.0 90.0 133.0 01:09:52 INFO - 2015-11-18 01:09:52,809 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,809 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:09:52 INFO - 2015-11-18 01:09:52,809 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 111.0 110.0 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 63.0 65.0 63.0 64.0 61.0 61.0 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,810 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 69.0 70.0 70.0 70.0 71.0 70.0 69.0 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:2.68 (3.1%) stddev-sans-first:2.52 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 92.0 85.0 84.0 85.0 87.0 86.0 86.0 84.0 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:119.00 stddev:5.03 (4.2%) stddev-sans-first:4.97 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: Values: 115.0 126.0 125.0 130.0 118.0 116.0 120.0 118.0 117.0 117.0 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.00 stddev:3.88 (2.6%) stddev-sans-first:3.41 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: Values: 143.0 151.0 153.0 151.0 150.0 149.0 153.0 152.0 148.0 142.0 01:09:52 INFO - 2015-11-18 01:09:52,811 DEBUG : BROWSER_OUTPUT: 01:09:52 INFO - 2015-11-18 01:09:52,812 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 01:09:52 INFO - 2015-11-18 01:09:52,812 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 67.0 69.0 66.0 66.0 66.0 66.0 67.0 01:09:52 INFO - 2015-11-18 01:09:52,812 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:52 INFO - 2015-11-18 01:09:52,812 DEBUG : BROWSER_OUTPUT: 01:09:53 INFO - 2015-11-18 01:09:53,641 INFO : Browser exited with error code: 0 01:09:53 INFO - 2015-11-18 01:09:53,775 INFO : Completed test kraken (00:00:59) 01:09:53 INFO - 2015-11-18 01:09:53,775 INFO : Starting test v8_7 01:09:53 INFO - 2015-11-18 01:09:53,775 DEBUG : operating with platform_type : linux_ 01:09:53 INFO - 2015-11-18 01:09:53,775 INFO : Initialising browser for v8_7 test... 01:09:53 INFO - 2015-11-18 01:09:53,781 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5341m7/profile http://localhost:54964/getInfo.html 01:09:57 INFO - 2015-11-18 01:09:57,778 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:09:57 INFO - 2015-11-18 01:09:57,779 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:09:57 INFO - 2015-11-18 01:09:57,779 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:09:57 INFO - 2015-11-18 01:09:57,779 DEBUG : BROWSER_OUTPUT: __metrics 01:09:58 INFO - 2015-11-18 01:09:58,721 INFO : Browser initialized. 01:09:58 INFO - 2015-11-18 01:09:58,722 INFO : Running cycle 1/1 for v8_7 test... 01:09:58 INFO - 2015-11-18 01:09:58,722 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5341m7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:10:10 INFO - 2015-11-18 01:10:10,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 141811712 01:10:10 INFO - 2015-11-18 01:10:10,559 DEBUG : BROWSER_OUTPUT: 01:10:31 INFO - 2015-11-18 01:10:31,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54964/tests/v8_7/run.html (next: http://localhost:54964/tests/v8_7/run.html) 01:10:32 INFO - 2015-11-18 01:10:32,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 137814016 01:10:32 INFO - 2015-11-18 01:10:32,223 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,224 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.9487975174554 01:10:32 INFO - 2015-11-18 01:10:32,225 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.1912693854107 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1063.8297872340424 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |5;Earley;697.350069735007 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |7;RegExp;27513.513513513513 01:10:32 INFO - 2015-11-18 01:10:32,226 DEBUG : BROWSER_OUTPUT: |8;Splay;678.3546864463924 01:10:32 INFO - 2015-11-18 01:10:32,227 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 01:10:32 INFO - 2015-11-18 01:10:32,227 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:10:32 INFO - 2015-11-18 01:10:32,227 DEBUG : BROWSER_OUTPUT: __startTimestamp1447837832224__endTimestamp 01:10:32 INFO - 2015-11-18 01:10:32,227 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: Values: 166.3 01:10:32 INFO - 2015-11-18 01:10:32,228 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,229 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.95 Median:193.95 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,229 DEBUG : BROWSER_OUTPUT: Values: 193.9 01:10:32 INFO - 2015-11-18 01:10:32,229 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,230 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.19 Median:287.19 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,230 DEBUG : BROWSER_OUTPUT: Values: 287.2 01:10:32 INFO - 2015-11-18 01:10:32,230 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,230 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: Values: 5035.2 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1063.83 Median:1063.83 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: Values: 1063.8 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:697.35 Median:697.35 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: Values: 697.4 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: Values: 12195.1 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27513.51 Median:27513.51 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,231 DEBUG : BROWSER_OUTPUT: Values: 27513.5 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:678.35 Median:678.35 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: Values: 678.4 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: Values: 4854.4 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:10:32 INFO - 2015-11-18 01:10:32,232 DEBUG : BROWSER_OUTPUT: 01:10:33 INFO - 2015-11-18 01:10:33,105 INFO : Browser exited with error code: 0 01:10:33 INFO - 2015-11-18 01:10:33,120 INFO : Completed test v8_7 (00:00:39) 01:10:33 INFO - 2015-11-18 01:10:33,249 INFO : Completed test suite (00:20:08) 01:10:33 INFO - 2015-11-18 01:10:33,249 DEBUG : Working with test: dromaeo_css 01:10:33 INFO - 2015-11-18 01:10:33,249 DEBUG : Generating results file: dromaeo_css 01:10:33 INFO - 2015-11-18 01:10:33,250 DEBUG : Working with test: kraken 01:10:33 INFO - 2015-11-18 01:10:33,250 DEBUG : Generating results file: kraken 01:10:33 INFO - 2015-11-18 01:10:33,250 INFO : javascript benchmark 01:10:33 INFO - 2015-11-18 01:10:33,251 DEBUG : Working with test: v8_7 01:10:33 INFO - 2015-11-18 01:10:33,251 DEBUG : Generating results file: v8_7 01:10:33 INFO - 2015-11-18 01:10:33,251 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:33 INFO - 2015-11-18 01:10:33,395 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 01:10:33 INFO - 2015-11-18 01:10:33,395 DEBUG : process_Request line: dromaeo_css 6909.91 graph.html#tests=[[72,1,43]] 01:10:33 INFO - 2015-11-18 01:10:33,395 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:33 INFO - 2015-11-18 01:10:33,500 DEBUG : process_Request line: kraken 1511.40 graph.html#tests=[[232,1,43]] 01:10:33 INFO - 2015-11-18 01:10:33,500 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:10:33 INFO - 2015-11-18 01:10:33,536 DEBUG : process_Request line: v8_7 20955.68 graph.html#tests=[[230,1,43]] 01:10:33 INFO - 2015-11-18 01:10:33,537 INFO : javascript benchmark 01:10:33 INFO - 2015-11-18 01:10:33,541 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [351.78189522496046, 353.1013570463173, 356.24831605312767, 358.7201982453685, 362.298951528792, 11230.719232019204, 11598.130140239473, 16621.584460388498, 17009.31962721491, 17527.123643817806, 16961.830381696178, 17000.744988825147, 17037.82962170378, 17315.22081506332, 17429.651406971854, 5727.198192253088, 6007.549433792461, 6014.428629280212, 6025.216721826157, 6033.577649564532, 6083.482903953147, 6093.146959425684, 6099.664518451484, 6104.084387341912, 6749.325067493236, 6274.560780745327, 6444.0, 6899.44804415648, 6910.585364878123, 6919.273476284993, 6398.840028999289, 6399.392057754506, 6427.807165784987, 6457.096006559062, 6848.452123830081, 6541.836454088686, 6570.868582628368, 6586.341365863424, 6595.241547222083, 6595.769148079842, 20581.38255852327, 21908.23321183751, 22144.446388840246, 22187.778122218893, 22795.658065129035, 2157.590057888996, 2162.0, 2189.419803752007, 2199.714037175173, 2255.7405898321576, 14046.789298160536, 14059.0, 14231.715365692628, 14603.634909127357, 14642.121472711671, 1749.1953701297418, 1841.3279153109152, 2040.6530889748778, 2059.7116403703344, 2066.276803118911, 64937.0, 66281.33718662849, 66535.0, 66911.330886691, 68286.0, 15943.681126377407, 16018.519444416686, 16132.596685082966, 16145.112018839076, 16164.272607732444, 23516.529669406515, 23517.17689880846, 23520.294391168292, 23748.406289842547, 23776.762232377456, 8718.476891386537, 8725.127487251224, 8773.736787896374, 8778.341624378198, 8925.821483570293, 7354.338109570164, 7595.734149304748, 7606.125295590967, 7632.274933881273, 7736.497127686683, 7931.405144614177, 7959.721409750747, 8011.238932301422, 8058.597070146587, 8073.7577872663915, 1215.671768622467, 3103.8603262853226, 3127.5308703694172, 3194.8242846643193, 3279.426100432415, 472.17840956735034, 491.4863967154332, 503.4889587069128, 511.2944137090791, 513.3249776543832, 11758.0, 11821.763564728657, 11881.287122772661, 12011.159218854596, 12093.939530302292, 517.4334104155943, 526.5287567626953, 528.5586535243038, 535.5501378841792, 544.1185279846595, 6540.9345906541275, 6855.951553658374, 6888.655567221619, 6947.7220911163995, 6960.269171736996, 542943.0, 544716.0, 550753.0, 584685.0, 592362.0, 72699.0, 75109.0, 75884.0, 76599.61700191464, 77255.61372193103, 559.1221781802612, 572.4533070917264, 573.1231216239161, 573.5411670663452, 574.1731906055351, 10744.785104297714, 10814.243002989715, 11158.051565616688, 11302.547898083985, 11498.310101393943, 32716.50925236171, 32902.83548582242, 33852.66147338594, 33922.49116263209, 33965.3206935855, 41257.79371103246, 46310.0, 48320.75839620779, 48609.756951215015, 48977.2653410192, 6882.724691012504, 6904.378605925491, 6922.826929326807, 6987.580745155307, 6987.615681137586, 12508.624741257778, 12627.30549819732, 12779.680507987374, 12801.0, 12952.093353465167, 9102.681406150752, 10805.243632945618, 10899.891001090205, 11096.167787415814, 11267.492962816857, 10471.738206544896, 10567.52446139941, 10570.471476426303, 10650.627228046982, 10687.091597214323, 10398.636047738293, 10650.881657425858, 10782.460876955964, 10791.730206744895, 11117.83323250168, 6788.558743681645, 6813.4889883257965, 6824.044633751378, 6849.0, 6850.657467126524, 10621.256512044083, 10639.787204256027, 10899.400532970763, 10900.291481054024, 11092.889071109508], "dojo.html": [3178.475551533996, 3234.935301293974, 3258.820764857935, 3275.279438523524, 3276.524903888936, 5113.769880355384, 5364.758585863636, 5379.38137114232, 5390.487903649157, 5398.730063496829, 5243.292155558998, 5349.839504814861, 5353.304070470834, 5358.517733403993, 5375.543078838294, 4847.878803029926, 4948.2330238812865, 5002.424721157077, 5016.824411145611, 5040.067587496306, 4897.314375987365, 4962.982588569334, 4988.102141614508, 5075.238714192864, 5095.6178286628465, 4784.210605250129, 4900.681455705368, 4903.583195428393, 4976.253561965716, 4988.2766998785155, 4950.232713929347, 4999.775010124553, 5015.749212539358, 5032.7735251913755, 5041.72270525121, 4959.82640607577, 4990.201567749179, 5009.298698182258, 5019.949800501985, 5042.319286896259, 5068.315777370045, 5106.5659418949435, 5159.509846564571, 5268.130758424855, 5296.867578310573, 5819.243498345188, 5848.97075514624, 5849.2980842298775, 5897.911531327033, 5904.232449781501, 5882.411758824083, 5892.292924849003, 5900.43945825146, 5914.0, 5930.7034648267845, 5207.713575753332, 5308.893822123536, 5375.166849138351, 5465.180222966507, 5515.448455154493, 5901.852453688606, 5971.58198926071, 5975.4024597540765, 5997.610155339889, 6022.1870047543025, 5727.4845263926445, 5806.622569532967, 5809.854753631109, 5813.709314534256, 5815.505682016991, 5683.9715801420725, 5733.082706766897, 5813.854653633608, 5821.126830975303, 5833.591648584558, 5729.684867332337, 5821.79623713168, 5822.592418530662, 5841.795537156179, 5842.2405087338375, 5701.572382071278, 5769.307683078057, 5779.624324418899, 5809.738561764731, 5813.0, 4410.6030457259, 4487.0, 4489.775511224426, 4510.323451482304, 4538.228501154812, 3968.6428221460205, 3987.900302492461, 3991.7604943703473, 4004.1591265833918, 4029.4560234367987, 5314.149736042292, 5384.542313903362, 5488.094464413407, 5488.56091512678, 5500.119980803132, 5706.686132262766, 5711.657300561979, 5802.303723553201, 5803.7388317524965, 5852.7658893643775, 5461.098918678374, 5543.334799824047, 5558.166275058774, 5562.805301814498, 5572.247746554244, 4952.5542701157065, 5057.266696329012, 5075.923861142012, 5078.162103252922, 5135.589152867761, 5878.206442130343, 5941.613795103304, 5984.162217289496, 6002.609830361012, 6031.2159419276095, 5816.767329306949, 5840.94159058421, 5874.765009399576, 5899.734511946886, 5909.763609455574, 5875.529957603467, 6044.0, 6075.756969721162, 6082.118092876596, 6084.452399284086, 5654.6324488908085, 5747.913781293368, 5760.855978600569, 5764.308283006066, 5806.796762113306, 5696.088625820014, 5720.256366672473, 5735.197072409783, 5767.509761670305, 5769.74036168365, 5445.782168713207, 5595.132754423071, 5624.606277560531, 5638.802641907513, 5639.548836093185, 5589.5807814413265, 5654.378018418053, 5676.659400435987, 5677.943220567741, 5721.22763426932, 5562.137868630369, 5580.888382232414, 5580.916286255629, 5592.86017849557, 5594.664320140804, 5612.971935140298, 5634.464725851038, 5647.802326918538, 5695.1457281406465, 5735.885282294247, 5486.698231597141, 5508.476694713996, 5556.777728890799, 5567.387587365306, 5575.358833734173], "mootools.html": [1484.2652886821024, 1677.8070521889981, 1738.8261173882613, 1745.711957527008, 1747.685416625007, 6552.705128269227, 6659.067730517731, 7374.483786134972, 7736.613169341538, 7744.4966077204945, 7207.53151045183, 7379.335859772619, 7440.330370266675, 7444.739434119807, 7490.250974902507, 2261.0390584001816, 2301.4016355747544, 2306.3772781349026, 2308.73449553301, 2313.363824948144, 2240.115154513974, 2279.7150356205475, 2328.1269523928527, 2344.202970989863, 2347.1784875293683, 2210.071769856656, 2219.9556008879895, 2240.6863039174527, 2312.2600767754325, 2328.499372634883, 2277.9772202278014, 2294.2314324701247, 2320.663503791949, 2326.8603883767028, 2344.120954642001, 2350.0952133428755, 2366.0181024874655, 2368.3723813189517, 2375.7386687464364, 2384.237044145874, 7560.886586701204, 7630.656620452093, 7639.274268944441, 7641.465097443125, 7687.500312479671, 4636.142313671948, 4709.646776491777, 4715.033418149271, 4757.024809913959, 4757.26262429324, 2974.6579143398353, 3004.4141392428487, 3052.450558899397, 3068.0, 3072.9078127656207, 1057.3391630231106, 1059.1791361694748, 1107.7341438054889, 1138.3852719531444, 1142.6686260984304, 10384.221183411199, 10441.738956526071, 10448.05967462932, 10450.216233782498, 10471.528781204865, 4225.556316586775, 4295.0, 4331.6318112960125, 4334.934975975363, 4351.956480435155, 8952.552372381355, 8960.103989600988, 8972.506512141765, 8980.146886045815, 8992.100789921087, 4629.305604159403, 4640.373549570832, 4647.070585882837, 4685.390899183152, 4701.1537923174155, 4180.770057646859, 4233.153369326147, 4255.340422234559, 4277.443932288845, 4279.144171165779, 3488.843002064913, 3576.481410195507, 3593.5148754918273, 3629.927401451956, 3662.6154253802965, 1037.8547003419528, 1047.450088703437, 1053.0991560233851, 1053.6048981631889, 1081.4106312059946, 1273.1279073834453, 1280.8142819291152, 1288.7422515496937, 1310.194230548206, 1320.9009324300523, 6959.930400696029, 6968.731328420654, 6982.47631427645, 7009.684564194624, 7071.434285257167, 499.7576175554853, 509.081108598975, 511.41443047710163, 512.6667666017045, 518.1967949678059, 5597.524210442077, 5604.355499117572, 5621.156826476062, 5621.381648018714, 5682.374938756733, 8755.168259015383, 9032.548372581476, 9168.954155229181, 9275.76810579741, 9356.204722598655, 9017.954910225408, 9067.501287429255, 9159.313051521163, 9203.907960920305, 9236.353455258068, 7087.078679771596, 7155.570665760071, 7171.820704482326, 7232.276772322831, 7237.927620723831, 6941.861162776615, 6951.9304806953305, 6961.61711105894, 6977.232504424611, 6986.720531178696, 7989.362180752815, 8052.114267430695, 8092.514449133071, 8094.311983481234, 8279.544625045439, 8290.917090829014, 8293.751187464386, 8312.25189732927, 8340.624671889658, 8431.662733490592, 6072.939270607414, 6319.210098737658, 6444.9033264502, 6474.741010359533, 6509.4792416605615, 7046.753363632249, 7262.963685181751, 7312.96343518279, 7320.743773967885, 7345.485815992829, 6741.966290168518, 6933.0, 6943.479239057192, 6956.5478243916, 7058.294170582901, 6592.044153597605, 6647.069410282661, 6726.0, 6776.254611992578, 6810.693518791567, 6704.296048914794, 6829.726810927507, 6832.0435139081565, 6869.347411996052, 6902.723891044302, 6354.459870911024, 6378.74485020594, 6391.424771770563, 6391.936080639134, 6394.680265986589, 6328.208973878265, 6347.460465860454, 6368.395002474757, 6372.0, 6374.776882809079], "ext.html": [552.3261620822598, 602.5360472436224, 605.6941244671443, 609.0559632569517, 615.532195531396, 38711.80644096779, 39730.40404393933, 39813.40279895797, 39876.0, 39890.202195956066, 40815.79592102043, 41639.37540936881, 41661.0, 41757.164856702926, 41989.37015944756, 8638.65445382184, 8767.824643507127, 8808.075152109033, 8815.911840881574, 8828.161324674145, 8450.957745211266, 8621.61202745878, 8633.611487483078, 8643.956780216091, 8662.956685216564, 8730.0, 8745.7813554661, 8768.34237432192, 8785.472871627722, 8811.867821982676, 8722.956385218065, 8755.737327880142, 8779.078196789342, 8793.912060879373, 8823.294136469067, 8637.740867773977, 8726.86909696355, 8751.606177722018, 8770.649174033031, 8771.956140219321, 38104.80947595244, 38284.617153828665, 38445.423318650246, 38555.80722096372, 38677.0, 3206.70086486753, 3292.818894960776, 3960.3465428204313, 3965.167314863882, 3970.4838371011874, 28687.84841136902, 28872.711272887213, 29012.854935725187, 30046.84976575103, 30060.8496957516, 3244.205169733407, 3279.5736554248033, 3295.47272436409, 3309.420851351004, 3382.3573521030926, 276279.0, 276513.0, 276994.0, 277116.0, 277845.0, 41336.37995430071, 41808.74573762792, 52926.20610690843, 53121.468785311656, 53267.40692227338, 43338.78330608327, 43412.56587434085, 43509.78245108754, 43543.34684979728, 43782.56217437849, 13483.247177866815, 13526.120802147829, 13550.254735989614, 13626.523071692642, 13636.113652612548, 12168.026557875348, 12182.634520964386, 12203.14577979533, 12259.632211033504, 12265.816012759815, 13878.861211387959, 13886.93056534711, 13957.441702331997, 13977.930110349384, 13996.370163342674, 5898.734556944948, 5903.439173278532, 5907.497862681635, 5971.671558064349, 5986.7904623338845, 922.0410772796217, 932.4545141092401, 951.9809603808023, 965.1603105298435, 1078.4823284823171, 26784.732152678225, 27302.453950921266, 27412.45175096527, 27428.588571171447, 27807.58288625672, 1062.8830828608848, 1069.3316677076828, 1092.4974511724536, 1102.795982743195, 1182.9526818927318, 14404.207768572829, 14414.0, 14509.637259068608, 14598.63503412402, 14741.115533067836, 393743.0, 395723.0, 396623.0168849195, 397352.0, 398256.0, 52720.0, 53380.466195338326, 53529.1970620441, 53543.464565354625, 53555.46444535505, 1333.999500374719, 1334.9199048057149, 1349.3118509560195, 1350.770369037266, 1357.545222350504, 26511.867440662674, 27381.589276160474, 27584.586231206948, 27675.86162069177, 27953.860230698716, 43735.0, 43837.0, 43905.0, 43963.56036439723, 44210.0, 302940.0, 303260.0, 304026.0, 304665.0, 305689.0, 32430.189245269055, 44562.77718611386, 44970.77514612537, 45431.7728411369, 45456.31815522704, 42643.36034959416, 42731.3590296152, 42755.35866961936, 42901.0, 42935.570644293155, 35761.0, 35904.28191436209, 36173.638263617024, 36253.27493450169, 36562.63437365592, 35953.0, 36146.63853361433, 36171.0, 36368.636313636525, 36640.0, 35116.29767404689, 35571.0, 35587.288254234256, 35665.0, 35666.10834729153, 31122.377552449278, 32313.35373292568, 32747.83626081854, 32998.83500582482, 33361.83319083389, 24195.516089677756, 24537.509249814546, 24562.63156052625, 24715.50568988574, 24984.250472485855], "prototype.html": [325.8045172896264, 331.3952037531504, 345.8789423701705, 347.19450873972386, 348.2964411887986, 6273.184486016818, 6286.811395658132, 6310.0, 6389.329120442357, 6536.901946470807, 6276.686165691709, 6325.355407594024, 6354.14219080424, 6360.427561519462, 6386.744530218785, 4804.231322988314, 4812.278158276269, 4822.445418776851, 4824.710517368969, 4830.227163653816, 4782.473927867949, 4814.566688997989, 4817.78319975602, 4829.420469543659, 4831.251156070814, 4678.8596342109795, 4736.9341898072835, 4746.477887432379, 4751.3585665935, 4784.928226076611, 4749.216379297412, 4751.738654374008, 4759.071980963713, 4773.140834649779, 4782.7608619569055, 4115.773632450214, 4124.319487284594, 4127.566605506408, 4128.0, 4137.924139723664, 6050.909236361458, 6054.606450580698, 6056.9697151513965, 6059.2728872535135, 6060.0, 5422.864428389322, 5541.33503979521, 5562.721863906829, 5564.86087847803, 5568.248286481355, 6720.025596288559, 6745.886928656766, 6749.595024298509, 6756.4932630052945, 6765.458763298973, 4576.222042252792, 4577.473590537097, 4588.541145885418, 4588.862334129982, 4594.448666160049, 6848.657567121624, 6899.517033807636, 6977.720891164347, 7025.367716905452, 7030.683619237096, 4660.370849935215, 4707.529247075265, 4711.269753188261, 4726.503717109723, 4733.124371991193, 4744.810207591658, 4764.499727528629, 4766.356541866873, 4783.6651434399255, 4791.760411979387, 5526.751296191681, 5557.694326812064, 5558.0, 5559.833205003856, 5570.61005729595, 6567.868642627121, 6757.898631520531, 6765.797026089225, 6813.7955861324235, 6814.318568143245, 1641.9507414777577, 1653.7188677924541, 1683.293016932891, 1684.8904821186584, 1687.7721507596318, 1100.5542755184163, 1105.8451816745662, 1123.152020224725, 1123.9831402528969, 1127.887211278882, 6391.169148010729, 6394.904076438857, 6398.232212134573, 6421.068945002949, 6426.068220108058, 6828.795136145924, 6840.760573379908, 6842.0, 6851.760188393482, 6877.277885822016, 6374.960012795954, 6379.266384365765, 6425.3574642536305, 6431.035344698239, 6432.4532414744335, 3789.7536660117003, 3793.9241215175543, 3821.2739579479808, 3826.674732647756, 3829.0, 7247.275272472816, 7262.20115787263, 7287.380572651278, 7301.123865136112, 7313.0, 7058.223595404502, 7225.710971561184, 7244.058272424656, 7244.529105608119, 7251.23861994483, 7245.384142347854, 7271.200167981624, 7285.4171666266575, 7290.489665723455, 7299.854002919912, 6975.6163411012885, 6985.057017302599, 7013.2986701329455, 7018.6490675465, 7049.682764275723, 6762.154730658668, 6937.410320122644, 6953.965230173817, 6975.511714179958, 7010.824729381806, 7291.0, 7318.1949985502615, 7325.267473252632, 7326.04761381017, 7327.2672732726305, 4699.060187962353, 4735.408073990751, 4739.360186374795, 4740.336352910526, 4740.407449068866, 6836.17965844082, 6853.554518956451, 7046.189688185719, 7046.894296585658, 7050.647467626701, 6810.761623343159, 6813.4889883257965, 6839.2818754032105, 6846.5892046477375, 6854.828629284308, 6778.288279730755, 6788.898166527605, 6789.660516974231, 6799.93200067993, 6800.727970881109, 6527.9020814688765, 6637.303083176197, 6679.8664026718225, 6689.2307384651385, 6706.295838936841, 6782.355676210949, 6807.863842723019, 6819.147606549182, 6828.0, 6831.45348372139, 6583.604983700993, 6601.3728695773825, 6642.767503137367, 6653.1018312527185, 6660.733570657313], "yui.html": [690.8894576867699, 698.4035782038641, 763.9197884222157, 813.4224700462671, 823.2590668398441, 12329.938350308246, 12677.366131693412, 12680.682982925431, 12705.682357941056, 12723.681907952283, 12628.052896032812, 12792.808107878389, 12811.487540498392, 12814.615561533168, 12825.615231543068, 783.0681489028067, 807.547773246982, 821.9301359384459, 825.3768404854327, 829.2909562324186, 822.8230930349973, 824.579464473117, 825.8761185822144, 826.2687521543447, 830.5515021888173, 831.9043310019365, 833.2417500074934, 836.5148214035875, 840.64272684109, 841.2008591837779, 824.1881746479683, 834.7412302186342, 836.0636087581947, 836.5273620404482, 836.782436566491, 609.4271384898182, 610.7343305662051, 612.0268772651461, 612.4365583662997, 612.4702132655266, 12886.613401597968, 12981.026423018311, 12985.675358116028, 12986.155899866479, 12986.675333116747, 8818.426802257833, 9225.953870230673, 9438.858417123749, 9913.851292230622, 10240.28318017739, 9847.842997359188, 9984.650537231162, 10045.69862904114, 10116.89883101167, 10176.898231017669, 3178.523221516768, 3190.8245046522666, 3217.3886961477247, 3250.6313477219173, 3300.2079500919845, 41586.37620435696, 42302.78848605768, 45941.0, 46424.53575464236, 46491.0, 6860.759873404407, 6985.476089293324, 6991.93008069923, 7057.18842333128, 7145.0, 11446.14153938458, 11553.942230288794, 11569.710757231136, 11574.0, 11588.246763960316, 6541.803745887631, 6760.695768690421, 6800.591964482147, 6857.9657101715175, 6865.9313406866295, 4275.337322714984, 4416.293393057095, 4468.4637843458995, 4569.383133277031, 4594.287885377772, 2723.6731592208666, 2724.9046283380385, 2727.972720272812, 2764.5714914188334, 2803.5934789455414, 442.8937055106751, 455.3238440915238, 455.61500532050366, 459.2697610798846, 461.87991122308443, 654.5745265577413, 662.1458318768831, 673.3737624009718, 677.6103740349221, 737.3990197988729, 8767.12328767131, 9085.273178145733, 9283.953580232055, 9362.765930851783, 9725.9027409725, 612.6691586543217, 690.6063543779998, 693.38635307753, 709.2411120101546, 709.5139829217003, 4001.519817621904, 4176.519700234512, 4279.293916503804, 4305.418768466279, 4386.692931494828, 61193.0, 61291.693541532004, 61440.69279653573, 61491.692541537006, 61560.69219653873, 54389.45610543923, 54434.72782636061, 54589.454105459234, 55145.172822407694, 55745.721271393384, 49081.0, 49103.75448122808, 49455.50544494581, 50567.74716126396, 50796.0, 8611.181937715906, 8657.653693852428, 8785.385023048326, 8806.691765788166, 8892.377533572846, 35645.287094258485, 35855.28289434144, 36468.635313646526, 36523.08692282608, 37053.81473092617, 42062.0, 42210.78894605507, 45622.54377456316, 46856.765716172566, 46928.530714693785, 10960.835587466036, 11022.669319920415, 11028.834567481656, 11092.057175140204, 11146.275492093313, 11804.232724872856, 11864.466099025392, 11965.880341196476, 12088.879111208775, 12334.81497777552, 10331.121854642439, 10430.739231519272, 10490.160787137163, 10508.894911050791, 10881.347119172875, 10119.311751185473, 10180.643677471253, 10197.388156710622, 10217.540210690686, 10853.294535855144, 9842.409455432697, 9919.900800991898, 10136.18910487174, 10611.151107911503, 10637.840432393676, 8997.0, 9165.816683666422, 9176.311776616647, 9372.0, 9454.0, 8462.547709923527, 8672.0, 8955.283577313669, 9378.812423751351, 9459.38513996588]}, "summary": {"lowerIsBetter": false, "suite": 6909.905960626803, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8546.554603438753, "unit": "ms", "value": 8546.554603438753}, "dojo.html": {"lowerIsBetter": false, "filtered": 5354.131687926272, "unit": "ms", "value": 5354.131687926272}, "mootools.html": {"lowerIsBetter": false, "filtered": 4345.655077706592, "unit": "ms", "value": 4345.655077706592}, "ext.html": {"lowerIsBetter": false, "filtered": 18031.138125596495, "unit": "ms", "value": 18031.138125596495}, "prototype.html": {"lowerIsBetter": false, "filtered": 5060.468874661768, "unit": "ms", "value": 5060.468874661768}, "yui.html": {"lowerIsBetter": false, "filtered": 5998.552897715596, "unit": "ms", "value": 5998.552897715596}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-009.e"}, "testrun": {"date": 1447836624, "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": "20151117223006", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 164.0, 165.0, 163.0, 161.0, 162.0, 165.0, 166.0, 172.0, 163.0], "ai-astar": [109.0, 103.0, 110.0, 111.0, 109.0, 121.0, 112.0, 109.0, 109.0, 108.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 110.0], "audio-beat-detection": [153.0, 126.0, 159.0, 168.0, 127.0, 151.0, 148.0, 126.0, 166.0, 127.0], "json-stringify-tinderbox": [70.0, 71.0, 69.0, 69.0, 70.0, 70.0, 70.0, 71.0, 70.0, 69.0], "stanford-crypto-pbkdf2": [143.0, 151.0, 153.0, 151.0, 150.0, 149.0, 153.0, 152.0, 148.0, 142.0], "json-parse-financial": [63.0, 63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 61.0, 61.0], "stanford-crypto-sha256-iterative": [69.0, 69.0, 69.0, 67.0, 69.0, 66.0, 66.0, 66.0, 66.0, 67.0], "audio-fft": [73.0, 74.0, 72.0, 73.0, 75.0, 73.0, 149.0, 72.0, 73.0, 72.0], "imaging-darkroom": [148.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [115.0, 126.0, 125.0, 130.0, 118.0, 116.0, 120.0, 118.0, 117.0, 117.0], "audio-oscillator": [89.0, 89.0, 135.0, 90.0, 91.0, 89.0, 132.0, 89.0, 90.0, 133.0], "stanford-crypto-aes": [82.0, 84.0, 92.0, 85.0, 84.0, 85.0, 87.0, 86.0, 86.0, 84.0], "imaging-desaturate": [96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1511.4000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.2, "unit": "ms", "value": 149.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.2, "unit": "ms", "value": 120.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.1, "unit": "ms", "value": 147.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.0, "unit": "ms", "value": 63.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.7, "unit": "ms", "value": 102.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.2, "unit": "ms", "value": 164.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.9, "unit": "ms", "value": 69.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.5, "unit": "ms", "value": 85.5}, "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-009.e"}, "testrun": {"date": 1447836624, "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": "20151117223006", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.9487975174554], "Encrypt": [287.1912693854107], "NavierStokes": [4854.368932038835], "Decrypt": [5035.175879396985], "Splay": [678.3546864463924], "Richards": [166.30633627141194], "RegExp": [27513.513513513513], "Earley": [697.350069735007], "Boyer": [12195.121951219513], "RayTrace": [1063.8297872340424]}, "summary": {"lowerIsBetter": false, "suite": 20955.680241184902, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.90440800000005, "unit": "score", "value": 340.90440800000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 926.8422419999996, "unit": "score", "value": 926.8422419999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 305.7040000000001, "unit": "score", "value": 305.7040000000001}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 120.1303707753479, "unit": "score", "value": 120.1303707753479}, "RegExp": {"lowerIsBetter": false, "filtered": 33.11045677799608, "unit": "score", "value": 33.11045677799608}, "Richards": {"lowerIsBetter": false, "filtered": 212.27092600000003, "unit": "score", "value": 212.27092600000003}, "Earley": {"lowerIsBetter": false, "filtered": 955.7079420000003, "unit": "score", "value": 955.7079420000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.64996600000001, "unit": "score", "value": 54.64996600000001}, "RayTrace": {"lowerIsBetter": false, "filtered": 695.5896600000003, "unit": "score", "value": 695.5896600000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-009.e"}, "testrun": {"date": 1447836624, "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": "20151117223006", "branch": "Firefox", "revision": "eb3016abd37db2e6a6d923265047e84b12c0af61"}}] 01:10:33 INFO - RETURN: dromaeo_css: 6909.91 01:10:33 INFO - RETURN: kraken: 1511.40 01:10:33 INFO - RETURN: v8_7: 20955.68 01:10:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20955.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1511.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6909.91"}}} 01:10:33 INFO - Return code: 0 01:10:33 INFO - # TBPL SUCCESS # 01:10:33 INFO - Running post-action listener: _resource_record_post_action 01:10:33 INFO - Running post-run listener: _resource_record_post_run 01:10:34 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 523149312; Read time: 8; Write time: 514440 01:10:34 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 228192256; Read time: 0; Write time: 301676 01:10:34 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291008512; Read time: 8; Write time: 211884 01:10:34 INFO - Running post-run listener: _upload_blobber_files 01:10:34 INFO - Blob upload gear active. 01:10:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:10:34 INFO - Copying logs to upload dir... 01:10:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.138112 ========= master_lag: 0.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-18 01:10:35.124278) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 01:10:35.128493) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010062 build_url: 'https://queue.taskcluster.net/v1/task/c3D4hq0mTjmuqMhZHG_5tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 01:10:35.154290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 01:10:35.154656) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1447833509.517498-1212327334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004656 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 01:10:35.204017) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 01:10:35.207353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 01:10:35.207643) ========= ========= Total master_lag: 0.99 =========