builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1447679915.16 results: success (0) buildid: 20151116030208 builduid: 1535f0fc9132460b9b4ed37dc4583e08 revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.161060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.161511) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.161949) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007296 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.185918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.186209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.227507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.227762) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.277789) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.278073) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.278444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.278727) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 05:18: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% 47.5M=0s 2015-11-16 05:18:35 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.476204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.476498) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.528429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:35.529042) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --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 48d636f678b0e5162ab868dc9024a5ffe350460c --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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 05:18:35,834 truncating revision to first 12 chars 2015-11-16 05:18:35,834 Setting DEBUG logging. 2015-11-16 05:18:35,834 attempt 1/10 2015-11-16 05:18:35,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 05:18:36,072 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528444 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.071368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.071773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.079143) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.079475) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:18:36.079914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 05:18:36.080273) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:36 INFO - MultiFileLogger online at 20151116 05:18:36 in /builds/slave/test-pgo 05:18:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:18:36 INFO - {'append_to_log': False, 05:18:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:18:36 INFO - 'blob_upload_branch': 'Firefox', 05:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:18:36 INFO - 'branch': 'Firefox', 05:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:36 INFO - 'config_files': ('talos/linux_config.py',), 05:18:36 INFO - 'default_actions': ('clobber', 05:18:36 INFO - 'read-buildbot-config', 05:18:36 INFO - 'download-and-extract', 05:18:36 INFO - 'populate-webroot', 05:18:36 INFO - 'create-virtualenv', 05:18:36 INFO - 'install', 05:18:36 INFO - 'run-tests'), 05:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:36 INFO - 'download_minidump_stackwalk': True, 05:18:36 INFO - 'download_symbols': 'ondemand', 05:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:36 INFO - 'installer_path': 'installer.exe', 05:18:36 INFO - 'log_level': 'info', 05:18:36 INFO - 'log_name': 'talos', 05:18:36 INFO - 'log_to_console': True, 05:18:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:36 INFO - 'opt_config_files': (), 05:18:36 INFO - 'pip_index': False, 05:18:36 INFO - 'sps_profile': False, 05:18:36 INFO - 'sps_profile_interval': 0, 05:18:36 INFO - 'suite': 'dromaeojs', 05:18:36 INFO - 'system_bits': '64', 05:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:36 INFO - 'title': 'talos-linux64-ix-008', 05:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:36 INFO - 'use_talos_json': True, 05:18:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:36 INFO - 'work_dir': 'build'} 05:18:36 INFO - ##### 05:18:36 INFO - ##### Running clobber step. 05:18:36 INFO - ##### 05:18:36 INFO - Running pre-action listener: _resource_record_pre_action 05:18:36 INFO - Running main action method: clobber 05:18:36 INFO - rmtree: /builds/slave/test-pgo/build 05:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:18:36 INFO - Running post-action listener: _resource_record_post_action 05:18:36 INFO - ##### 05:18:36 INFO - ##### Running read-buildbot-config step. 05:18:36 INFO - ##### 05:18:36 INFO - Running pre-action listener: _resource_record_pre_action 05:18:36 INFO - Running main action method: read_buildbot_config 05:18:36 INFO - Using buildbot properties: 05:18:36 INFO - { 05:18:36 INFO - "properties": { 05:18:36 INFO - "buildnumber": 556, 05:18:36 INFO - "product": "firefox", 05:18:36 INFO - "script_repo_revision": "production", 05:18:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:18:36 INFO - "repository": "", 05:18:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:18:36 INFO - "buildid": "20151116030208", 05:18:36 INFO - "slavename": "talos-linux64-ix-008", 05:18:36 INFO - "stage_platform": "linux64-pgo", 05:18:36 INFO - "basedir": "/builds/slave/test-pgo", 05:18:36 INFO - "nightly_build": "True", 05:18:36 INFO - "project": "", 05:18:36 INFO - "platform": "ubuntu64_hw", 05:18:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:18:36 INFO - "slavebuilddir": "test", 05:18:36 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:18:36 INFO - "branch": "mozilla-central", 05:18:36 INFO - "repo_path": "mozilla-central", 05:18:36 INFO - "pgo_build": "True", 05:18:36 INFO - "builduid": "1535f0fc9132460b9b4ed37dc4583e08", 05:18:36 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:36 INFO - }, 05:18:36 INFO - "sourcestamp": { 05:18:36 INFO - "repository": "", 05:18:36 INFO - "hasPatch": false, 05:18:36 INFO - "project": "", 05:18:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:18:36 INFO - "changes": [ 05:18:36 INFO - { 05:18:36 INFO - "category": null, 05:18:36 INFO - "files": [ 05:18:36 INFO - { 05:18:36 INFO - "url": null, 05:18:36 INFO - "name": "https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:18:36 INFO - } 05:18:36 INFO - ], 05:18:36 INFO - "repository": "", 05:18:36 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 05:18:36 INFO - "who": "sendchange", 05:18:36 INFO - "when": 1447679888, 05:18:36 INFO - "number": 6665698, 05:18:36 INFO - "comments": "", 05:18:36 INFO - "project": "", 05:18:36 INFO - "at": "Mon 16 Nov 2015 05:18:08", 05:18:36 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:18:36 INFO - "revlink": "", 05:18:36 INFO - "properties": [ 05:18:36 INFO - [ 05:18:36 INFO - "buildid", 05:18:36 INFO - "20151116030208", 05:18:36 INFO - "Change" 05:18:36 INFO - ], 05:18:36 INFO - [ 05:18:36 INFO - "builduid", 05:18:36 INFO - "1535f0fc9132460b9b4ed37dc4583e08", 05:18:36 INFO - "Change" 05:18:36 INFO - ], 05:18:36 INFO - [ 05:18:36 INFO - "nightly_build", 05:18:36 INFO - "True", 05:18:36 INFO - "Change" 05:18:36 INFO - ], 05:18:36 INFO - [ 05:18:36 INFO - "pgo_build", 05:18:36 INFO - "True", 05:18:36 INFO - "Change" 05:18:36 INFO - ] 05:18:36 INFO - ], 05:18:36 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:36 INFO - } 05:18:36 INFO - ], 05:18:36 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:18:36 INFO - } 05:18:36 INFO - } 05:18:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:18:36 INFO - Running post-action listener: _resource_record_post_action 05:18:36 INFO - ##### 05:18:36 INFO - ##### Running download-and-extract step. 05:18:36 INFO - ##### 05:18:36 INFO - Running pre-action listener: _resource_record_pre_action 05:18:36 INFO - Running main action method: download_and_extract 05:18:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:36 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json 05:18:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json 05:18:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:18:37 INFO - Downloaded 1302 bytes. 05:18:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:18:37 INFO - Using the following test package requirements: 05:18:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'jsshell-linux-x86_64.zip'], 05:18:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:18:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:18:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:37 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:38 INFO - Downloaded 22463059 bytes. 05:18:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:18:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:18:39 INFO - Return code: 0 05:18:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:39 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:18:42 INFO - Downloaded 22463059 bytes. 05:18:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:18:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:18:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:18:44 INFO - Return code: 0 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:44 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:18:44 INFO - Downloaded 11131693 bytes. 05:18:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:18:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:18:45 INFO - Return code: 0 05:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:45 INFO - https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:18:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:18:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:18:49 INFO - Downloaded 57133317 bytes. 05:18:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:18:49 INFO - mkdir: /builds/slave/test-pgo/properties 05:18:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:18:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:18:49 INFO - Contents: 05:18:49 INFO - build_url:https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:18:49 INFO - Running post-action listener: _resource_record_post_action 05:18:49 INFO - Running post-action listener: set_extra_try_arguments 05:18:49 INFO - ##### 05:18:49 INFO - ##### Running populate-webroot step. 05:18:49 INFO - ##### 05:18:49 INFO - Running pre-action listener: _resource_record_pre_action 05:18:49 INFO - Running main action method: populate_webroot 05:18:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:18:49 INFO - '../fennec_ids.txt'], 05:18:49 INFO - 'tests': ['tcheck2']}, 05:18:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:49 INFO - '--tppagecycles', 05:18:49 INFO - '7'], 05:18:49 INFO - 'tests': ['tsvgm']}}, 05:18:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:18:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:18:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'tests': ['damp', 'tps']}, 05:18:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['damp', 'tps']}, 05:18:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:18:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:49 INFO - 'other': {'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'other_l64': {'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:18:49 INFO - 'ts_paint', 05:18:49 INFO - 'tpaint', 05:18:49 INFO - 'sessionrestore', 05:18:49 INFO - 'sessionrestore_no_auto_restore']}, 05:18:49 INFO - 'svgr': {'tests': ['tsvgx', 05:18:49 INFO - 'tsvgr_opacity', 05:18:49 INFO - 'tart', 05:18:49 INFO - 'tscrollx', 05:18:49 INFO - 'cart']}, 05:18:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['tsvgx', 05:18:49 INFO - 'tsvgr_opacity', 05:18:49 INFO - 'tart', 05:18:49 INFO - 'tscrollx', 05:18:49 INFO - 'cart']}, 05:18:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'tests': ['tp5o']}, 05:18:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'talos_options': ['--e10s'], 05:18:49 INFO - 'tests': ['tp5o']}, 05:18:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'talos_options': ['--xperf_path', 05:18:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:49 INFO - 'tests': ['tp5n']}, 05:18:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:49 INFO - 'talos_options': ['--e10s', 05:18:49 INFO - '--xperf_path', 05:18:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:49 INFO - 'tests': ['tp5n']}}, 05:18:49 INFO - 'talos.zip': {'path': '', 05:18:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:49 INFO - Running post-action listener: _resource_record_post_action 05:18:49 INFO - ##### 05:18:49 INFO - ##### Running create-virtualenv step. 05:18:49 INFO - ##### 05:18:49 INFO - Running pre-action listener: _resource_record_pre_action 05:18:49 INFO - Running main action method: create_virtualenv 05:18:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:18:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:18:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:18:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:49 INFO - Using real prefix '/usr' 05:18:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:18:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:52 INFO - Installing pip.................done. 05:18:52 INFO - Return code: 0 05:18:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:18:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:18:52 INFO - Using env: {'DISPLAY': ':0', 05:18:52 INFO - 'HOME': '/home/cltbld', 05:18:52 INFO - 'LANG': 'en_US.UTF-8', 05:18:52 INFO - 'LANGUAGE': 'en_US:en', 05:18:52 INFO - 'LOGNAME': 'cltbld', 05:18:52 INFO - 'MAIL': '/var/mail/cltbld', 05:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:52 INFO - 'MOZ_NO_REMOTE': '1', 05:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:52 INFO - 'NO_EM_RESTART': '1', 05:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:52 INFO - 'SHELL': '/bin/bash', 05:18:52 INFO - 'SHLVL': '1', 05:18:52 INFO - 'TERM': 'linux', 05:18:52 INFO - 'TMOUT': '86400', 05:18:52 INFO - 'USER': 'cltbld', 05:18:52 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:52 INFO - '_': '/tools/buildbot/bin/python'} 05:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:18:52 INFO - Cleaning up... 05:18:52 INFO - Return code: 0 05:18:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:18:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:18:52 INFO - Using env: {'DISPLAY': ':0', 05:18:52 INFO - 'HOME': '/home/cltbld', 05:18:52 INFO - 'LANG': 'en_US.UTF-8', 05:18:52 INFO - 'LANGUAGE': 'en_US:en', 05:18:52 INFO - 'LOGNAME': 'cltbld', 05:18:52 INFO - 'MAIL': '/var/mail/cltbld', 05:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:52 INFO - 'MOZ_NO_REMOTE': '1', 05:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:52 INFO - 'NO_EM_RESTART': '1', 05:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:52 INFO - 'SHELL': '/bin/bash', 05:18:52 INFO - 'SHLVL': '1', 05:18:52 INFO - 'TERM': 'linux', 05:18:52 INFO - 'TMOUT': '86400', 05:18:52 INFO - 'USER': 'cltbld', 05:18:52 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:52 INFO - '_': '/tools/buildbot/bin/python'} 05:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:52 INFO - Downloading/unpacking psutil>=0.7.1 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:18:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:18:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:54 INFO - Installing collected packages: psutil 05:18:54 INFO - Running setup.py install for psutil 05:18:54 INFO - building 'psutil._psutil_linux' extension 05:18:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:18:54 INFO - building 'psutil._psutil_posix' extension 05:18:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:18:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:18:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:54 INFO - Successfully installed psutil 05:18:54 INFO - Cleaning up... 05:18:54 INFO - Return code: 0 05:18:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:18: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')]} 05:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', '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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:18: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 mozsystemmonitor==0.0.0 05:18:54 INFO - Using env: {'DISPLAY': ':0', 05:18:54 INFO - 'HOME': '/home/cltbld', 05:18:54 INFO - 'LANG': 'en_US.UTF-8', 05:18:54 INFO - 'LANGUAGE': 'en_US:en', 05:18:54 INFO - 'LOGNAME': 'cltbld', 05:18:54 INFO - 'MAIL': '/var/mail/cltbld', 05:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:54 INFO - 'MOZ_NO_REMOTE': '1', 05:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:54 INFO - 'NO_EM_RESTART': '1', 05:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:54 INFO - 'SHELL': '/bin/bash', 05:18:54 INFO - 'SHLVL': '1', 05:18:54 INFO - 'TERM': 'linux', 05:18:54 INFO - 'TMOUT': '86400', 05:18:54 INFO - 'USER': 'cltbld', 05:18:54 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:54 INFO - '_': '/tools/buildbot/bin/python'} 05:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:18:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:18:56 INFO - Installing collected packages: mozsystemmonitor 05:18:56 INFO - Running setup.py install for mozsystemmonitor 05:18:56 INFO - Successfully installed mozsystemmonitor 05:18:56 INFO - Cleaning up... 05:18:57 INFO - Return code: 0 05:18:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:18: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')]} 05:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', '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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:18: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:18: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 blobuploader==1.2.4 05:18:57 INFO - Using env: {'DISPLAY': ':0', 05:18:57 INFO - 'HOME': '/home/cltbld', 05:18:57 INFO - 'LANG': 'en_US.UTF-8', 05:18:57 INFO - 'LANGUAGE': 'en_US:en', 05:18:57 INFO - 'LOGNAME': 'cltbld', 05:18:57 INFO - 'MAIL': '/var/mail/cltbld', 05:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:57 INFO - 'MOZ_NO_REMOTE': '1', 05:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:57 INFO - 'NO_EM_RESTART': '1', 05:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:57 INFO - 'SHELL': '/bin/bash', 05:18:57 INFO - 'SHLVL': '1', 05:18:57 INFO - 'TERM': 'linux', 05:18:57 INFO - 'TMOUT': '86400', 05:18:57 INFO - 'USER': 'cltbld', 05:18:57 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:57 INFO - '_': '/tools/buildbot/bin/python'} 05:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18:59 INFO - Downloading docopt-0.6.1.tar.gz 05:18:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:18:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:59 INFO - Running setup.py install for blobuploader 05:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:18:59 INFO - Running setup.py install for requests 05:19:00 INFO - Running setup.py install for docopt 05:19:00 INFO - Successfully installed blobuploader requests docopt 05:19:00 INFO - Cleaning up... 05:19:00 INFO - Return code: 0 05:19:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:19:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:00 INFO - Using env: {'DISPLAY': ':0', 05:19:00 INFO - 'HOME': '/home/cltbld', 05:19:00 INFO - 'LANG': 'en_US.UTF-8', 05:19:00 INFO - 'LANGUAGE': 'en_US:en', 05:19:00 INFO - 'LOGNAME': 'cltbld', 05:19:00 INFO - 'MAIL': '/var/mail/cltbld', 05:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:00 INFO - 'MOZ_NO_REMOTE': '1', 05:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:00 INFO - 'NO_EM_RESTART': '1', 05:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:00 INFO - 'SHELL': '/bin/bash', 05:19:00 INFO - 'SHLVL': '1', 05:19:00 INFO - 'TERM': 'linux', 05:19:00 INFO - 'TMOUT': '86400', 05:19:00 INFO - 'USER': 'cltbld', 05:19:00 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:00 INFO - '_': '/tools/buildbot/bin/python'} 05:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:00 INFO - Running setup.py (path:/tmp/pip-OED1_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:00 INFO - Running setup.py (path:/tmp/pip-EDFUHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:00 INFO - Running setup.py (path:/tmp/pip-OGqGfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:00 INFO - Running setup.py (path:/tmp/pip-X1KOEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:00 INFO - Running setup.py (path:/tmp/pip-rNmv1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:00 INFO - Running setup.py (path:/tmp/pip-ACwh4J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:00 INFO - Running setup.py (path:/tmp/pip-6KVtcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:00 INFO - Running setup.py (path:/tmp/pip-TsBGSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:00 INFO - Running setup.py (path:/tmp/pip-DWNVPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:01 INFO - Running setup.py (path:/tmp/pip-E7e1Xy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:01 INFO - Running setup.py (path:/tmp/pip-JQjM4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:01 INFO - Running setup.py (path:/tmp/pip-l1U4Al-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:01 INFO - Running setup.py (path:/tmp/pip-vmXPAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:01 INFO - Running setup.py (path:/tmp/pip-r2yLMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:01 INFO - Running setup.py (path:/tmp/pip-YD364o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:01 INFO - Running setup.py (path:/tmp/pip-1ph77n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:01 INFO - Running setup.py (path:/tmp/pip-9fXD5H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:01 INFO - Running setup.py install for manifestparser 05:19:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:19:01 INFO - Running setup.py install for mozcrash 05:19:01 INFO - Running setup.py install for mozdebug 05:19:01 INFO - Running setup.py install for mozdevice 05:19:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozfile 05:19:02 INFO - Running setup.py install for mozhttpd 05:19:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozinfo 05:19:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozInstall 05:19:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozleak 05:19:02 INFO - Running setup.py install for mozlog 05:19:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for moznetwork 05:19:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozprocess 05:19:02 INFO - Running setup.py install for mozprofile 05:19:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:19:02 INFO - Running setup.py install for mozrunner 05:19:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:19:03 INFO - Running setup.py install for mozscreenshot 05:19:03 INFO - Running setup.py install for moztest 05:19:03 INFO - Running setup.py install for mozversion 05:19:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:19:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:03 INFO - Cleaning up... 05:19:03 INFO - Return code: 0 05:19:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:19:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:03 INFO - Using env: {'DISPLAY': ':0', 05:19:03 INFO - 'HOME': '/home/cltbld', 05:19:03 INFO - 'LANG': 'en_US.UTF-8', 05:19:03 INFO - 'LANGUAGE': 'en_US:en', 05:19:03 INFO - 'LOGNAME': 'cltbld', 05:19:03 INFO - 'MAIL': '/var/mail/cltbld', 05:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:03 INFO - 'MOZ_NO_REMOTE': '1', 05:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:03 INFO - 'NO_EM_RESTART': '1', 05:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:03 INFO - 'SHELL': '/bin/bash', 05:19:03 INFO - 'SHLVL': '1', 05:19:03 INFO - 'TERM': 'linux', 05:19:03 INFO - 'TMOUT': '86400', 05:19:03 INFO - 'USER': 'cltbld', 05:19:03 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:03 INFO - '_': '/tools/buildbot/bin/python'} 05:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:03 INFO - Running setup.py (path:/tmp/pip-spBIbQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:03 INFO - Running setup.py (path:/tmp/pip-Jd6pHt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:03 INFO - Running setup.py (path:/tmp/pip-mptfP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:03 INFO - Running setup.py (path:/tmp/pip-avTQ8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:03 INFO - Running setup.py (path:/tmp/pip-colBkm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:03 INFO - Running setup.py (path:/tmp/pip-wDzXpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:04 INFO - Running setup.py (path:/tmp/pip-fz3qBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:04 INFO - Running setup.py (path:/tmp/pip-HWY1VX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:04 INFO - Running setup.py (path:/tmp/pip-BVb51w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:04 INFO - Running setup.py (path:/tmp/pip-Cfm2S4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:04 INFO - Running setup.py (path:/tmp/pip-IciBqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:04 INFO - Running setup.py (path:/tmp/pip-ZVdrOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:04 INFO - Running setup.py (path:/tmp/pip-usOwyF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:04 INFO - Running setup.py (path:/tmp/pip-07iz3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:04 INFO - Running setup.py (path:/tmp/pip-tWlBd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:04 INFO - Running setup.py (path:/tmp/pip-P4DSuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:19:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:04 INFO - Running setup.py (path:/tmp/pip-WYvbJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:19:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:06 INFO - Downloading blessings-1.5.1.tar.gz 05:19:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:19:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:06 INFO - Installing collected packages: blessings 05:19:06 INFO - Running setup.py install for blessings 05:19:06 INFO - Successfully installed blessings 05:19:06 INFO - Cleaning up... 05:19:06 INFO - Return code: 0 05:19:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:19:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:19:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:19:06 INFO - Reading from file tmpfile_stdout 05:19:06 INFO - Current package versions: 05:19:06 INFO - argparse == 1.2.1 05:19:06 INFO - blessings == 1.5.1 05:19:06 INFO - blobuploader == 1.2.4 05:19:06 INFO - docopt == 0.6.1 05:19:06 INFO - manifestparser == 1.1 05:19:06 INFO - mozInstall == 1.12 05:19:06 INFO - mozcrash == 0.16 05:19:06 INFO - mozdebug == 0.1 05:19:06 INFO - mozdevice == 0.47 05:19:06 INFO - mozfile == 1.2 05:19:06 INFO - mozhttpd == 0.7 05:19:06 INFO - mozinfo == 0.9 05:19:06 INFO - mozleak == 0.1 05:19:06 INFO - mozlog == 3.0 05:19:06 INFO - moznetwork == 0.27 05:19:06 INFO - mozprocess == 0.22 05:19:06 INFO - mozprofile == 0.27 05:19:06 INFO - mozrunner == 6.11 05:19:06 INFO - mozscreenshot == 0.1 05:19:06 INFO - mozsystemmonitor == 0.0 05:19:06 INFO - moztest == 0.7 05:19:06 INFO - mozversion == 1.4 05:19:06 INFO - psutil == 3.1.1 05:19:06 INFO - requests == 1.2.3 05:19:06 INFO - wsgiref == 0.1.2 05:19:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:19: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')]} 05:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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')]} 05:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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/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 0x7ff746ed7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:19: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/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:19: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/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:06 INFO - Using env: {'DISPLAY': ':0', 05:19:06 INFO - 'HOME': '/home/cltbld', 05:19:06 INFO - 'LANG': 'en_US.UTF-8', 05:19:06 INFO - 'LANGUAGE': 'en_US:en', 05:19:06 INFO - 'LOGNAME': 'cltbld', 05:19:06 INFO - 'MAIL': '/var/mail/cltbld', 05:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:06 INFO - 'MOZ_NO_REMOTE': '1', 05:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:06 INFO - 'NO_EM_RESTART': '1', 05:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:06 INFO - 'SHELL': '/bin/bash', 05:19:06 INFO - 'SHLVL': '1', 05:19:06 INFO - 'TERM': 'linux', 05:19:06 INFO - 'TMOUT': '86400', 05:19:06 INFO - 'USER': 'cltbld', 05:19:06 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:06 INFO - '_': '/tools/buildbot/bin/python'} 05:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:19: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:19:07 INFO - Cleaning up... 05:19:07 INFO - Return code: 0 05:19:07 INFO - Running post-action listener: _resource_record_post_action 05:19:07 INFO - Running post-action listener: _start_resource_monitoring 05:19:07 INFO - Starting resource monitoring. 05:19:07 INFO - ##### 05:19:07 INFO - ##### Running install step. 05:19:07 INFO - ##### 05:19:07 INFO - Running pre-action listener: _resource_record_pre_action 05:19:07 INFO - Running main action method: install 05:19:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:19:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:19:07 INFO - Reading from file tmpfile_stdout 05:19:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:19:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:19:07 INFO - Reading from file tmpfile_stdout 05:19:07 INFO - Output received: 05:19:07 INFO - Usage: mozinstall [options] installer 05:19:07 INFO - Options: 05:19:07 INFO - -h, --help show this help message and exit 05:19:07 INFO - -d DEST, --destination=DEST 05:19:07 INFO - Directory to install application into. [default: 05:19:07 INFO - "/builds/slave/test-pgo"] 05:19:07 INFO - --app=APP Application being installed. [default: firefox] 05:19:07 INFO - mkdir: /builds/slave/test-pgo/build/application 05:19:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:19:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:19:21 INFO - Reading from file tmpfile_stdout 05:19:21 INFO - Output received: 05:19:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:19:21 INFO - Running post-action listener: _resource_record_post_action 05:19:21 INFO - ##### 05:19:21 INFO - ##### Running run-tests step. 05:19:21 INFO - ##### 05:19:21 INFO - Running pre-action listener: _resource_record_pre_action 05:19:21 INFO - Running main action method: run_tests 05:19:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:19:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:19:21 INFO - Python 2.7.3 05:19:21 INFO - Return code: 0 05:19:21 INFO - grabbing minidump binary from tooltool 05:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:21 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 0x10f78c0>, '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 0x10a4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a48b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:19:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:19:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:19:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:21 INFO - Return code: 0 05:19:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:19:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:19:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:19:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:19:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:19:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:19:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 05:19:21 INFO - Using env: {'DISPLAY': ':0', 05:19:21 INFO - 'HOME': '/home/cltbld', 05:19:21 INFO - 'LANG': 'en_US.UTF-8', 05:19:21 INFO - 'LANGUAGE': 'en_US:en', 05:19:21 INFO - 'LOGNAME': 'cltbld', 05:19:21 INFO - 'MAIL': '/var/mail/cltbld', 05:19:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:19:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:21 INFO - 'MOZ_NO_REMOTE': '1', 05:19:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:21 INFO - 'NO_EM_RESTART': '1', 05:19:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:19:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:19:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:19:21 INFO - 'SHELL': '/bin/bash', 05:19:21 INFO - 'SHLVL': '1', 05:19:21 INFO - 'TERM': 'linux', 05:19:21 INFO - 'TMOUT': '86400', 05:19:21 INFO - 'USER': 'cltbld', 05:19:21 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370', 05:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:21 INFO - '_': '/tools/buildbot/bin/python'} 05:19:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 05:19:22 INFO - mozversion INFO | application_buildid: 20151116030208 05:19:22 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:19:22 INFO - mozversion INFO | application_display_name: Nightly 05:19:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:22 INFO - mozversion INFO | application_name: Firefox 05:19:22 INFO - mozversion INFO | application_remotingname: firefox 05:19:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:19:22 INFO - mozversion INFO | application_vendor: Mozilla 05:19:22 INFO - mozversion INFO | application_version: 45.0a1 05:19:22 INFO - mozversion INFO | platform_buildid: 20151116030208 05:19:22 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:19:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:19:22 INFO - mozversion INFO | platform_version: 45.0a1 05:19:22 INFO - 2015-11-16 05:19:22,143 DEBUG : using testdate: 1447679962 05:19:22 INFO - 2015-11-16 05:19:22,143 DEBUG : actual date: 1447679962 05:19:22 INFO - 2015-11-16 05:19:22,152 INFO : starting webserver on 'localhost:58377' 05:19:22 INFO - 2015-11-16 05:19:22,153 INFO : Starting test suite talos-linux64-ix-008 05:19:22 INFO - 2015-11-16 05:19:22,153 INFO : Starting test dromaeo_css 05:19:22 INFO - 2015-11-16 05:19:22,153 DEBUG : operating with platform_type : linux_ 05:19:22 INFO - 2015-11-16 05:19:22,154 INFO : Initialising browser for dromaeo_css test... 05:19:22 INFO - 2015-11-16 05:19:22,169 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQCQKDX/profile http://localhost:58377/getInfo.html 05:19:25 INFO - 2015-11-16 05:19:25,913 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:19:25 INFO - 2015-11-16 05:19:25,913 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:19:25 INFO - 2015-11-16 05:19:25,914 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:19:25 INFO - 2015-11-16 05:19:25,914 DEBUG : BROWSER_OUTPUT: __metrics 05:19:26 INFO - 2015-11-16 05:19:26,070 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:27 INFO - 2015-11-16 05:19:27,288 INFO : Browser initialized. 05:19:27 INFO - 2015-11-16 05:19:27,288 INFO : Running cycle 1/1 for dromaeo_css test... 05:19:27 INFO - 2015-11-16 05:19:27,288 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQCQKDX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:19:39 INFO - 2015-11-16 05:19:39,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 141713408 05:19:39 INFO - 2015-11-16 05:19:39,065 DEBUG : BROWSER_OUTPUT: 05:20:30 INFO - 2015-11-16 05:20:30,440 DEBUG : BROWSER_OUTPUT: 1447680030436 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:22:38 INFO - 2015-11-16 05:22:38,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58377/tests/dromaeo/cssquery-ext.html) 05:22:39 INFO - 2015-11-16 05:22:39,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 233500672 05:22:39 INFO - 2015-11-16 05:22:39,639 DEBUG : BROWSER_OUTPUT: 05:25:42 INFO - 2015-11-16 05:25:42,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-ext.html (next: http://localhost:58377/tests/dromaeo/cssquery-jquery.html) 05:25:42 INFO - 2015-11-16 05:25:42,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 218537984 05:25:42 INFO - 2015-11-16 05:25:42,693 DEBUG : BROWSER_OUTPUT: 05:28:44 INFO - 2015-11-16 05:28:44,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58377/tests/dromaeo/cssquery-mootools.html) 05:28:45 INFO - 2015-11-16 05:28:45,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 207671296 05:28:45 INFO - 2015-11-16 05:28:45,168 DEBUG : BROWSER_OUTPUT: 05:31:46 INFO - 2015-11-16 05:31:46,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58377/tests/dromaeo/cssquery-prototype.html) 05:31:47 INFO - 2015-11-16 05:31:47,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 204460032 05:31:47 INFO - 2015-11-16 05:31:47,562 DEBUG : BROWSER_OUTPUT: 05:34:49 INFO - 2015-11-16 05:34:49,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58377/tests/dromaeo/cssquery-yui.html) 05:34:50 INFO - 2015-11-16 05:34:50,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 203182080 05:34:50 INFO - 2015-11-16 05:34:50,585 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/dromaeo/cssquery-yui.html (next: http://localhost:58377/tests/dromaeo/cssquery-dojo.html) 05:37:53 INFO - 2015-11-16 05:37:53,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 298221568 05:37:53 INFO - 2015-11-16 05:37:53,333 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,333 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:37:53 INFO - 2015-11-16 05:37:53,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:37:53 INFO - 2015-11-16 05:37:53,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:37:53 INFO - 2015-11-16 05:37:53,334 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:37:53 INFO - 2015-11-16 05:37:53,335 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3143.6384815746187;3201.8078915265073;3244.724198443132;3253.8047717136988;3266.608007039156;5128.461511541281;5259.710715910624;5365.919511207335;5394.703291318976;5429.999999999995;5259.500347466994;5391.110466772978;5393.460653934604;5437.157240627709;5448.37343705473;4871.439784424792;4938.80244790208;4957.206846904496;4970.826021089262;5006.299118123466;4777.450593181777;4958.826441074563;4972.8508144755715;5020.121478741224;5024.698518088908;4836.806527738904;4882.951170488285;4946.431160416562;4953.578945789613;4968.950310496885;4959.504049595048;4973.204287314013;4975.079610272075;5006.374203224597;5015.924761128586;4743.7628118594275;4876.317315575822;4981.875453113701;4982.526659967298;5026.5727413169925;5093.312402825608;5170.638055336128;5170.767315470813;5176.094183517869;5181.559567436772;5775.5957083004205;5852.356240813507;5853.122031695238;5853.795117170921;5857.209276747627;5771.769129234825;5835.503982161521;5858.912116318259;5910.438508341744;5955.52355811534;5368.30212072432;5447.373552041527;5458.2904222450825;5463.235147079372;5494.478024587658;5937.168796368512;5946.197263369476;5954.315253745788;5955.702214889238;5956.344802071769;5648.548116150698;5667.489925906688;5780.6531608102805;5791.189233507313;5817.94182058174;5762.366139724627;5762.74067666956;5768.048272035151;5776.133579962955;5800.564957628195;5705;5705.286839145107;5713.771449141987;5717.028105222123;5728.112142617901;5752.395998420189;5777.480026797524;5779.537636989031;5896.823095307148;5921.763129474859;4454.510003899569;4454.866354009385;4456.665750068758;4476.171908196994;4486.237339652202;3968.265870813909;3972.2849887020034;3982.064214909494;4000.739951903117;4012.6990475714438;5304.204369344552;5429.619926605179;5446.7276636168035;5520.806771762969;5559.6664200148125;5799.971000144972;5829.5044921181325;5835.883282334329;5855.707214639251;5867.911981320283;5347.86630334237;5518.944810551923;5534.944650553523;5539.501444869981;5543.944560554423;5008.449070602231;5048.469910659328;5068.138416469135;5080.441151473335;5117.130087885069;6027.45752882234;6040.7583696651645;6041.214642096499;6043.36544662804;6044.879102418015;5680.204771331934;5815.476607105381;5859.853503662272;5869.35437101927;5869.559783016376;5933.851653708692;6017.669028203491;6023.397660233942;6038.51691864641;6077.3011103721865;5784.710764461676;5792.189093526994;5796.072628379439;5796.304443466643;5799.391063938226;5709.371969083314;5753.942460575341;5877.970610147093;5913.85215369602;5930;5674.971625141848;5676.489115979582;5677.347105082803;5680.176374425602;5719.342275638355;5663.716814159193;5672;5677.290338707661;5679.233303504139;5680.034394153086;5404.945950540444;5494.09347457665;5519.31008623922;5592.384837667934;5596.300462442195;5771.7402716877;5791.247137872049;5795.33353664334;5812.099124635688;5823.82528524145;5668.37647858727;5673.9432605675065;5689.061304884648;5689.459501347365;5725.055365864586 05:37:53 INFO - 2015-11-16 05:37:53,335 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.5892662615895;581.206652918766;584.9649021058736;599.1342510072943;599.1462166412861;29892.55161172584;39610;39768.80115599418;39838.2032359353;39848;40942.795286023604;41364;41439;41509.30189537678;41511;7729.690812367498;7847.764567062969;8669.956650216756;8834.779130521723;8858.069902660225;10412.583496660163;10553.41956192409;10603.363798172135;10617.946910265477;10640.255182137253;10278.383297002167;10331.58673653053;10396.896031039707;10398.428086455242;10406.32358896673;7932.722354717586;8066.274035336848;10258.179345652366;10502;10723.302985306009;10112.140468060225;10240.924702906237;10241.53913073906;10243.539040743184;10244.078032977068;33252.50121248183;39367.60632393668;39755.20489590192;39758;39871.8006409969;2798.958015629767;3262.5432439458496;3414.6926776589976;3792.867249646249;3882.9038409696786;29350.706492935013;30034;30068.398632027456;30113.397732045454;30408.54387184194;2835.6313679221776;2864.7309838560423;2921.7078292170827;2935.2955290730283;3007.383486385286;269108.27229319426;269616;269760;269789;269964;56861.43138568644;57233.71383143141;57234.7138264306;57237;57322;60010;60195.37850836405;60303;60351.69824150939;60353;13604.795928061087;14339.78490322646;14546.709065818624;14550.927245363917;14560.563183104523;10049.799004019878;10149.34029288094;10199.0820826126;10208.744781380525;10947.726306842393;18755.249790008518;19180.328688496116;19353.51616209606;19811.306604268782;19895;7278.454115941219;7400.5189662671755;7431.665575049135;7443.962780186064;7467.551946883204;885.9778505537413;903.7605034665819;956.8899576548786;1023.6673081248624;1027.8047171037629;25560.8721956389;25608.48783024329;25937.870310648326;26043;27186.456270874867;1036.5387402605768;1050.7005503431485;1062.5218651606654;1084.821004534243;1151.3725019864194;14395.64010899715;14421.567352979428;15037.699246015018;15449.459268925533;15556.22218889051;305989;310854;311996;312294;312377;52199.73900130551;52296.73851630794;52570.73714631402;52576.474235257156;52600.736996315536;1365.528892532075;1368.3979049218312;1380.0063953953138;1384.0311781752814;1388.4654408052972;27565.31086722848;28442.862285509174;28492.145235642965;28778.71221287844;28965.275868102624;45088;45305.093898121195;45373.092538149715;45393.31910021418;45398.546014540756;291720;294418;294878;295131;295452;28306.43387132287;30422.391552169276;31462;31486.685133148374;31662.208444789063;39124.804375979074;39436.802815985735;41375.7931210342;42384.576154238064;42758.358624620036;33120.834395827864;33186.5022024665;33230.50154247737;33375.49936750902;33649.663503365635;31933;33391.66608333983;33474;33478.83260583682;37200.44199336958;33653.663463365054;34254.82872585621;34859;34918.47622285617;34954.47568286427;29894.25264368408;31940.36119277648;32065.51901721523;32289.677103228667;32370.352592947536;23732.88133559321;23868.88065559661;23995.02054027138;24016.39959001039;24036.87981560081 05:37:53 INFO - 2015-11-16 05:37:53,336 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.63520127859374;333.30006985330823;344.20145262989865;347.5429809800113;348.1071052749697;13611.387487563059;13927.860721392783;17365.479035628934;17961;18358.99999999998;15665.373385064584;16013.83986160138;17272.136393180353;17396.652066958653;17403.564910877234;5275.235090911825;5415.675059496423;5419.512243898049;5432.837014889559;5437.945620543804;3968.543617483983;4090.406891000803;5387.865303367408;5878.206442130322;6026.548008899328;6032.065029920369;6062.757489700407;6080.878382432371;6096.481799047064;6104.694765261741;4936.654434189591;5021.49785021495;5027.49725027498;5031.119554078022;5032.874178145557;4378.190034843564;4378.211921854065;4381.364702118175;4389.275769498029;4395.274779661352;13917.791233131511;14191.503297384543;14404.855951440457;14444.061136026125;14458.69871711551;2019.2528764357282;2026.6858636911302;2034.9898250508652;2111.5037966077957;2126.075157306577;9984.700458986243;10177.89822101777;10196.3372380795;10404.895951040544;10512.579496820117;1583.3903946980495;1674.1294526846093;1730.3078768492578;1742.6166243426426;1750.2736364408754;53703;54433.45566544363;54591;58985.41014589842;62228;7021.122359705037;7156.964215178891;7187;7194.38847697941;7240.855182896313;8503.277221436247;8508.446950948168;8509.276711479593;8509.872351914726;8514.957425212835;5552.91670624941;5555.194496797942;5573.665580065209;5580.609357344947;5592.97203513988;5614.045612245928;5642.153676948491;5681.147827825776;5681.687507187062;5695.231143795618;3270.2151483643756;3320.286138480238;3334.7665663403327;3337.766356355032;3350.7151892089446;1128.3173679923527;1172.5427083437467;1180.4215934192184;1193.8567371915426;1193.8985186259265;488.8753367891165;491.7885309317028;492.990140197194;500.92986981822577;504.41235960106064;11787.410629468492;11819;12151.270923744603;12174.147809653416;12186.75626487483;496.85591178558536;501.914674505335;505.8431886115316;505.97217153056937;513.9563137133385;6331;6582.111414959015;6619.5035372347265;6652.800415987528;6657.600543967377;489683;494975;498618;502980;510047;73239.63380183066;75245;75381;75510;76242;535.8097875254228;546.7676237599004;554.6339415985431;570.9229254050733;570.9371969083397;11125.165612578927;11171.888281117084;11362.94318528402;11565.190436669689;11729.530818767154;34668;34765.65234347624;34872.12819679528;35431.82284088563;35662;44852;46078.53921460877;46223.76888115673;46463.76768116138;46935.29597056115;6683.198016238082;6948.062011628567;6959.547629404073;6962.164540255202;6964.582125072512;12087.879121209027;12234;12333.198342107735;12334.876651233373;12545.874541254836;10725.41010244444;10987.670369888596;11014.44927753625;11025.338479691245;11060.115190784558;10605.681829545127;10683.358998460117;10768.892311077103;10831.133509319394;10856.2400631955;10917.344959302467;10990.120790336914;11350.318980861175;11579.131565132817;11723.531058757555;6902.8619427610165;6940.236573976757;6982.51122421446;6984.755533556301;7010.75462358815;10525.421101839473;10544.89455105439;10765.838512422477;11274.041706455044;11415.543378265109 05:37:53 INFO - 2015-11-16 05:37:53,340 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1365.515242089059;1687.9746803797943;1710.8460238578525;1739.139126132564;1745.467632372126;6794.4564434845215;6992.685329160187;7183.533070350423;7189.604571748552;7194.640267986606;7394.149672787631;7475.925240747591;7477.027986361765;7477.065366829146;7491;1959.9314024009163;1997.4307322413042;2183.4213933307688;2247.898844551995;2267.5351552931693;2165.772593877644;2172.5329054253334;2178.302943058222;2180.563887222554;2180.6292930201826;2162.686410470481;2205.9227927022557;2208.745994210662;2210.10490751246;2211.612967730649;1965.7124583397826;1994.3917105282883;2185.180557291024;2212.590670725921;2226.220822712054;2171.9022643981057;2180.498485348363;2202.9449263768374;2206.6138425775425;2267.195145723261;7504.549727016342;7546.69813207471;7573.507721998052;7576.356009739179;7587.355074818647;4452.799624016927;4536.79584418702;4551.977240113812;4563.201439748031;4567.3377360282575;2889.1043776429374;2949.115265420365;2977.196157037588;2984.7164519370626;2992.251937015746;888;899.163777686751;901.544719916438;905.4069584422214;910.3081657939947;10338.586456541729;10384.896151038469;10399.948000260027;10400.739981500446;10410.53152608127;4129.339305711072;4134.979325103355;4192.05678722285;4196.160767846443;4291.356296555542;8987.325950553735;8990.325725570608;8991.820163596822;8997.235235005099;9000.279977601776;4519.864404067883;4546.931796023062;4557.95442045582;4571.062932098912;4576.496585375606;4127.9587204128175;4134.235166494148;4135.234981528427;4136.131412403429;4140.006398464347;3583.157957879896;3626.7642603230706;3641.053326135171;3643.4352675335367;3664.523611930432;1160.6808127764932;1174.4890972427022;1180.6694125644833;1181.509673485494;1184.413715210976;1296.5397283964246;1306.0922658752077;1306.4382315604191;1321.2666969831835;1340.6179238917057;7106.786796396116;7110.822229444202;7132.750353737698;7150.642467876585;7160.069191005136;488.66770595995064;497.31122395481793;500.7521276967924;504.6064070025386;505.0580667055988;5365.839024829262;5539.362973258047;5583.525400340935;5596.412376700469;5597.160425936142;8823.514706691194;9006.774830629156;9097.363184577016;9141.040190780006;9163.58763855628;8941.374103812801;8955.194032536972;9037.322200834964;9043.050479699537;9049.683261085962;6772.255051944282;7002.894956575554;7003.26465721092;7023.578585284899;7063.717451301993;6929.861402771816;6966;6986.126734158231;7007.054047703495;7020.894686579603;8029.5583742894705;8030.759077227693;8087.83824323522;8103.270705636521;8113.310368618498;8226.670933162846;8277.337812975067;8311.044229913396;8406.579671016303;8414.326853851555;6839.247682754993;6963.651817409211;6973.965130174317;6974.093367862146;6983.057287266154;7394.963025185055;7395.889061663972;7397.556146631219;7401.444891633041;7451.882217667393;6760.22257440381;6862.691178897061;6952.061471701458;7012.228654848064;7124.750633727795;6284.780032698834;6426.485881129405;6463.709133088928;6883.621400823003;6931.618760968196;6774.898376524455;6827.283135270725;6830.795076147723;6831.316868313328;6833.80408428533;6296.559240853279;6298.842528936813;6303.306636270098;6334.809955701337;6355.523335749745;6037.245344331958;6151.538634602333;6154.3845615438095;6161;6172.22847144107 05:37:53 INFO - 2015-11-16 05:37:53,340 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.364728599013;304.4565450670553;310.0466066844454;310.26931576138196;313.3951473655843;6128.172696685946;6154.538409619279;6314.305426403103;6318.957372033615;6351.460125889305;6140.2938662053875;6207.286162091361;6209.348018458053;6214.223222097238;6222.222222222223;4451.5993560579545;4554.453465584134;4676;4676.415448068991;4679.227927391977;4523.751193684346;4611.838585649503;4626.653001024936;4642.744649044301;4661.044485880403;4578.908421831561;4581;4583.335416364625;4583.381243532114;4586.082783443308;4408.118376324748;4511.774411279423;4512.758991277392;4586.678932474728;4608.262677971508;3927.8625248116464;3937.3700207966876;3939.98030009851;3945.684345252373;3956.742811717229;5845.357010728816;5846.649201047951;5855.092460668603;5861.794837180721;5867.11993201019;5318.787248510055;5350.866228344284;5352.839414817562;5353;5361.490658387486;6316.494680425555;6485.2541957675;6485.870282594369;6493.51298652603;6502.609843409363;4306.547812479707;4309.849155279581;4311.611954924072;4312.504062032875;4314.827406903752;6718.798436046926;6749.987501874709;6816.99999999995;6820.215675197366;6829.351211634887;4338.436003319612;4453.376527286183;4453.732776033448;4453.755043472575;4455.799489023002;4489.910201795946;4498.887527811831;4502.662300327489;4505.594496495331;4505.819767209275;5330.546903513167;5334.199870019451;5338.412774594792;5338.946610533845;5341.359036915517;6625.271220165778;6633.170853643294;6636.502262330248;6638.767643132467;6643.40209381158;1537.331260901489;1587.2381256996475;1591.043017088964;1591.4111778641977;1595.1226825246067;1015.939043657383;1027.5376080763685;1037.092544023979;1037.1754455207977;1049.2969710294121;6365.586236894587;6388.39310265524;6391.96804015977;6392.20097487814;6405.3594640535575;6759.898601520981;6823.283555226729;6837.555558888656;6839.316068393121;6846.212685541127;6222.595531290452;6392.0411938209645;6394.729870895765;6400.551961362753;6409.455196308366;3585.103724068983;3646;3660.5790334111384;3744.6817020553012;3745.3632882410056;7163.570185788869;7173.605451700207;7176.1388633363285;7196.532225405332;7198.064251647253;6833.350831670983;7028.121484814398;7035.8241043973285;7049.400800931979;7050.6827192776445;7134.286571342825;7141.428685705235;7145.82135446618;7155.570665760071;7159.928400715926;6851.07510486078;6852.794416167523;6855.280195579392;6858.279880612464;6867.725290988305;6645.767398141042;6766.323367663194;6768.898466523105;6784.728610855511;6786.898196527155;7067.2579379164445;7144.499885007999;7149.785506434815;7153.605047015782;7153.964230178815;4463.977680111579;4495.842645507391;4511.1654343946475;4521;4525.456945166601;6668.933310666831;6823;6862.451003919575;6863.210730766026;6877.243503214542;6671.933280667131;6677.3656502632175;6678.49911256648;6686.53194276396;6687.1975362956755;6662.467002639681;6665.566738162198;6666.133402657623;6670.466362691071;6678.332166783477;6448.065030570635;6513.381228783258;6538.869222615616;6552;6563.671816409256;6692.431143352675;6702.798916032331;6706.429953454011;6707.3628005339415;6711.563748356341;6537.953927371597;6542.34576542342;6542.574732642363;6546.967265163644;6551.868962620816 05:37:53 INFO - 2015-11-16 05:37:53,344 DEBUG : BROWSER_OUTPUT: |5;yui.html;751.4476859508262;767.7696690992701;778.1479280188194;786.1666633368629;809.2676128104064;14155.929220353897;14410.423583056665;14433.783493247609;14439.63900902478;14448.494302699408;13569.52506662267;13628.931855340734;13656.453741850313;13684.178949263027;13689.931550342259;672.6166085331363;672.7947975867359;673.9157605299338;789.6604460082162;808.9635966381512;814.0882211922625;821.1337039423406;821.2034326703089;822.0751654388813;824.1099612418574;850.7107583421636;853.4580541356221;855.324293807891;855.7903313688155;855.9614817333235;704.1972151747012;706.7385067524997;852.1521086518953;853.4026181672823;858.6393714639867;621.1614320667109;623.9220097487814;627.6830200748639;627.9843003924892;629.4712441549075;13599.59201223965;13599.728005439934;13617.727645447134;13631.591052268448;13737.313134343243;11405.258658187191;11867.821982670266;12381.442835072443;12717.936410317889;12827.422765975554;10619.522121504551;10746.516406761637;10928.508217130247;10937.398443085627;10964.780704385947;3623.4564815277654;3669.4679271505483;3692.280005398948;3760.4735337052834;3763.4542991266385;47883.52116478825;47905;47971.76014119942;48223;48567.27149092766;9907.851382229272;10099.848502272473;10248.743781405525;10556.26106172576;10574.275469978853;19032.52418689516;19086.904565477085;19104.713429298572;19118.904405477882;19133.13900874464;7378.151512576015;8018.5990700464745;8175.836483270301;8261.297789687824;8265.752027439186;4452.376667266585;4484.372187893698;4502.527234640381;4537.447549679378;4729.314249433882;3013.4877070898;3076.9846150769104;3080.122165182912;3082.2448500117616;3085.4446199683825;462.5004994605885;464.3730963199653;473.8720545452708;475.61950439648143;478.6816766850075;515.8985565817007;634.6985182038495;660.3429587560312;701.929807019294;717.3077979749567;8242.587870606445;8466.915330846736;8686.261667758312;8764.430312029697;8813.867791983126;475.8429718192988;612.8774245150987;646.3794757033301;682.8054004608762;689.290031267795;3838.846446142179;3997.6402123809;4150.5641907599875;4197.9370309445385;4240.363945408152;56840.43159568434;57110;57120.42879571151;57493;57557;47846.10539260983;48740.75629621829;48864.51135488671;49000;49425.50574494209;45306.09387812225;45337.31994020158;45427.54572454299;46408.303875441896;47068.29397559039;8567.143285671384;8855.557222138996;8864.911350886667;8949.507777072064;9482.810343793224;34253.14367140841;34296;34701.13247168841;35124;35449.1137721559;43532.782336088116;43712;44604.77697611491;44719.329210062526;44796.32805507985;8012.839743204987;8180.148893279863;8220.958895205486;8259.256666899768;8508.829823403621;11248.437578121226;11257.49341279628;11968.640940771791;12453.813192802296;12790.936045319713;11447.313161210353;11562.248453850809;11572.074234061087;11592.768144637228;12024.639260822189;11405.600803971822;11470.254433461798;11755.764884702428;12211.572594959134;12344.506219751109;11379.260348077349;11725.237859539102;11732.648020559396;11794.941025294818;11803;9532.666356677482;9776;9850.852237216592;9927.751806204902;10098;8844.823103538021;9490.335676502578;9743.610255589698;9780.217582593234;9850.162736167505 05:37:53 INFO - 2015-11-16 05:37:53,344 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:37:53 INFO - 2015-11-16 05:37:53,344 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:37:53 INFO - 2015-11-16 05:37:53,344 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,772 05:37:53 INFO - 2015-11-16 05:37:53,344 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:37:53 INFO - 2015-11-16 05:37:53,345 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681073332__endTimestamp 05:37:53 INFO - 2015-11-16 05:37:53,345 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,345 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:37:53 INFO - 2015-11-16 05:37:53,346 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:37:53 INFO - 2015-11-16 05:37:53,346 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,346 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5398.33 Median:5667.49 stddev:607.51 (10.7%) stddev-sans-first:583.06 05:37:53 INFO - 2015-11-16 05:37:53,346 DEBUG : BROWSER_OUTPUT: Values: 3143.6 3201.8 3244.7 3253.8 3266.6 5128.5 5259.7 5365.9 5394.7 5430.0 5259.5 5391.1 5393.5 5437.2 5448.4 4871.4 4938.8 4957.2 4970.8 5006.3 4777.5 4958.8 4972.9 5020.1 5024.7 4836.8 4883.0 4946.4 4953.6 4969.0 4959.5 4973.2 4975.1 5006.4 5015.9 4743.8 4876.3 4981.9 4982.5 5026.6 5093.3 5170.6 5170.8 5176.1 5181.6 5775.6 5852.4 5853.1 5853.8 5857.2 5771.8 5835.5 5858.9 5910.4 5955.5 5368.3 5447.4 5458.3 5463.2 5494.5 5937.2 5946.2 5954.3 5955.7 5956.3 5648.5 5667.5 5780.7 5791.2 5817.9 5762.4 5762.7 5768.0 5776.1 5800.6 5705.0 5705.3 5713.8 5717.0 5728.1 5752.4 5777.5 5779.5 5896.8 5921.8 4454.5 4454.9 4456.7 4476.2 4486.2 3968.3 3972.3 3982.1 4000.7 4012.7 5304.2 5429.6 5446.7 5520.8 5559.7 5800.0 5829.5 5835.9 5855.7 5867.9 5347.9 5518.9 5534.9 5539.5 5543.9 5008.4 5048.5 5068.1 5080.4 5117.1 6027.5 6040.8 6041.2 6043.4 6044.9 5680.2 5815.5 5859.9 5869.4 5869.6 5933.9 6017.7 6023.4 6038.5 6077.3 5784.7 5792.2 5796.1 5796.3 5799.4 5709.4 5753.9 5878.0 5913.9 5930.0 5675.0 5676.5 5677.3 5680.2 5719.3 5663.7 5672.0 5677.3 5679.2 5680.0 5404.9 5494.1 5519.3 5592.4 5596.3 5771.7 5791.2 5795.3 5812.1 5823.8 5668.4 5673.9 5689.1 5689.5 5725.1 05:37:53 INFO - 2015-11-16 05:37:53,347 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,347 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45743.01 Median:308421.50 stddev:76299.73 (24.7%) stddev-sans-first:76438.36 05:37:53 INFO - 2015-11-16 05:37:53,347 DEBUG : BROWSER_OUTPUT: Values: 562.6 581.2 585.0 599.1 599.1 29892.6 39610.0 39768.8 39838.2 39848.0 40942.8 41364.0 41439.0 41509.3 41511.0 7729.7 7847.8 8670.0 8834.8 8858.1 10412.6 10553.4 10603.4 10617.9 10640.3 10278.4 10331.6 10396.9 10398.4 10406.3 7932.7 8066.3 10258.2 10502.0 10723.3 10112.1 10240.9 10241.5 10243.5 10244.1 33252.5 39367.6 39755.2 39758.0 39871.8 2799.0 3262.5 3414.7 3792.9 3882.9 29350.7 30034.0 30068.4 30113.4 30408.5 2835.6 2864.7 2921.7 2935.3 3007.4 269108.3 269616.0 269760.0 269789.0 269964.0 56861.4 57233.7 57234.7 57237.0 57322.0 60010.0 60195.4 60303.0 60351.7 60353.0 13604.8 14339.8 14546.7 14550.9 14560.6 10049.8 10149.3 10199.1 10208.7 10947.7 18755.2 19180.3 19353.5 19811.3 19895.0 7278.5 7400.5 7431.7 7444.0 7467.6 886.0 903.8 956.9 1023.7 1027.8 25560.9 25608.5 25937.9 26043.0 27186.5 1036.5 1050.7 1062.5 1084.8 1151.4 14395.6 14421.6 15037.7 15449.5 15556.2 305989.0 310854.0 311996.0 312294.0 312377.0 52199.7 52296.7 52570.7 52576.5 52600.7 1365.5 1368.4 1380.0 1384.0 1388.5 27565.3 28442.9 28492.1 28778.7 28965.3 45088.0 45305.1 45373.1 45393.3 45398.5 291720.0 294418.0 294878.0 295131.0 295452.0 28306.4 30422.4 31462.0 31486.7 31662.2 39124.8 39436.8 41375.8 42384.6 42758.4 33120.8 33186.5 33230.5 33375.5 33649.7 31933.0 33391.7 33474.0 33478.8 37200.4 33653.7 34254.8 34859.0 34918.5 34954.5 29894.3 31940.4 32065.5 32289.7 32370.4 23732.9 23868.9 23995.0 24016.4 24036.9 05:37:53 INFO - 2015-11-16 05:37:53,347 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,347 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25916.03 Median:24623.64 stddev:81812.34 (332.3%) stddev-sans-first:82019.29 05:37:53 INFO - 2015-11-16 05:37:53,348 DEBUG : BROWSER_OUTPUT: Values: 331.6 333.3 344.2 347.5 348.1 13611.4 13927.9 17365.5 17961.0 18359.0 15665.4 16013.8 17272.1 17396.7 17403.6 5275.2 5415.7 5419.5 5432.8 5437.9 3968.5 4090.4 5387.9 5878.2 6026.5 6032.1 6062.8 6080.9 6096.5 6104.7 4936.7 5021.5 5027.5 5031.1 5032.9 4378.2 4378.2 4381.4 4389.3 4395.3 13917.8 14191.5 14404.9 14444.1 14458.7 2019.3 2026.7 2035.0 2111.5 2126.1 9984.7 10177.9 10196.3 10404.9 10512.6 1583.4 1674.1 1730.3 1742.6 1750.3 53703.0 54433.5 54591.0 58985.4 62228.0 7021.1 7157.0 7187.0 7194.4 7240.9 8503.3 8508.4 8509.3 8509.9 8515.0 5552.9 5555.2 5573.7 5580.6 5593.0 5614.0 5642.2 5681.1 5681.7 5695.2 3270.2 3320.3 3334.8 3337.8 3350.7 1128.3 1172.5 1180.4 1193.9 1193.9 488.9 491.8 493.0 500.9 504.4 11787.4 11819.0 12151.3 12174.1 12186.8 496.9 501.9 505.8 506.0 514.0 6331.0 6582.1 6619.5 6652.8 6657.6 489683.0 494975.0 498618.0 502980.0 510047.0 73239.6 75245.0 75381.0 75510.0 76242.0 535.8 546.8 554.6 570.9 570.9 11125.2 11171.9 11362.9 11565.2 11729.5 34668.0 34765.7 34872.1 35431.8 35662.0 44852.0 46078.5 46223.8 46463.8 46935.3 6683.2 6948.1 6959.5 6962.2 6964.6 12087.9 12234.0 12333.2 12334.9 12545.9 10725.4 10987.7 11014.4 11025.3 11060.1 10605.7 10683.4 10768.9 10831.1 10856.2 10917.3 10990.1 11350.3 11579.1 11723.5 6902.9 6940.2 6982.5 6984.8 7010.8 10525.4 10544.9 10765.8 11274.0 11415.5 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5280.24 Median:6290.67 stddev:2754.45 (43.8%) stddev-sans-first:2746.46 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: Values: 1365.5 1688.0 1710.8 1739.1 1745.5 6794.5 6992.7 7183.5 7189.6 7194.6 7394.1 7475.9 7477.0 7477.1 7491.0 1959.9 1997.4 2183.4 2247.9 2267.5 2165.8 2172.5 2178.3 2180.6 2180.6 2162.7 2205.9 2208.7 2210.1 2211.6 1965.7 1994.4 2185.2 2212.6 2226.2 2171.9 2180.5 2202.9 2206.6 2267.2 7504.5 7546.7 7573.5 7576.4 7587.4 4452.8 4536.8 4552.0 4563.2 4567.3 2889.1 2949.1 2977.2 2984.7 2992.3 888.0 899.2 901.5 905.4 910.3 10338.6 10384.9 10399.9 10400.7 10410.5 4129.3 4135.0 4192.1 4196.2 4291.4 8987.3 8990.3 8991.8 8997.2 9000.3 4519.9 4546.9 4558.0 4571.1 4576.5 4128.0 4134.2 4135.2 4136.1 4140.0 3583.2 3626.8 3641.1 3643.4 3664.5 1160.7 1174.5 1180.7 1181.5 1184.4 1296.5 1306.1 1306.4 1321.3 1340.6 7106.8 7110.8 7132.8 7150.6 7160.1 488.7 497.3 500.8 504.6 505.1 5365.8 5539.4 5583.5 5596.4 5597.2 8823.5 9006.8 9097.4 9141.0 9163.6 8941.4 8955.2 9037.3 9043.1 9049.7 6772.3 7002.9 7003.3 7023.6 7063.7 6929.9 6966.0 6986.1 7007.1 7020.9 8029.6 8030.8 8087.8 8103.3 8113.3 8226.7 8277.3 8311.0 8406.6 8414.3 6839.2 6963.7 6974.0 6974.1 6983.1 7395.0 7395.9 7397.6 7401.4 7451.9 6760.2 6862.7 6952.1 7012.2 7124.8 6284.8 6426.5 6463.7 6883.6 6931.6 6774.9 6827.3 6830.8 6831.3 6833.8 6296.6 6298.8 6303.3 6334.8 6355.5 6037.2 6151.5 6154.4 6161.0 6172.2 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5474.12 Median:6335.21 stddev:1723.29 (27.2%) stddev-sans-first:1683.80 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: Values: 300.4 304.5 310.0 310.3 313.4 6128.2 6154.5 6314.3 6319.0 6351.5 6140.3 6207.3 6209.3 6214.2 6222.2 4451.6 4554.5 4676.0 4676.4 4679.2 4523.8 4611.8 4626.7 4642.7 4661.0 4578.9 4581.0 4583.3 4583.4 4586.1 4408.1 4511.8 4512.8 4586.7 4608.3 3927.9 3937.4 3940.0 3945.7 3956.7 5845.4 5846.6 5855.1 5861.8 5867.1 5318.8 5350.9 5352.8 5353.0 5361.5 6316.5 6485.3 6485.9 6493.5 6502.6 4306.5 4309.8 4311.6 4312.5 4314.8 6718.8 6750.0 6817.0 6820.2 6829.4 4338.4 4453.4 4453.7 4453.8 4455.8 4489.9 4498.9 4502.7 4505.6 4505.8 5330.5 5334.2 5338.4 5338.9 5341.4 6625.3 6633.2 6636.5 6638.8 6643.4 1537.3 1587.2 1591.0 1591.4 1595.1 1015.9 1027.5 1037.1 1037.2 1049.3 6365.6 6388.4 6392.0 6392.2 6405.4 6759.9 6823.3 6837.6 6839.3 6846.2 6222.6 6392.0 6394.7 6400.6 6409.5 3585.1 3646.0 3660.6 3744.7 3745.4 7163.6 7173.6 7176.1 7196.5 7198.1 6833.4 7028.1 7035.8 7049.4 7050.7 7134.3 7141.4 7145.8 7155.6 7159.9 6851.1 6852.8 6855.3 6858.3 6867.7 6645.8 6766.3 6768.9 6784.7 6786.9 7067.3 7144.5 7149.8 7153.6 7154.0 4464.0 4495.8 4511.2 4521.0 4525.5 6668.9 6823.0 6862.5 6863.2 6877.2 6671.9 6677.4 6678.5 6686.5 6687.2 6662.5 6665.6 6666.1 6670.5 6678.3 6448.1 6513.4 6538.9 6552.0 6563.7 6692.4 6702.8 6706.4 6707.4 6711.6 6538.0 6542.3 6542.6 6547.0 6551.9 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: 05:37:53 INFO - 2015-11-16 05:37:53,349 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13755.11 Median:25898.80 stddev:15719.56 (60.7%) stddev-sans-first:15733.32 05:37:53 INFO - 2015-11-16 05:37:53,351 DEBUG : BROWSER_OUTPUT: Values: 751.4 767.8 778.1 786.2 809.3 14155.9 14410.4 14433.8 14439.6 14448.5 13569.5 13628.9 13656.5 13684.2 13689.9 672.6 672.8 673.9 789.7 809.0 814.1 821.1 821.2 822.1 824.1 850.7 853.5 855.3 855.8 856.0 704.2 706.7 852.2 853.4 858.6 621.2 623.9 627.7 628.0 629.5 13599.6 13599.7 13617.7 13631.6 13737.3 11405.3 11867.8 12381.4 12717.9 12827.4 10619.5 10746.5 10928.5 10937.4 10964.8 3623.5 3669.5 3692.3 3760.5 3763.5 47883.5 47905.0 47971.8 48223.0 48567.3 9907.9 10099.8 10248.7 10556.3 10574.3 19032.5 19086.9 19104.7 19118.9 19133.1 7378.2 8018.6 8175.8 8261.3 8265.8 4452.4 4484.4 4502.5 4537.4 4729.3 3013.5 3077.0 3080.1 3082.2 3085.4 462.5 464.4 473.9 475.6 478.7 515.9 634.7 660.3 701.9 717.3 8242.6 8466.9 8686.3 8764.4 8813.9 475.8 612.9 646.4 682.8 689.3 3838.8 3997.6 4150.6 4197.9 4240.4 56840.4 57110.0 57120.4 57493.0 57557.0 47846.1 48740.8 48864.5 49000.0 49425.5 45306.1 45337.3 45427.5 46408.3 47068.3 8567.1 8855.6 8864.9 8949.5 9482.8 34253.1 34296.0 34701.1 35124.0 35449.1 43532.8 43712.0 44604.8 44719.3 44796.3 8012.8 8180.1 8221.0 8259.3 8508.8 11248.4 11257.5 11968.6 12453.8 12790.9 11447.3 11562.2 11572.1 11592.8 12024.6 11405.6 11470.3 11755.8 12211.6 12344.5 11379.3 11725.2 11732.6 11794.9 11803.0 9532.7 9776.0 9850.9 9927.8 10098.0 8844.8 9490.3 9743.6 9780.2 9850.2 05:37:53 INFO - 2015-11-16 05:37:53,351 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:37:53 INFO - 2015-11-16 05:37:53,351 DEBUG : BROWSER_OUTPUT: 05:37:54 INFO - 2015-11-16 05:37:54,041 INFO : Browser exited with error code: 0 05:37:54 INFO - 2015-11-16 05:37:54,059 INFO : Completed test dromaeo_css (00:18:31) 05:37:54 INFO - 2015-11-16 05:37:54,059 INFO : Starting test kraken 05:37:54 INFO - 2015-11-16 05:37:54,059 DEBUG : operating with platform_type : linux_ 05:37:54 INFO - 2015-11-16 05:37:54,059 INFO : Initialising browser for kraken test... 05:37:54 INFO - 2015-11-16 05:37:54,066 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPig29D/profile http://localhost:58377/getInfo.html 05:37:57 INFO - 2015-11-16 05:37:57,719 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:37:57 INFO - 2015-11-16 05:37:57,719 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:37:57 INFO - 2015-11-16 05:37:57,719 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:37:57 INFO - 2015-11-16 05:37:57,719 DEBUG : BROWSER_OUTPUT: __metrics 05:37:57 INFO - 2015-11-16 05:37:57,856 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:59 INFO - 2015-11-16 05:37:59,036 INFO : Browser initialized. 05:37:59 INFO - 2015-11-16 05:37:59,037 INFO : Running cycle 1/1 for kraken test... 05:37:59 INFO - 2015-11-16 05:37:59,037 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPig29D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:38:10 INFO - 2015-11-16 05:38:10,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 142045184 05:38:10 INFO - 2015-11-16 05:38:10,774 DEBUG : BROWSER_OUTPUT: 05:38:13 INFO - 2015-11-16 05:38:13,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:13 INFO - 2015-11-16 05:38:13,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 181129216 05:38:13 INFO - 2015-11-16 05:38:13,851 DEBUG : BROWSER_OUTPUT: 05:38:16 INFO - 2015-11-16 05:38:16,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-dft) 05:38:16 INFO - 2015-11-16 05:38:16,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 169365504 05:38:16 INFO - 2015-11-16 05:38:16,997 DEBUG : BROWSER_OUTPUT: 05:38:19 INFO - 2015-11-16 05:38:19,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-fft) 05:38:20 INFO - 2015-11-16 05:38:20,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 152051712 05:38:20 INFO - 2015-11-16 05:38:20,405 DEBUG : BROWSER_OUTPUT: 05:38:22 INFO - 2015-11-16 05:38:22,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58377/tests/kraken/driver.html?testName=audio-oscillator) 05:38:22 INFO - 2015-11-16 05:38:22,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 153829376 05:38:22 INFO - 2015-11-16 05:38:22,975 DEBUG : BROWSER_OUTPUT: 05:38:25 INFO - 2015-11-16 05:38:25,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:25 INFO - 2015-11-16 05:38:25,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 154574848 05:38:25 INFO - 2015-11-16 05:38:25,675 DEBUG : BROWSER_OUTPUT: 05:38:28 INFO - 2015-11-16 05:38:28,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:29 INFO - 2015-11-16 05:38:29,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 156254208 05:38:29 INFO - 2015-11-16 05:38:29,184 DEBUG : BROWSER_OUTPUT: 05:38:32 INFO - 2015-11-16 05:38:32,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58377/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:33 INFO - 2015-11-16 05:38:33,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 156557312 05:38:33 INFO - 2015-11-16 05:38:33,107 DEBUG : BROWSER_OUTPUT: 05:38:35 INFO - 2015-11-16 05:38:35,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58377/tests/kraken/driver.html?testName=json-parse-financial) 05:38:36 INFO - 2015-11-16 05:38:36,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 155987968 05:38:36 INFO - 2015-11-16 05:38:36,449 DEBUG : BROWSER_OUTPUT: 05:38:37 INFO - 2015-11-16 05:38:37,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:38 INFO - 2015-11-16 05:38:38,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 165466112 05:38:38 INFO - 2015-11-16 05:38:38,552 DEBUG : BROWSER_OUTPUT: 05:38:40 INFO - 2015-11-16 05:38:40,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:40 INFO - 2015-11-16 05:38:40,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 166645760 05:38:40 INFO - 2015-11-16 05:38:40,948 DEBUG : BROWSER_OUTPUT: 05:38:42 INFO - 2015-11-16 05:38:42,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:43 INFO - 2015-11-16 05:38:43,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 173674496 05:38:43 INFO - 2015-11-16 05:38:43,567 DEBUG : BROWSER_OUTPUT: 05:38:45 INFO - 2015-11-16 05:38:45,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:46 INFO - 2015-11-16 05:38:46,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 180957184 05:38:46 INFO - 2015-11-16 05:38:46,527 DEBUG : BROWSER_OUTPUT: 05:38:49 INFO - 2015-11-16 05:38:49,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:49 INFO - 2015-11-16 05:38:49,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 178851840 05:38:49 INFO - 2015-11-16 05:38:49,656 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58377/tests/kraken/driver.html?testName=ai-astar) 05:38:51 INFO - 2015-11-16 05:38:51,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 237809664 05:38:51 INFO - 2015-11-16 05:38:51,588 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:38:51 INFO - 2015-11-16 05:38:51,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:38:51 INFO - 2015-11-16 05:38:51,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:38:51 INFO - 2015-11-16 05:38:51,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:38:51 INFO - 2015-11-16 05:38:51,589 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;111;110;112;99;110;115;110 05:38:51 INFO - 2015-11-16 05:38:51,589 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;155;159;126;151;153;125;163;124 05:38:51 INFO - 2015-11-16 05:38:51,589 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;162;160;159;159;163;160;160 05:38:51 INFO - 2015-11-16 05:38:51,589 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;96;72;73;72;111;93;72 05:38:51 INFO - 2015-11-16 05:38:51,590 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;135;90;90;90;137;90;90;135 05:38:51 INFO - 2015-11-16 05:38:51,590 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;109;110;109;109;110;109 05:38:51 INFO - 2015-11-16 05:38:51,590 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;147;145;147;145;145;146;145 05:38:51 INFO - 2015-11-16 05:38:51,590 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;96;96;95;96;95 05:38:51 INFO - 2015-11-16 05:38:51,590 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;57;58;58;58;58;65;55;56 05:38:51 INFO - 2015-11-16 05:38:51,591 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;68;68;69;69 05:38:51 INFO - 2015-11-16 05:38:51,591 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;87;86;84;85;85;86;86;86 05:38:51 INFO - 2015-11-16 05:38:51,591 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;122;112;117;121;117;123;116;120;126 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;148;149;148;140;148;149;147;139 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;65;65;67;65;66;65;65;67 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,942 05:38:51 INFO - 2015-11-16 05:38:51,592 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681131582__endTimestamp 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:4.63 (4.2%) stddev-sans-first:4.90 05:38:51 INFO - 2015-11-16 05:38:51,593 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 111.0 110.0 112.0 99.0 110.0 115.0 110.0 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.50 stddev:15.70 (10.2%) stddev-sans-first:16.23 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 155.0 159.0 126.0 151.0 153.0 125.0 163.0 124.0 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.40 (0.9%) stddev-sans-first:1.41 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 162.0 160.0 159.0 159.0 163.0 160.0 160.0 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,594 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:72.50 stddev:13.93 (19.2%) stddev-sans-first:14.32 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 96.0 72.0 73.0 72.0 111.0 93.0 72.0 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:90.00 stddev:22.14 (24.6%) stddev-sans-first:22.84 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 135.0 90.0 90.0 90.0 137.0 90.0 90.0 135.0 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:38:51 INFO - 2015-11-16 05:38:51,595 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 147.0 145.0 147.0 145.0 145.0 146.0 145.0 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 05:38:51 INFO - 2015-11-16 05:38:51,596 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.69 (4.6%) stddev-sans-first:2.83 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 57.0 58.0 58.0 58.0 58.0 65.0 55.0 56.0 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 68.0 68.0 69.0 69.0 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,597 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:0.97 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 87.0 86.0 84.0 85.0 85.0 86.0 86.0 86.0 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:121.50 stddev:4.09 (3.4%) stddev-sans-first:4.24 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: Values: 122.0 122.0 112.0 117.0 121.0 117.0 123.0 116.0 120.0 126.0 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:148.00 stddev:3.96 (2.7%) stddev-sans-first:4.03 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 148.0 149.0 148.0 140.0 148.0 149.0 147.0 139.0 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: 05:38:51 INFO - 2015-11-16 05:38:51,598 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 05:38:51 INFO - 2015-11-16 05:38:51,599 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 65.0 67.0 65.0 66.0 65.0 65.0 67.0 05:38:51 INFO - 2015-11-16 05:38:51,599 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:38:51 INFO - 2015-11-16 05:38:51,599 DEBUG : BROWSER_OUTPUT: 05:38:52 INFO - 2015-11-16 05:38:52,428 INFO : Browser exited with error code: 0 05:38:52 INFO - 2015-11-16 05:38:52,476 INFO : Completed test kraken (00:00:58) 05:38:52 INFO - 2015-11-16 05:38:52,477 INFO : Starting test v8_7 05:38:52 INFO - 2015-11-16 05:38:52,477 DEBUG : operating with platform_type : linux_ 05:38:52 INFO - 2015-11-16 05:38:52,477 INFO : Initialising browser for v8_7 test... 05:38:52 INFO - 2015-11-16 05:38:52,483 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx9Zvns/profile http://localhost:58377/getInfo.html 05:38:56 INFO - 2015-11-16 05:38:56,149 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:38:56 INFO - 2015-11-16 05:38:56,150 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:38:56 INFO - 2015-11-16 05:38:56,150 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:38:56 INFO - 2015-11-16 05:38:56,150 DEBUG : BROWSER_OUTPUT: __metrics 05:38:56 INFO - 2015-11-16 05:38:56,267 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:57 INFO - 2015-11-16 05:38:57,455 INFO : Browser initialized. 05:38:57 INFO - 2015-11-16 05:38:57,455 INFO : Running cycle 1/1 for v8_7 test... 05:38:57 INFO - 2015-11-16 05:38:57,456 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx9Zvns/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:39:09 INFO - 2015-11-16 05:39:09,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 141701120 05:39:09 INFO - 2015-11-16 05:39:09,216 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58377/tests/v8_7/run.html (next: http://localhost:58377/tests/v8_7/run.html) 05:39:30 INFO - 2015-11-16 05:39:30,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 535851008 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:30 INFO - 2015-11-16 05:39:30,815 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1321370309951 05:39:30 INFO - 2015-11-16 05:39:30,816 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.02405898331392 05:39:30 INFO - 2015-11-16 05:39:30,816 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.0102243680773 05:39:30 INFO - 2015-11-16 05:39:30,816 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 05:39:30 INFO - 2015-11-16 05:39:30,816 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1119.8208286674133 05:39:30 INFO - 2015-11-16 05:39:30,816 DEBUG : BROWSER_OUTPUT: |5;Earley;801.924619085806 05:39:30 INFO - 2015-11-16 05:39:30,817 DEBUG : BROWSER_OUTPUT: |6;Boyer;12456.79012345679 05:39:30 INFO - 2015-11-16 05:39:30,817 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 05:39:30 INFO - 2015-11-16 05:39:30,817 DEBUG : BROWSER_OUTPUT: |8;Splay;598.8023952095808 05:39:30 INFO - 2015-11-16 05:39:30,817 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4812.5 05:39:30 INFO - 2015-11-16 05:39:30,817 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:30 INFO - 2015-11-16 05:39:30,818 DEBUG : BROWSER_OUTPUT: __startTimestamp1447681170811__endTimestamp 05:39:30 INFO - 2015-11-16 05:39:30,818 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,818 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:30 INFO - 2015-11-16 05:39:30,818 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:39:30 INFO - 2015-11-16 05:39:30,818 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,819 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.13 Median:163.13 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,819 DEBUG : BROWSER_OUTPUT: Values: 163.1 05:39:30 INFO - 2015-11-16 05:39:30,819 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,819 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.02 Median:194.02 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,819 DEBUG : BROWSER_OUTPUT: Values: 194.0 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.01 Median:284.01 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: Values: 284.0 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: Values: 5055.6 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,820 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1119.82 Median:1119.82 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: Values: 1119.8 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: Values: 801.9 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: Values: 12456.8 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,821 DEBUG : BROWSER_OUTPUT: Values: 25820.5 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.80 Median:598.80 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: Values: 598.8 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: Values: 4812.5 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:30 INFO - 2015-11-16 05:39:30,822 DEBUG : BROWSER_OUTPUT: 05:39:31 INFO - 2015-11-16 05:39:31,617 INFO : Browser exited with error code: 0 05:39:31 INFO - 2015-11-16 05:39:31,631 INFO : Completed test v8_7 (00:00:39) 05:39:31 INFO - 2015-11-16 05:39:31,891 INFO : Completed test suite (00:20:09) 05:39:31 INFO - 2015-11-16 05:39:31,891 DEBUG : Working with test: dromaeo_css 05:39:31 INFO - 2015-11-16 05:39:31,891 DEBUG : Generating results file: dromaeo_css 05:39:31 INFO - 2015-11-16 05:39:31,892 DEBUG : Working with test: kraken 05:39:31 INFO - 2015-11-16 05:39:31,893 DEBUG : Generating results file: kraken 05:39:31 INFO - 2015-11-16 05:39:31,893 INFO : javascript benchmark 05:39:31 INFO - 2015-11-16 05:39:31,893 DEBUG : Working with test: v8_7 05:39:31 INFO - 2015-11-16 05:39:31,893 DEBUG : Generating results file: v8_7 05:39:31 INFO - 2015-11-16 05:39:31,893 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:31 INFO - 2015-11-16 05:39:31,941 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:39:31 INFO - 2015-11-16 05:39:31,941 DEBUG : process_Request line: dromaeo_css 6706.95 graph.html#tests=[[72,1,35]] 05:39:31 INFO - 2015-11-16 05:39:31,941 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:31 INFO - 2015-11-16 05:39:31,972 DEBUG : process_Request line: kraken 1493.40 graph.html#tests=[[232,1,35]] 05:39:31 INFO - 2015-11-16 05:39:31,972 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:32 INFO - 2015-11-16 05:39:32,002 DEBUG : process_Request line: v8_7 20973.44 graph.html#tests=[[230,1,35]] 05:39:32 INFO - 2015-11-16 05:39:32,004 INFO : javascript benchmark 05:39:32 INFO - 2015-11-16 05:39:32,008 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [331.63520127859374, 333.30006985330823, 344.20145262989865, 347.5429809800113, 348.1071052749697, 13611.387487563059, 13927.860721392783, 17365.479035628934, 17961.0, 18358.99999999998, 15665.373385064584, 16013.83986160138, 17272.136393180353, 17396.652066958653, 17403.564910877234, 5275.235090911825, 5415.675059496423, 5419.512243898049, 5432.837014889559, 5437.945620543804, 3968.543617483983, 4090.406891000803, 5387.865303367408, 5878.206442130322, 6026.548008899328, 6032.065029920369, 6062.757489700407, 6080.878382432371, 6096.481799047064, 6104.694765261741, 4936.654434189591, 5021.49785021495, 5027.49725027498, 5031.119554078022, 5032.874178145557, 4378.190034843564, 4378.211921854065, 4381.364702118175, 4389.275769498029, 4395.274779661352, 13917.791233131511, 14191.503297384543, 14404.855951440457, 14444.061136026125, 14458.69871711551, 2019.2528764357282, 2026.6858636911302, 2034.9898250508652, 2111.5037966077957, 2126.075157306577, 9984.700458986243, 10177.89822101777, 10196.3372380795, 10404.895951040544, 10512.579496820117, 1583.3903946980495, 1674.1294526846093, 1730.3078768492578, 1742.6166243426426, 1750.2736364408754, 53703.0, 54433.45566544363, 54591.0, 58985.41014589842, 62228.0, 7021.122359705037, 7156.964215178891, 7187.0, 7194.38847697941, 7240.855182896313, 8503.277221436247, 8508.446950948168, 8509.276711479593, 8509.872351914726, 8514.957425212835, 5552.91670624941, 5555.194496797942, 5573.665580065209, 5580.609357344947, 5592.97203513988, 5614.045612245928, 5642.153676948491, 5681.147827825776, 5681.687507187062, 5695.231143795618, 3270.2151483643756, 3320.286138480238, 3334.7665663403327, 3337.766356355032, 3350.7151892089446, 1128.3173679923527, 1172.5427083437467, 1180.4215934192184, 1193.8567371915426, 1193.8985186259265, 488.8753367891165, 491.7885309317028, 492.990140197194, 500.92986981822577, 504.41235960106064, 11787.410629468492, 11819.0, 12151.270923744603, 12174.147809653416, 12186.75626487483, 496.85591178558536, 501.914674505335, 505.8431886115316, 505.97217153056937, 513.9563137133385, 6331.0, 6582.111414959015, 6619.5035372347265, 6652.800415987528, 6657.600543967377, 489683.0, 494975.0, 498618.0, 502980.0, 510047.0, 73239.63380183066, 75245.0, 75381.0, 75510.0, 76242.0, 535.8097875254228, 546.7676237599004, 554.6339415985431, 570.9229254050733, 570.9371969083397, 11125.165612578927, 11171.888281117084, 11362.94318528402, 11565.190436669689, 11729.530818767154, 34668.0, 34765.65234347624, 34872.12819679528, 35431.82284088563, 35662.0, 44852.0, 46078.53921460877, 46223.76888115673, 46463.76768116138, 46935.29597056115, 6683.198016238082, 6948.062011628567, 6959.547629404073, 6962.164540255202, 6964.582125072512, 12087.879121209027, 12234.0, 12333.198342107735, 12334.876651233373, 12545.874541254836, 10725.41010244444, 10987.670369888596, 11014.44927753625, 11025.338479691245, 11060.115190784558, 10605.681829545127, 10683.358998460117, 10768.892311077103, 10831.133509319394, 10856.2400631955, 10917.344959302467, 10990.120790336914, 11350.318980861175, 11579.131565132817, 11723.531058757555, 6902.8619427610165, 6940.236573976757, 6982.51122421446, 6984.755533556301, 7010.75462358815, 10525.421101839473, 10544.89455105439, 10765.838512422477, 11274.041706455044, 11415.543378265109], "dojo.html": [3143.6384815746187, 3201.8078915265073, 3244.724198443132, 3253.8047717136988, 3266.608007039156, 5128.461511541281, 5259.710715910624, 5365.919511207335, 5394.703291318976, 5429.999999999995, 5259.500347466994, 5391.110466772978, 5393.460653934604, 5437.157240627709, 5448.37343705473, 4871.439784424792, 4938.80244790208, 4957.206846904496, 4970.826021089262, 5006.299118123466, 4777.450593181777, 4958.826441074563, 4972.8508144755715, 5020.121478741224, 5024.698518088908, 4836.806527738904, 4882.951170488285, 4946.431160416562, 4953.578945789613, 4968.950310496885, 4959.504049595048, 4973.204287314013, 4975.079610272075, 5006.374203224597, 5015.924761128586, 4743.7628118594275, 4876.317315575822, 4981.875453113701, 4982.526659967298, 5026.5727413169925, 5093.312402825608, 5170.638055336128, 5170.767315470813, 5176.094183517869, 5181.559567436772, 5775.5957083004205, 5852.356240813507, 5853.122031695238, 5853.795117170921, 5857.209276747627, 5771.769129234825, 5835.503982161521, 5858.912116318259, 5910.438508341744, 5955.52355811534, 5368.30212072432, 5447.373552041527, 5458.2904222450825, 5463.235147079372, 5494.478024587658, 5937.168796368512, 5946.197263369476, 5954.315253745788, 5955.702214889238, 5956.344802071769, 5648.548116150698, 5667.489925906688, 5780.6531608102805, 5791.189233507313, 5817.94182058174, 5762.366139724627, 5762.74067666956, 5768.048272035151, 5776.133579962955, 5800.564957628195, 5705.0, 5705.286839145107, 5713.771449141987, 5717.028105222123, 5728.112142617901, 5752.395998420189, 5777.480026797524, 5779.537636989031, 5896.823095307148, 5921.763129474859, 4454.510003899569, 4454.866354009385, 4456.665750068758, 4476.171908196994, 4486.237339652202, 3968.265870813909, 3972.2849887020034, 3982.064214909494, 4000.739951903117, 4012.6990475714438, 5304.204369344552, 5429.619926605179, 5446.7276636168035, 5520.806771762969, 5559.6664200148125, 5799.971000144972, 5829.5044921181325, 5835.883282334329, 5855.707214639251, 5867.911981320283, 5347.86630334237, 5518.944810551923, 5534.944650553523, 5539.501444869981, 5543.944560554423, 5008.449070602231, 5048.469910659328, 5068.138416469135, 5080.441151473335, 5117.130087885069, 6027.45752882234, 6040.7583696651645, 6041.214642096499, 6043.36544662804, 6044.879102418015, 5680.204771331934, 5815.476607105381, 5859.853503662272, 5869.35437101927, 5869.559783016376, 5933.851653708692, 6017.669028203491, 6023.397660233942, 6038.51691864641, 6077.3011103721865, 5784.710764461676, 5792.189093526994, 5796.072628379439, 5796.304443466643, 5799.391063938226, 5709.371969083314, 5753.942460575341, 5877.970610147093, 5913.85215369602, 5930.0, 5674.971625141848, 5676.489115979582, 5677.347105082803, 5680.176374425602, 5719.342275638355, 5663.716814159193, 5672.0, 5677.290338707661, 5679.233303504139, 5680.034394153086, 5404.945950540444, 5494.09347457665, 5519.31008623922, 5592.384837667934, 5596.300462442195, 5771.7402716877, 5791.247137872049, 5795.33353664334, 5812.099124635688, 5823.82528524145, 5668.37647858727, 5673.9432605675065, 5689.061304884648, 5689.459501347365, 5725.055365864586], "mootools.html": [1365.515242089059, 1687.9746803797943, 1710.8460238578525, 1739.139126132564, 1745.467632372126, 6794.4564434845215, 6992.685329160187, 7183.533070350423, 7189.604571748552, 7194.640267986606, 7394.149672787631, 7475.925240747591, 7477.027986361765, 7477.065366829146, 7491.0, 1959.9314024009163, 1997.4307322413042, 2183.4213933307688, 2247.898844551995, 2267.5351552931693, 2165.772593877644, 2172.5329054253334, 2178.302943058222, 2180.563887222554, 2180.6292930201826, 2162.686410470481, 2205.9227927022557, 2208.745994210662, 2210.10490751246, 2211.612967730649, 1965.7124583397826, 1994.3917105282883, 2185.180557291024, 2212.590670725921, 2226.220822712054, 2171.9022643981057, 2180.498485348363, 2202.9449263768374, 2206.6138425775425, 2267.195145723261, 7504.549727016342, 7546.69813207471, 7573.507721998052, 7576.356009739179, 7587.355074818647, 4452.799624016927, 4536.79584418702, 4551.977240113812, 4563.201439748031, 4567.3377360282575, 2889.1043776429374, 2949.115265420365, 2977.196157037588, 2984.7164519370626, 2992.251937015746, 888.0, 899.163777686751, 901.544719916438, 905.4069584422214, 910.3081657939947, 10338.586456541729, 10384.896151038469, 10399.948000260027, 10400.739981500446, 10410.53152608127, 4129.339305711072, 4134.979325103355, 4192.05678722285, 4196.160767846443, 4291.356296555542, 8987.325950553735, 8990.325725570608, 8991.820163596822, 8997.235235005099, 9000.279977601776, 4519.864404067883, 4546.931796023062, 4557.95442045582, 4571.062932098912, 4576.496585375606, 4127.9587204128175, 4134.235166494148, 4135.234981528427, 4136.131412403429, 4140.006398464347, 3583.157957879896, 3626.7642603230706, 3641.053326135171, 3643.4352675335367, 3664.523611930432, 1160.6808127764932, 1174.4890972427022, 1180.6694125644833, 1181.509673485494, 1184.413715210976, 1296.5397283964246, 1306.0922658752077, 1306.4382315604191, 1321.2666969831835, 1340.6179238917057, 7106.786796396116, 7110.822229444202, 7132.750353737698, 7150.642467876585, 7160.069191005136, 488.66770595995064, 497.31122395481793, 500.7521276967924, 504.6064070025386, 505.0580667055988, 5365.839024829262, 5539.362973258047, 5583.525400340935, 5596.412376700469, 5597.160425936142, 8823.514706691194, 9006.774830629156, 9097.363184577016, 9141.040190780006, 9163.58763855628, 8941.374103812801, 8955.194032536972, 9037.322200834964, 9043.050479699537, 9049.683261085962, 6772.255051944282, 7002.894956575554, 7003.26465721092, 7023.578585284899, 7063.717451301993, 6929.861402771816, 6966.0, 6986.126734158231, 7007.054047703495, 7020.894686579603, 8029.5583742894705, 8030.759077227693, 8087.83824323522, 8103.270705636521, 8113.310368618498, 8226.670933162846, 8277.337812975067, 8311.044229913396, 8406.579671016303, 8414.326853851555, 6839.247682754993, 6963.651817409211, 6973.965130174317, 6974.093367862146, 6983.057287266154, 7394.963025185055, 7395.889061663972, 7397.556146631219, 7401.444891633041, 7451.882217667393, 6760.22257440381, 6862.691178897061, 6952.061471701458, 7012.228654848064, 7124.750633727795, 6284.780032698834, 6426.485881129405, 6463.709133088928, 6883.621400823003, 6931.618760968196, 6774.898376524455, 6827.283135270725, 6830.795076147723, 6831.316868313328, 6833.80408428533, 6296.559240853279, 6298.842528936813, 6303.306636270098, 6334.809955701337, 6355.523335749745, 6037.245344331958, 6151.538634602333, 6154.3845615438095, 6161.0, 6172.22847144107], "ext.html": [562.5892662615895, 581.206652918766, 584.9649021058736, 599.1342510072943, 599.1462166412861, 29892.55161172584, 39610.0, 39768.80115599418, 39838.2032359353, 39848.0, 40942.795286023604, 41364.0, 41439.0, 41509.30189537678, 41511.0, 7729.690812367498, 7847.764567062969, 8669.956650216756, 8834.779130521723, 8858.069902660225, 10412.583496660163, 10553.41956192409, 10603.363798172135, 10617.946910265477, 10640.255182137253, 10278.383297002167, 10331.58673653053, 10396.896031039707, 10398.428086455242, 10406.32358896673, 7932.722354717586, 8066.274035336848, 10258.179345652366, 10502.0, 10723.302985306009, 10112.140468060225, 10240.924702906237, 10241.53913073906, 10243.539040743184, 10244.078032977068, 33252.50121248183, 39367.60632393668, 39755.20489590192, 39758.0, 39871.8006409969, 2798.958015629767, 3262.5432439458496, 3414.6926776589976, 3792.867249646249, 3882.9038409696786, 29350.706492935013, 30034.0, 30068.398632027456, 30113.397732045454, 30408.54387184194, 2835.6313679221776, 2864.7309838560423, 2921.7078292170827, 2935.2955290730283, 3007.383486385286, 269108.27229319426, 269616.0, 269760.0, 269789.0, 269964.0, 56861.43138568644, 57233.71383143141, 57234.7138264306, 57237.0, 57322.0, 60010.0, 60195.37850836405, 60303.0, 60351.69824150939, 60353.0, 13604.795928061087, 14339.78490322646, 14546.709065818624, 14550.927245363917, 14560.563183104523, 10049.799004019878, 10149.34029288094, 10199.0820826126, 10208.744781380525, 10947.726306842393, 18755.249790008518, 19180.328688496116, 19353.51616209606, 19811.306604268782, 19895.0, 7278.454115941219, 7400.5189662671755, 7431.665575049135, 7443.962780186064, 7467.551946883204, 885.9778505537413, 903.7605034665819, 956.8899576548786, 1023.6673081248624, 1027.8047171037629, 25560.8721956389, 25608.48783024329, 25937.870310648326, 26043.0, 27186.456270874867, 1036.5387402605768, 1050.7005503431485, 1062.5218651606654, 1084.821004534243, 1151.3725019864194, 14395.64010899715, 14421.567352979428, 15037.699246015018, 15449.459268925533, 15556.22218889051, 305989.0, 310854.0, 311996.0, 312294.0, 312377.0, 52199.73900130551, 52296.73851630794, 52570.73714631402, 52576.474235257156, 52600.736996315536, 1365.528892532075, 1368.3979049218312, 1380.0063953953138, 1384.0311781752814, 1388.4654408052972, 27565.31086722848, 28442.862285509174, 28492.145235642965, 28778.71221287844, 28965.275868102624, 45088.0, 45305.093898121195, 45373.092538149715, 45393.31910021418, 45398.546014540756, 291720.0, 294418.0, 294878.0, 295131.0, 295452.0, 28306.43387132287, 30422.391552169276, 31462.0, 31486.685133148374, 31662.208444789063, 39124.804375979074, 39436.802815985735, 41375.7931210342, 42384.576154238064, 42758.358624620036, 33120.834395827864, 33186.5022024665, 33230.50154247737, 33375.49936750902, 33649.663503365635, 31933.0, 33391.66608333983, 33474.0, 33478.83260583682, 37200.44199336958, 33653.663463365054, 34254.82872585621, 34859.0, 34918.47622285617, 34954.47568286427, 29894.25264368408, 31940.36119277648, 32065.51901721523, 32289.677103228667, 32370.352592947536, 23732.88133559321, 23868.88065559661, 23995.02054027138, 24016.39959001039, 24036.87981560081], "prototype.html": [300.364728599013, 304.4565450670553, 310.0466066844454, 310.26931576138196, 313.3951473655843, 6128.172696685946, 6154.538409619279, 6314.305426403103, 6318.957372033615, 6351.460125889305, 6140.2938662053875, 6207.286162091361, 6209.348018458053, 6214.223222097238, 6222.222222222223, 4451.5993560579545, 4554.453465584134, 4676.0, 4676.415448068991, 4679.227927391977, 4523.751193684346, 4611.838585649503, 4626.653001024936, 4642.744649044301, 4661.044485880403, 4578.908421831561, 4581.0, 4583.335416364625, 4583.381243532114, 4586.082783443308, 4408.118376324748, 4511.774411279423, 4512.758991277392, 4586.678932474728, 4608.262677971508, 3927.8625248116464, 3937.3700207966876, 3939.98030009851, 3945.684345252373, 3956.742811717229, 5845.357010728816, 5846.649201047951, 5855.092460668603, 5861.794837180721, 5867.11993201019, 5318.787248510055, 5350.866228344284, 5352.839414817562, 5353.0, 5361.490658387486, 6316.494680425555, 6485.2541957675, 6485.870282594369, 6493.51298652603, 6502.609843409363, 4306.547812479707, 4309.849155279581, 4311.611954924072, 4312.504062032875, 4314.827406903752, 6718.798436046926, 6749.987501874709, 6816.99999999995, 6820.215675197366, 6829.351211634887, 4338.436003319612, 4453.376527286183, 4453.732776033448, 4453.755043472575, 4455.799489023002, 4489.910201795946, 4498.887527811831, 4502.662300327489, 4505.594496495331, 4505.819767209275, 5330.546903513167, 5334.199870019451, 5338.412774594792, 5338.946610533845, 5341.359036915517, 6625.271220165778, 6633.170853643294, 6636.502262330248, 6638.767643132467, 6643.40209381158, 1537.331260901489, 1587.2381256996475, 1591.043017088964, 1591.4111778641977, 1595.1226825246067, 1015.939043657383, 1027.5376080763685, 1037.092544023979, 1037.1754455207977, 1049.2969710294121, 6365.586236894587, 6388.39310265524, 6391.96804015977, 6392.20097487814, 6405.3594640535575, 6759.898601520981, 6823.283555226729, 6837.555558888656, 6839.316068393121, 6846.212685541127, 6222.595531290452, 6392.0411938209645, 6394.729870895765, 6400.551961362753, 6409.455196308366, 3585.103724068983, 3646.0, 3660.5790334111384, 3744.6817020553012, 3745.3632882410056, 7163.570185788869, 7173.605451700207, 7176.1388633363285, 7196.532225405332, 7198.064251647253, 6833.350831670983, 7028.121484814398, 7035.8241043973285, 7049.400800931979, 7050.6827192776445, 7134.286571342825, 7141.428685705235, 7145.82135446618, 7155.570665760071, 7159.928400715926, 6851.07510486078, 6852.794416167523, 6855.280195579392, 6858.279880612464, 6867.725290988305, 6645.767398141042, 6766.323367663194, 6768.898466523105, 6784.728610855511, 6786.898196527155, 7067.2579379164445, 7144.499885007999, 7149.785506434815, 7153.605047015782, 7153.964230178815, 4463.977680111579, 4495.842645507391, 4511.1654343946475, 4521.0, 4525.456945166601, 6668.933310666831, 6823.0, 6862.451003919575, 6863.210730766026, 6877.243503214542, 6671.933280667131, 6677.3656502632175, 6678.49911256648, 6686.53194276396, 6687.1975362956755, 6662.467002639681, 6665.566738162198, 6666.133402657623, 6670.466362691071, 6678.332166783477, 6448.065030570635, 6513.381228783258, 6538.869222615616, 6552.0, 6563.671816409256, 6692.431143352675, 6702.798916032331, 6706.429953454011, 6707.3628005339415, 6711.563748356341, 6537.953927371597, 6542.34576542342, 6542.574732642363, 6546.967265163644, 6551.868962620816], "yui.html": [751.4476859508262, 767.7696690992701, 778.1479280188194, 786.1666633368629, 809.2676128104064, 14155.929220353897, 14410.423583056665, 14433.783493247609, 14439.63900902478, 14448.494302699408, 13569.52506662267, 13628.931855340734, 13656.453741850313, 13684.178949263027, 13689.931550342259, 672.6166085331363, 672.7947975867359, 673.9157605299338, 789.6604460082162, 808.9635966381512, 814.0882211922625, 821.1337039423406, 821.2034326703089, 822.0751654388813, 824.1099612418574, 850.7107583421636, 853.4580541356221, 855.324293807891, 855.7903313688155, 855.9614817333235, 704.1972151747012, 706.7385067524997, 852.1521086518953, 853.4026181672823, 858.6393714639867, 621.1614320667109, 623.9220097487814, 627.6830200748639, 627.9843003924892, 629.4712441549075, 13599.59201223965, 13599.728005439934, 13617.727645447134, 13631.591052268448, 13737.313134343243, 11405.258658187191, 11867.821982670266, 12381.442835072443, 12717.936410317889, 12827.422765975554, 10619.522121504551, 10746.516406761637, 10928.508217130247, 10937.398443085627, 10964.780704385947, 3623.4564815277654, 3669.4679271505483, 3692.280005398948, 3760.4735337052834, 3763.4542991266385, 47883.52116478825, 47905.0, 47971.76014119942, 48223.0, 48567.27149092766, 9907.851382229272, 10099.848502272473, 10248.743781405525, 10556.26106172576, 10574.275469978853, 19032.52418689516, 19086.904565477085, 19104.713429298572, 19118.904405477882, 19133.13900874464, 7378.151512576015, 8018.5990700464745, 8175.836483270301, 8261.297789687824, 8265.752027439186, 4452.376667266585, 4484.372187893698, 4502.527234640381, 4537.447549679378, 4729.314249433882, 3013.4877070898, 3076.9846150769104, 3080.122165182912, 3082.2448500117616, 3085.4446199683825, 462.5004994605885, 464.3730963199653, 473.8720545452708, 475.61950439648143, 478.6816766850075, 515.8985565817007, 634.6985182038495, 660.3429587560312, 701.929807019294, 717.3077979749567, 8242.587870606445, 8466.915330846736, 8686.261667758312, 8764.430312029697, 8813.867791983126, 475.8429718192988, 612.8774245150987, 646.3794757033301, 682.8054004608762, 689.290031267795, 3838.846446142179, 3997.6402123809, 4150.5641907599875, 4197.9370309445385, 4240.363945408152, 56840.43159568434, 57110.0, 57120.42879571151, 57493.0, 57557.0, 47846.10539260983, 48740.75629621829, 48864.51135488671, 49000.0, 49425.50574494209, 45306.09387812225, 45337.31994020158, 45427.54572454299, 46408.303875441896, 47068.29397559039, 8567.143285671384, 8855.557222138996, 8864.911350886667, 8949.507777072064, 9482.810343793224, 34253.14367140841, 34296.0, 34701.13247168841, 35124.0, 35449.1137721559, 43532.782336088116, 43712.0, 44604.77697611491, 44719.329210062526, 44796.32805507985, 8012.839743204987, 8180.148893279863, 8220.958895205486, 8259.256666899768, 8508.829823403621, 11248.437578121226, 11257.49341279628, 11968.640940771791, 12453.813192802296, 12790.936045319713, 11447.313161210353, 11562.248453850809, 11572.074234061087, 11592.768144637228, 12024.639260822189, 11405.600803971822, 11470.254433461798, 11755.764884702428, 12211.572594959134, 12344.506219751109, 11379.260348077349, 11725.237859539102, 11732.648020559396, 11794.941025294818, 11803.0, 9532.666356677482, 9776.0, 9850.852237216592, 9927.751806204902, 10098.0, 8844.823103538021, 9490.335676502578, 9743.610255589698, 9780.217582593234, 9850.162736167505]}, "summary": {"lowerIsBetter": false, "suite": 6706.946958580733, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7119.334136239477, "unit": "ms", "value": 7119.334136239477}, "dojo.html": {"lowerIsBetter": false, "filtered": 5358.361286010989, "unit": "ms", "value": 5358.361286010989}, "mootools.html": {"lowerIsBetter": false, "filtered": 4274.489813131134, "unit": "ms", "value": 4274.489813131134}, "ext.html": {"lowerIsBetter": false, "filtered": 18214.950718490316, "unit": "ms", "value": 18214.950718490316}, "prototype.html": {"lowerIsBetter": false, "filtered": 4893.795585336889, "unit": "ms", "value": 4893.795585336889}, "yui.html": {"lowerIsBetter": false, "filtered": 6261.561904901536, "unit": "ms", "value": 6261.561904901536}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447679962, "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": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 162.0, 162.0, 160.0, 159.0, 159.0, 163.0, 160.0, 160.0], "ai-astar": [110.0, 111.0, 103.0, 111.0, 110.0, 112.0, 99.0, 110.0, 115.0, 110.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [154.0, 130.0, 155.0, 159.0, 126.0, 151.0, 153.0, 125.0, 163.0, 124.0], "json-stringify-tinderbox": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [143.0, 150.0, 148.0, 149.0, 148.0, 140.0, 148.0, 149.0, 147.0, 139.0], "json-parse-financial": [59.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 65.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0, 65.0, 67.0], "audio-fft": [72.0, 72.0, 85.0, 96.0, 72.0, 73.0, 72.0, 111.0, 93.0, 72.0], "imaging-darkroom": [145.0, 145.0, 146.0, 147.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0], "stanford-crypto-ccm": [122.0, 122.0, 112.0, 117.0, 121.0, 117.0, 123.0, 116.0, 120.0, 126.0], "audio-oscillator": [89.0, 90.0, 135.0, 90.0, 90.0, 90.0, 137.0, 90.0, 90.0, 135.0], "stanford-crypto-aes": [84.0, 87.0, 87.0, 86.0, 84.0, 85.0, 85.0, 86.0, 86.0, 86.0], "imaging-desaturate": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1493.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.8, "unit": "ms", "value": 81.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.1, "unit": "ms", "value": 146.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.6, "unit": "ms", "value": 119.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.1, "unit": "ms", "value": 58.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.6, "unit": "ms", "value": 103.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.8, "unit": "ms", "value": 160.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.7, "unit": "ms", "value": 65.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.5, "unit": "ms", "value": 68.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447679962, "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": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.02405898331392], "Encrypt": [284.0102243680773], "NavierStokes": [4812.5], "Decrypt": [5055.555555555556], "Splay": [598.8023952095808], "Richards": [163.1321370309951], "RegExp": [25820.51282051282], "Earley": [801.924619085806], "Boyer": [12456.79012345679], "RayTrace": [1119.8208286674133]}, "summary": {"lowerIsBetter": false, "suite": 20973.439924079572, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.772172, "unit": "score", "value": 340.772172}, "Encrypt": {"lowerIsBetter": false, "filtered": 937.2233010000001, "unit": "score", "value": 937.2233010000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.3636363636364, "unit": "score", "value": 308.3636363636364}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.65118681318681, "unit": "score", "value": 52.65118681318681}, "Splay": {"lowerIsBetter": false, "filtered": 136.08996999999997, "unit": "score", "value": 136.08996999999997}, "RegExp": {"lowerIsBetter": false, "filtered": 35.28144488579943, "unit": "score", "value": 35.28144488579943}, "Richards": {"lowerIsBetter": false, "filtered": 216.40126, "unit": "score", "value": 216.40126}, "Earley": {"lowerIsBetter": false, "filtered": 831.079361, "unit": "score", "value": 831.079361}, "Boyer": {"lowerIsBetter": false, "filtered": 53.501985133795806, "unit": "score", "value": 53.501985133795806}, "RayTrace": {"lowerIsBetter": false, "filtered": 660.8101769999998, "unit": "score", "value": 660.8101769999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447679962, "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": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 05:39:32 INFO - RETURN: dromaeo_css: 6706.95 05:39:32 INFO - RETURN: kraken: 1493.40 05:39:32 INFO - RETURN: v8_7: 20973.44 05:39:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20973.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6706.95"}}} 05:39:32 INFO - Return code: 0 05:39:32 INFO - # TBPL SUCCESS # 05:39:32 INFO - Running post-action listener: _resource_record_post_action 05:39:32 INFO - Running post-run listener: _resource_record_post_run 05:39:33 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509140992; Read time: 12; Write time: 491628 05:39:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 234176512; Read time: 0; Write time: 337864 05:39:33 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 274964480; Read time: 0; Write time: 153764 05:39:33 INFO - Running post-run listener: _upload_blobber_files 05:39:33 INFO - Blob upload gear active. 05:39:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:39:33 INFO - Copying logs to upload dir... 05:39:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.865475 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 05:39:32.956532) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:32.960314) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010039 build_url: 'https://queue.taskcluster.net/v1/task/wktbw61TRvWn_d7jjIt0oQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:33.012912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:33.013266) ========= 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=7d909545e45784438f4e8e36000001b3-1447676293.430322-896630370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:39:33.062774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:39:33.063120) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:39:33.063404) ========= ========= Total master_lag: 0.23 =========