builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1448354913.58 results: success (0) buildid: 20151123233007 builduid: 9fdcbe9d33cd44f6a0456fb8cd41c599 revision: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.578414) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.578846) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.579137) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006680 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.611677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.611986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.636316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.636683) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.689511) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.690014) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.690617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.691058) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 00:48:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-11-24 00:48:35 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.808682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.809147) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.860179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:33.860733) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 00:48:35,193 truncating revision to first 12 chars 2015-11-24 00:48:35,194 Setting DEBUG logging. 2015-11-24 00:48:35,194 attempt 1/10 2015-11-24 00:48:35,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dca10306d58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 00:48:35,447 unpacking tar archive at: fx-team-4dca10306d58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:34.419204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:34.419785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:34.428845) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:34.429290) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 00:48:34.429852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-24 00:48:34.430144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:35 INFO - MultiFileLogger online at 20151124 00:48:35 in /builds/slave/test-pgo 00:48:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:48:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:48:35 INFO - {'append_to_log': False, 00:48:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:48:35 INFO - 'blob_upload_branch': 'Fx-Team', 00:48:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:48:35 INFO - 'branch': 'Fx-Team', 00:48:35 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:35 INFO - 'config_files': ('talos/linux_config.py',), 00:48:35 INFO - 'default_actions': ('clobber', 00:48:35 INFO - 'read-buildbot-config', 00:48:35 INFO - 'download-and-extract', 00:48:35 INFO - 'populate-webroot', 00:48:35 INFO - 'create-virtualenv', 00:48:35 INFO - 'install', 00:48:35 INFO - 'run-tests'), 00:48:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:35 INFO - 'download_minidump_stackwalk': True, 00:48:35 INFO - 'download_symbols': 'ondemand', 00:48:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:35 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:35 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:35 INFO - 'installer_path': 'installer.exe', 00:48:35 INFO - 'log_level': 'info', 00:48:35 INFO - 'log_name': 'talos', 00:48:35 INFO - 'log_to_console': True, 00:48:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:35 INFO - 'opt_config_files': (), 00:48:35 INFO - 'pip_index': False, 00:48:35 INFO - 'sps_profile': False, 00:48:35 INFO - 'sps_profile_interval': 0, 00:48:35 INFO - 'suite': 'dromaeojs-e10s', 00:48:35 INFO - 'system_bits': '64', 00:48:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:35 INFO - 'title': 'talos-linux64-ix-025', 00:48:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:35 INFO - 'use_talos_json': True, 00:48:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:48:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:35 INFO - 'work_dir': 'build'} 00:48:35 INFO - ##### 00:48:35 INFO - ##### Running clobber step. 00:48:35 INFO - ##### 00:48:35 INFO - Running pre-action listener: _resource_record_pre_action 00:48:35 INFO - Running main action method: clobber 00:48:35 INFO - rmtree: /builds/slave/test-pgo/build 00:48:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:48:36 INFO - Running post-action listener: _resource_record_post_action 00:48:36 INFO - ##### 00:48:36 INFO - ##### Running read-buildbot-config step. 00:48:36 INFO - ##### 00:48:36 INFO - Running pre-action listener: _resource_record_pre_action 00:48:36 INFO - Running main action method: read_buildbot_config 00:48:36 INFO - Using buildbot properties: 00:48:36 INFO - { 00:48:36 INFO - "properties": { 00:48:36 INFO - "buildnumber": 103, 00:48:36 INFO - "product": "firefox", 00:48:36 INFO - "script_repo_revision": "production", 00:48:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 00:48:36 INFO - "repository": "", 00:48:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 00:48:36 INFO - "buildid": "20151123233007", 00:48:36 INFO - "slavename": "talos-linux64-ix-025", 00:48:36 INFO - "pgo_build": "True", 00:48:36 INFO - "basedir": "/builds/slave/test-pgo", 00:48:36 INFO - "project": "", 00:48:36 INFO - "platform": "ubuntu64_hw", 00:48:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:48:36 INFO - "slavebuilddir": "test", 00:48:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 00:48:36 INFO - "branch": "fx-team", 00:48:36 INFO - "repo_path": "integration/fx-team", 00:48:36 INFO - "stage_platform": "linux64-pgo", 00:48:36 INFO - "builduid": "9fdcbe9d33cd44f6a0456fb8cd41c599", 00:48:36 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:36 INFO - }, 00:48:36 INFO - "sourcestamp": { 00:48:36 INFO - "repository": "", 00:48:36 INFO - "hasPatch": false, 00:48:36 INFO - "project": "", 00:48:36 INFO - "branch": "fx-team-linux64-pgo-talos", 00:48:36 INFO - "changes": [ 00:48:36 INFO - { 00:48:36 INFO - "category": null, 00:48:36 INFO - "files": [ 00:48:36 INFO - { 00:48:36 INFO - "url": null, 00:48:36 INFO - "name": "https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:48:36 INFO - } 00:48:36 INFO - ], 00:48:36 INFO - "repository": "", 00:48:36 INFO - "rev": "4dca10306d58d2e87cbed46a72472b62c17b0ec9", 00:48:36 INFO - "who": "sendchange", 00:48:36 INFO - "when": 1448354855, 00:48:36 INFO - "number": 6699375, 00:48:36 INFO - "comments": "", 00:48:36 INFO - "project": "", 00:48:36 INFO - "at": "Tue 24 Nov 2015 00:47:35", 00:48:36 INFO - "branch": "fx-team-linux64-pgo-talos", 00:48:36 INFO - "revlink": "", 00:48:36 INFO - "properties": [ 00:48:36 INFO - [ 00:48:36 INFO - "buildid", 00:48:36 INFO - "20151123233007", 00:48:36 INFO - "Change" 00:48:36 INFO - ], 00:48:36 INFO - [ 00:48:36 INFO - "builduid", 00:48:36 INFO - "9fdcbe9d33cd44f6a0456fb8cd41c599", 00:48:36 INFO - "Change" 00:48:36 INFO - ], 00:48:36 INFO - [ 00:48:36 INFO - "pgo_build", 00:48:36 INFO - "True", 00:48:36 INFO - "Change" 00:48:36 INFO - ] 00:48:36 INFO - ], 00:48:36 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:36 INFO - } 00:48:36 INFO - ], 00:48:36 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 00:48:36 INFO - } 00:48:36 INFO - } 00:48:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:48:36 INFO - Running post-action listener: _resource_record_post_action 00:48:36 INFO - ##### 00:48:36 INFO - ##### Running download-and-extract step. 00:48:36 INFO - ##### 00:48:36 INFO - Running pre-action listener: _resource_record_pre_action 00:48:36 INFO - Running main action method: download_and_extract 00:48:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:48: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')]} 00:48:36 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json 00:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json 00:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:48:37 INFO - Downloaded 1302 bytes. 00:48:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:48:37 INFO - Using the following test package requirements: 00:48:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'jsshell-linux-x86_64.zip'], 00:48:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:37 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:48:38 INFO - Downloaded 22525990 bytes. 00:48: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 00:48:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48: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 00:48:40 INFO - Return code: 0 00:48:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:40 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:48:44 INFO - Downloaded 22525990 bytes. 00:48:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 00:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:48:46 INFO - Return code: 0 00:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:46 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:48:46 INFO - Downloaded 11130997 bytes. 00:48:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 00:48:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:48:47 INFO - Return code: 0 00:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:47 INFO - https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:48:48 INFO - Downloaded 57588136 bytes. 00:48:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - mkdir: /builds/slave/test-pgo/properties 00:48:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:48:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:48:48 INFO - Contents: 00:48:48 INFO - build_url:https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - Running post-action listener: _resource_record_post_action 00:48:48 INFO - Running post-action listener: set_extra_try_arguments 00:48:48 INFO - ##### 00:48:48 INFO - ##### Running populate-webroot step. 00:48:48 INFO - ##### 00:48:48 INFO - Running pre-action listener: _resource_record_pre_action 00:48:48 INFO - Running main action method: populate_webroot 00:48:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:48:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:48:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:48:48 INFO - '../fennec_ids.txt'], 00:48:48 INFO - 'tests': ['tcheck2']}, 00:48:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:48:48 INFO - '--tppagecycles', 00:48:48 INFO - '7'], 00:48:48 INFO - 'tests': ['tsvgm']}}, 00:48:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:48:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:48:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'tests': ['damp', 'tps']}, 00:48:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['damp', 'tps']}, 00:48:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:48:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:48:48 INFO - 'other': {'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'other_l64': {'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'other_nol64': {'tests': ['a11yr', 00:48:48 INFO - 'ts_paint', 00:48:48 INFO - 'tpaint', 00:48:48 INFO - 'sessionrestore', 00:48:48 INFO - 'sessionrestore_no_auto_restore']}, 00:48:48 INFO - 'svgr': {'tests': ['tsvgx', 00:48:48 INFO - 'tsvgr_opacity', 00:48:48 INFO - 'tart', 00:48:48 INFO - 'tscrollx', 00:48:48 INFO - 'cart']}, 00:48:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['tsvgx', 00:48:48 INFO - 'tsvgr_opacity', 00:48:48 INFO - 'tart', 00:48:48 INFO - 'tscrollx', 00:48:48 INFO - 'cart']}, 00:48:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'tests': ['tp5o']}, 00:48:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'talos_options': ['--e10s'], 00:48:48 INFO - 'tests': ['tp5o']}, 00:48:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'talos_options': ['--xperf_path', 00:48:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:48 INFO - 'tests': ['tp5n']}, 00:48:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:48 INFO - 'talos_options': ['--e10s', 00:48:48 INFO - '--xperf_path', 00:48:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:48 INFO - 'tests': ['tp5n']}}, 00:48:48 INFO - 'talos.zip': {'path': '', 00:48:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:48:48 INFO - Running post-action listener: _resource_record_post_action 00:48:48 INFO - ##### 00:48:48 INFO - ##### Running create-virtualenv step. 00:48:48 INFO - ##### 00:48:48 INFO - Running pre-action listener: _resource_record_pre_action 00:48:48 INFO - Running main action method: create_virtualenv 00:48:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:48:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 00:48:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:48:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:48:48 INFO - Using real prefix '/usr' 00:48:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:48:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:48:51 INFO - Installing pip.................done. 00:48:51 INFO - Return code: 0 00:48:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:48:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 00:48:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:48:51 INFO - Using env: {'DISPLAY': ':0', 00:48:51 INFO - 'HOME': '/home/cltbld', 00:48:51 INFO - 'LANG': 'en_US.UTF-8', 00:48:51 INFO - 'LANGUAGE': 'en_US:en', 00:48:51 INFO - 'LOGNAME': 'cltbld', 00:48:51 INFO - 'MAIL': '/var/mail/cltbld', 00:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:51 INFO - 'MOZ_NO_REMOTE': '1', 00:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:51 INFO - 'NO_EM_RESTART': '1', 00:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:51 INFO - 'SHELL': '/bin/bash', 00:48:51 INFO - 'SHLVL': '1', 00:48:51 INFO - 'TERM': 'linux', 00:48:51 INFO - 'TMOUT': '86400', 00:48:51 INFO - 'USER': 'cltbld', 00:48:51 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:51 INFO - '_': '/tools/buildbot/bin/python'} 00:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:48:51 INFO - Cleaning up... 00:48:51 INFO - Return code: 0 00:48:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:48:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:48:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:48:51 INFO - Using env: {'DISPLAY': ':0', 00:48:51 INFO - 'HOME': '/home/cltbld', 00:48:51 INFO - 'LANG': 'en_US.UTF-8', 00:48:51 INFO - 'LANGUAGE': 'en_US:en', 00:48:51 INFO - 'LOGNAME': 'cltbld', 00:48:51 INFO - 'MAIL': '/var/mail/cltbld', 00:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:51 INFO - 'MOZ_NO_REMOTE': '1', 00:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:51 INFO - 'NO_EM_RESTART': '1', 00:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:51 INFO - 'SHELL': '/bin/bash', 00:48:51 INFO - 'SHLVL': '1', 00:48:51 INFO - 'TERM': 'linux', 00:48:51 INFO - 'TMOUT': '86400', 00:48:51 INFO - 'USER': 'cltbld', 00:48:51 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:51 INFO - '_': '/tools/buildbot/bin/python'} 00:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:51 INFO - Downloading/unpacking psutil>=0.7.1 00:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:48:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:53 INFO - Installing collected packages: psutil 00:48:53 INFO - Running setup.py install for psutil 00:48:53 INFO - building 'psutil._psutil_linux' extension 00:48:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 00:48:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:48:53 INFO - building 'psutil._psutil_posix' extension 00:48:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:48:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:53 INFO - Successfully installed psutil 00:48:53 INFO - Cleaning up... 00:48:54 INFO - Return code: 0 00:48:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:48: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 00:48: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 00:48:54 INFO - Using env: {'DISPLAY': ':0', 00:48:54 INFO - 'HOME': '/home/cltbld', 00:48:54 INFO - 'LANG': 'en_US.UTF-8', 00:48:54 INFO - 'LANGUAGE': 'en_US:en', 00:48:54 INFO - 'LOGNAME': 'cltbld', 00:48:54 INFO - 'MAIL': '/var/mail/cltbld', 00:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:54 INFO - 'MOZ_NO_REMOTE': '1', 00:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:54 INFO - 'NO_EM_RESTART': '1', 00:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:54 INFO - 'SHELL': '/bin/bash', 00:48:54 INFO - 'SHLVL': '1', 00:48:54 INFO - 'TERM': 'linux', 00:48:54 INFO - 'TMOUT': '86400', 00:48:54 INFO - 'USER': 'cltbld', 00:48:54 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:54 INFO - '_': '/tools/buildbot/bin/python'} 00:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:48:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:48:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:48:55 INFO - Installing collected packages: mozsystemmonitor 00:48:55 INFO - Running setup.py install for mozsystemmonitor 00:48:56 INFO - Successfully installed mozsystemmonitor 00:48:56 INFO - Cleaning up... 00:48:56 INFO - Return code: 0 00:48:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:56 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 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:48:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:48:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:48:56 INFO - Using env: {'DISPLAY': ':0', 00:48:56 INFO - 'HOME': '/home/cltbld', 00:48:56 INFO - 'LANG': 'en_US.UTF-8', 00:48:56 INFO - 'LANGUAGE': 'en_US:en', 00:48:56 INFO - 'LOGNAME': 'cltbld', 00:48:56 INFO - 'MAIL': '/var/mail/cltbld', 00:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:56 INFO - 'MOZ_NO_REMOTE': '1', 00:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:56 INFO - 'NO_EM_RESTART': '1', 00:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:56 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:56 INFO - 'SHELL': '/bin/bash', 00:48:56 INFO - 'SHLVL': '1', 00:48:56 INFO - 'TERM': 'linux', 00:48:56 INFO - 'TMOUT': '86400', 00:48:56 INFO - 'USER': 'cltbld', 00:48:56 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:56 INFO - '_': '/tools/buildbot/bin/python'} 00:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:56 INFO - Downloading/unpacking blobuploader==1.2.4 00:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:57 INFO - Downloading blobuploader-1.2.4.tar.gz 00:48:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:48:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:48:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:48:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48: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 00:48:58 INFO - Downloading docopt-0.6.1.tar.gz 00:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:48:58 INFO - Installing collected packages: blobuploader, requests, docopt 00:48:58 INFO - Running setup.py install for blobuploader 00:48:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:48:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:48:58 INFO - Running setup.py install for requests 00:48:59 INFO - Running setup.py install for docopt 00:48:59 INFO - Successfully installed blobuploader requests docopt 00:48:59 INFO - Cleaning up... 00:48:59 INFO - Return code: 0 00:48:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:59 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 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:48:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:48:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:48:59 INFO - Using env: {'DISPLAY': ':0', 00:48:59 INFO - 'HOME': '/home/cltbld', 00:48:59 INFO - 'LANG': 'en_US.UTF-8', 00:48:59 INFO - 'LANGUAGE': 'en_US:en', 00:48:59 INFO - 'LOGNAME': 'cltbld', 00:48:59 INFO - 'MAIL': '/var/mail/cltbld', 00:48:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:59 INFO - 'MOZ_NO_REMOTE': '1', 00:48:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:59 INFO - 'NO_EM_RESTART': '1', 00:48:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:59 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:59 INFO - 'SHELL': '/bin/bash', 00:48:59 INFO - 'SHLVL': '1', 00:48:59 INFO - 'TERM': 'linux', 00:48:59 INFO - 'TMOUT': '86400', 00:48:59 INFO - 'USER': 'cltbld', 00:48:59 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:48:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:59 INFO - '_': '/tools/buildbot/bin/python'} 00:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:48:59 INFO - Running setup.py (path:/tmp/pip-qx_QYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:48:59 INFO - Running setup.py (path:/tmp/pip-37iqnX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:48:59 INFO - Running setup.py (path:/tmp/pip-SPVQXl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:48:59 INFO - Running setup.py (path:/tmp/pip-lVQMLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:48:59 INFO - Running setup.py (path:/tmp/pip-f5TGvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:48:59 INFO - Running setup.py (path:/tmp/pip-Yf4wQJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:48:59 INFO - Running setup.py (path:/tmp/pip-RzlMdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:48:59 INFO - Running setup.py (path:/tmp/pip-ekiOBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:00 INFO - Running setup.py (path:/tmp/pip-pXI0Do-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:00 INFO - Running setup.py (path:/tmp/pip-qXuLoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:00 INFO - Running setup.py (path:/tmp/pip-txR5of-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:00 INFO - Running setup.py (path:/tmp/pip-wXAWdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:00 INFO - Running setup.py (path:/tmp/pip-0wmC9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:00 INFO - Running setup.py (path:/tmp/pip-TllXDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:00 INFO - Running setup.py (path:/tmp/pip-aj8EWq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:00 INFO - Running setup.py (path:/tmp/pip-sZseYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:00 INFO - Running setup.py (path:/tmp/pip-giT_fQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:00 INFO - Running setup.py install for manifestparser 00:49:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:00 INFO - Running setup.py install for mozcrash 00:49:00 INFO - Running setup.py install for mozdebug 00:49:01 INFO - Running setup.py install for mozdevice 00:49:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozfile 00:49:01 INFO - Running setup.py install for mozhttpd 00:49:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozinfo 00:49:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozInstall 00:49:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozleak 00:49:01 INFO - Running setup.py install for mozlog 00:49:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for moznetwork 00:49:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozprocess 00:49:01 INFO - Running setup.py install for mozprofile 00:49:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozrunner 00:49:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozscreenshot 00:49:02 INFO - Running setup.py install for moztest 00:49:02 INFO - Running setup.py install for mozversion 00:49:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:02 INFO - Cleaning up... 00:49:02 INFO - Return code: 0 00:49:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:49:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 00:49:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:49:02 INFO - Using env: {'DISPLAY': ':0', 00:49:02 INFO - 'HOME': '/home/cltbld', 00:49:02 INFO - 'LANG': 'en_US.UTF-8', 00:49:02 INFO - 'LANGUAGE': 'en_US:en', 00:49:02 INFO - 'LOGNAME': 'cltbld', 00:49:02 INFO - 'MAIL': '/var/mail/cltbld', 00:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:02 INFO - 'MOZ_NO_REMOTE': '1', 00:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:02 INFO - 'NO_EM_RESTART': '1', 00:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:02 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:02 INFO - 'SHELL': '/bin/bash', 00:49:02 INFO - 'SHLVL': '1', 00:49:02 INFO - 'TERM': 'linux', 00:49:02 INFO - 'TMOUT': '86400', 00:49:02 INFO - 'USER': 'cltbld', 00:49:02 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:02 INFO - '_': '/tools/buildbot/bin/python'} 00:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:02 INFO - Running setup.py (path:/tmp/pip-xuLQzl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 00:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:02 INFO - Running setup.py (path:/tmp/pip-Va2j9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:02 INFO - Running setup.py (path:/tmp/pip-AezJuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:02 INFO - Running setup.py (path:/tmp/pip-PeSQuk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49: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)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:03 INFO - Running setup.py (path:/tmp/pip-WxX4qK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49: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)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:03 INFO - Running setup.py (path:/tmp/pip-CgCW2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:03 INFO - Running setup.py (path:/tmp/pip-JKClpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:03 INFO - Running setup.py (path:/tmp/pip-Jz6Hby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:03 INFO - Running setup.py (path:/tmp/pip-R3Qzha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:03 INFO - Running setup.py (path:/tmp/pip-BXA04J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:03 INFO - Running setup.py (path:/tmp/pip-UJc53D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:03 INFO - Running setup.py (path:/tmp/pip-GhKFhN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:03 INFO - Running setup.py (path:/tmp/pip-zkQb_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:03 INFO - Running setup.py (path:/tmp/pip-kmtCRf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:03 INFO - Running setup.py (path:/tmp/pip-6QpNQG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:03 INFO - Running setup.py (path:/tmp/pip-4e77eA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:03 INFO - Running setup.py (path:/tmp/pip-fdlzPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 00:49:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:05 INFO - Downloading blessings-1.5.1.tar.gz 00:49:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:49:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:05 INFO - Installing collected packages: blessings 00:49:05 INFO - Running setup.py install for blessings 00:49:05 INFO - Successfully installed blessings 00:49:05 INFO - Cleaning up... 00:49:05 INFO - Return code: 0 00:49:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:06 INFO - Reading from file tmpfile_stdout 00:49:06 INFO - Current package versions: 00:49:06 INFO - argparse == 1.2.1 00:49:06 INFO - blessings == 1.5.1 00:49:06 INFO - blobuploader == 1.2.4 00:49:06 INFO - docopt == 0.6.1 00:49:06 INFO - manifestparser == 1.1 00:49:06 INFO - mozInstall == 1.12 00:49:06 INFO - mozcrash == 0.16 00:49:06 INFO - mozdebug == 0.1 00:49:06 INFO - mozdevice == 0.47 00:49:06 INFO - mozfile == 1.2 00:49:06 INFO - mozhttpd == 0.7 00:49:06 INFO - mozinfo == 0.9 00:49:06 INFO - mozleak == 0.1 00:49:06 INFO - mozlog == 3.1 00:49:06 INFO - moznetwork == 0.27 00:49:06 INFO - mozprocess == 0.22 00:49:06 INFO - mozprofile == 0.27 00:49:06 INFO - mozrunner == 6.11 00:49:06 INFO - mozscreenshot == 0.1 00:49:06 INFO - mozsystemmonitor == 0.0 00:49:06 INFO - moztest == 0.7 00:49:06 INFO - mozversion == 1.4 00:49:06 INFO - psutil == 3.1.1 00:49:06 INFO - requests == 1.2.3 00:49:06 INFO - wsgiref == 0.1.2 00:49:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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 0x7f9ae6ea7c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ff7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, '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': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 00:49: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 00:49: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 00:49:06 INFO - Using env: {'DISPLAY': ':0', 00:49:06 INFO - 'HOME': '/home/cltbld', 00:49:06 INFO - 'LANG': 'en_US.UTF-8', 00:49:06 INFO - 'LANGUAGE': 'en_US:en', 00:49:06 INFO - 'LOGNAME': 'cltbld', 00:49:06 INFO - 'MAIL': '/var/mail/cltbld', 00:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:06 INFO - 'MOZ_NO_REMOTE': '1', 00:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:06 INFO - 'NO_EM_RESTART': '1', 00:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:06 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:06 INFO - 'SHELL': '/bin/bash', 00:49:06 INFO - 'SHLVL': '1', 00:49:06 INFO - 'TERM': 'linux', 00:49:06 INFO - 'TMOUT': '86400', 00:49:06 INFO - 'USER': 'cltbld', 00:49:06 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:06 INFO - '_': '/tools/buildbot/bin/python'} 00:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:49:06 INFO - Cleaning up... 00:49:06 INFO - Return code: 0 00:49:06 INFO - Running post-action listener: _resource_record_post_action 00:49:06 INFO - Running post-action listener: _start_resource_monitoring 00:49:06 INFO - Starting resource monitoring. 00:49:06 INFO - ##### 00:49:06 INFO - ##### Running install step. 00:49:06 INFO - ##### 00:49:06 INFO - Running pre-action listener: _resource_record_pre_action 00:49:06 INFO - Running main action method: install 00:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:06 INFO - Reading from file tmpfile_stdout 00:49:06 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:49:06 INFO - Reading from file tmpfile_stdout 00:49:06 INFO - Output received: 00:49:06 INFO - Usage: mozinstall [options] installer 00:49:06 INFO - Options: 00:49:06 INFO - -h, --help show this help message and exit 00:49:06 INFO - -d DEST, --destination=DEST 00:49:06 INFO - Directory to install application into. [default: 00:49:06 INFO - "/builds/slave/test-pgo"] 00:49:06 INFO - --app=APP Application being installed. [default: firefox] 00:49:06 INFO - mkdir: /builds/slave/test-pgo/build/application 00:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:49:21 INFO - Reading from file tmpfile_stdout 00:49:21 INFO - Output received: 00:49:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:49:21 INFO - Running post-action listener: _resource_record_post_action 00:49:21 INFO - ##### 00:49:21 INFO - ##### Running run-tests step. 00:49:21 INFO - ##### 00:49:21 INFO - Running pre-action listener: _resource_record_pre_action 00:49:21 INFO - Running main action method: run_tests 00:49:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:49:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:49:21 INFO - Python 2.7.3 00:49:21 INFO - Return code: 0 00:49:21 INFO - grabbing minidump binary from tooltool 00:49: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')]} 00:49: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 0x2143d70>, '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 0x2144b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2144fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:49: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 00:49: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 00:49:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:21 INFO - Return code: 0 00:49:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:49:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:49:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:49:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49: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', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:49: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 Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 00:49:21 INFO - Using env: {'DISPLAY': ':0', 00:49:21 INFO - 'HOME': '/home/cltbld', 00:49:21 INFO - 'LANG': 'en_US.UTF-8', 00:49:21 INFO - 'LANGUAGE': 'en_US:en', 00:49:21 INFO - 'LOGNAME': 'cltbld', 00:49:21 INFO - 'MAIL': '/var/mail/cltbld', 00:49:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:21 INFO - 'MOZ_NO_REMOTE': '1', 00:49:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:21 INFO - 'NO_EM_RESTART': '1', 00:49:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:21 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:49:21 INFO - 'SHELL': '/bin/bash', 00:49:21 INFO - 'SHLVL': '1', 00:49:21 INFO - 'TERM': 'linux', 00:49:21 INFO - 'TMOUT': '86400', 00:49:21 INFO - 'USER': 'cltbld', 00:49:21 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1448354825.407677-1831010083', 00:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:21 INFO - '_': '/tools/buildbot/bin/python'} 00:49:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 00:49:21 INFO - mozversion INFO | application_buildid: 20151123233007 00:49:21 INFO - mozversion INFO | application_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 00:49:21 INFO - mozversion INFO | application_display_name: Nightly 00:49:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:21 INFO - mozversion INFO | application_name: Firefox 00:49:21 INFO - mozversion INFO | application_remotingname: firefox 00:49:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:49:21 INFO - mozversion INFO | application_vendor: Mozilla 00:49:21 INFO - mozversion INFO | application_version: 45.0a1 00:49:21 INFO - mozversion INFO | platform_buildid: 20151123233007 00:49:21 INFO - mozversion INFO | platform_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 00:49:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:49:21 INFO - mozversion INFO | platform_version: 45.0a1 00:49:21 INFO - 2015-11-24 00:49:21,418 DEBUG : using testdate: 1448354961 00:49:21 INFO - 2015-11-24 00:49:21,419 DEBUG : actual date: 1448354961 00:49:21 INFO - 2015-11-24 00:49:21,430 INFO : starting webserver on 'localhost:46662' 00:49:21 INFO - 2015-11-24 00:49:21,431 INFO : Starting test suite talos-linux64-ix-025.e 00:49:21 INFO - 2015-11-24 00:49:21,431 INFO : Starting test dromaeo_css 00:49:21 INFO - 2015-11-24 00:49:21,431 DEBUG : operating with platform_type : linux_ 00:49:21 INFO - 2015-11-24 00:49:21,432 INFO : Initialising browser for dromaeo_css test... 00:49:21 INFO - 2015-11-24 00:49:21,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEyKVf0/profile http://localhost:46662/getInfo.html 00:49:27 INFO - 2015-11-24 00:49:27,203 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:49:27 INFO - 2015-11-24 00:49:27,203 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:49:27 INFO - 2015-11-24 00:49:27,203 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:49:27 INFO - 2015-11-24 00:49:27,203 DEBUG : BROWSER_OUTPUT: __metrics 00:49:28 INFO - 2015-11-24 00:49:28,294 INFO : Browser initialized. 00:49:28 INFO - 2015-11-24 00:49:28,295 INFO : Running cycle 1/1 for dromaeo_css test... 00:49:28 INFO - 2015-11-24 00:49:28,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEyKVf0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:49:40 INFO - 2015-11-24 00:49:40,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 00:49:40 INFO - 2015-11-24 00:49:40,118 DEBUG : BROWSER_OUTPUT: 00:50:29 INFO - 2015-11-24 00:50:29,727 DEBUG : BROWSER_OUTPUT: 1448355029725 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:52:38 INFO - 2015-11-24 00:52:38,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46662/tests/dromaeo/cssquery-ext.html) 00:52:39 INFO - 2015-11-24 00:52:39,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 147992576 00:52:39 INFO - 2015-11-24 00:52:39,707 DEBUG : BROWSER_OUTPUT: 00:55:41 INFO - 2015-11-24 00:55:41,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-ext.html (next: http://localhost:46662/tests/dromaeo/cssquery-jquery.html) 00:55:42 INFO - 2015-11-24 00:55:42,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 142684160 00:55:42 INFO - 2015-11-24 00:55:42,200 DEBUG : BROWSER_OUTPUT: 00:58:43 INFO - 2015-11-24 00:58:43,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46662/tests/dromaeo/cssquery-mootools.html) 00:58:44 INFO - 2015-11-24 00:58:44,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 142884864 00:58:44 INFO - 2015-11-24 00:58:44,444 DEBUG : BROWSER_OUTPUT: 01:01:46 INFO - 2015-11-24 01:01:46,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46662/tests/dromaeo/cssquery-prototype.html) 01:01:46 INFO - 2015-11-24 01:01:46,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 01:01:46 INFO - 2015-11-24 01:01:46,698 DEBUG : BROWSER_OUTPUT: 01:04:48 INFO - 2015-11-24 01:04:48,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46662/tests/dromaeo/cssquery-yui.html) 01:04:49 INFO - 2015-11-24 01:04:49,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 142385152 01:04:49 INFO - 2015-11-24 01:04:49,592 DEBUG : BROWSER_OUTPUT: 01:07:51 INFO - 2015-11-24 01:07:51,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-yui.html (next: http://localhost:46662/tests/dromaeo/cssquery-dojo.html) 01:07:52 INFO - 2015-11-24 01:07:52,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 145154048 01:07:52 INFO - 2015-11-24 01:07:52,043 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,043 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:07:52 INFO - 2015-11-24 01:07:52,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:07:52 INFO - 2015-11-24 01:07:52,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:07:52 INFO - 2015-11-24 01:07:52,044 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:07:52 INFO - 2015-11-24 01:07:52,045 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3197.9040628781136;3237.061252236853;3261.347730453907;3284.556584861043;3285.999999999999;5283.8150664726645;5432.70120143392;5465.644733092357;5468.72656367182;5477.5070243678065;5460.262864513289;5464.207689884965;5470;5478.808241711541;5584.86037849053;4918.50814918508;5031.295618613379;5122.052420302238;5141.485851414847;5149.2791009258735;4953.578945789613;5061.54446099851;5086.237064440345;5101.107306221396;5149.433562308143;4921.237208232729;4927.1870141426625;5029.446760856303;5046.293518907356;5059.747012649353;5006.5744411725045;5013.623978201613;5020.548150666457;5034.647574669774;5036.068327359413;4956.529129732669;4990.476000020019;4992.850214493535;4995.55040046394;4996.700197988096;5154.716490593016;5222.843314700565;5288.444713305124;5399.244105825188;5403.486668766461;5913.29040515141;5913.822585322448;5924.555658325643;5939.792107276267;5940.37626049263;5851.824445266649;5945.583809133363;5954.4938680212235;5956.761729530814;5960.821175364746;5557.888842223133;5583.4137415571595;5703.515201207943;5716.514096301861;5760.9711951440395;6009.639421634716;6012.368701286389;6014.8195554133445;6020.187274717945;6030.969845150747;5649.152627105885;5674.4892959633835;5791.884162316815;5800.7099645018425;5814.505767009767;5746.856328591819;5821.126830975303;5839.270091238595;5842.152887831241;5872.559558033165;5916.970415147896;5930.466258036798;5935.73289201987;5980.73086711099;5989.880202396015;5742.397048309867;5865.237519122486;5994.250718660168;6009.909851352233;6011.789587364421;4436.112777444524;4440.378347031418;4441.20058389493;4475.977620111944;4476.552344765498;4020.43713880057;4042.0905296308097;4093.2222877653153;4105.220008198433;4121.423000779893;5474.890502190014;5544.750486228129;5575.4424557544735;5733.140028995684;5743.425657434307;5977.880442391128;6007.699615019232;6021.277446706424;6028.246469191351;6040.063790112539;5673.1490276458035;5684.317881854121;5714.371419143891;5718.399568045295;5730.5129064030025;4933.950660493421;5007.524285192901;5038.949610503848;5125.103106956342;5129.897402051938;6137.285055221596;6254;6258.937410625836;6269.185005949289;6273.686315684197;5968.313643931004;5980;5995.640261584319;6009.759609615567;6032.6983650818165;5893.528517718658;6012.158297838394;6040.6979651018155;6130.601510901777;6204.844878877883;5875.529957603467;5894.351621321737;5939.673317967553;5951.047832346804;5961.52307815365;6047.848803779764;6072.939270607414;6080.543959202989;6081.817545473643;6082;5574.498295153294;5683.687397193194;5767.711614419346;5857.209276747755;5879.647221166743;5815.534757219328;5827.475527202572;5861.296644402529;5873.148393483007;5879.94120058811;5775.509081727932;5792.21805056312;5792.536597072309;5796.188533605215;5804.477597016289;5653;5679.318481782213;5787.971060144672;5856.443637854397;5868.618539794899;5673.801416950387;5723;5725.656460612377;5759.280089988752;5765.077587585966 01:07:52 INFO - 2015-11-24 01:07:52,049 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.4541413172694;543.717267021149;554.7087778916068;580.2109131581052;581.3692144023734;38788.80605596972;39714.404283935764;39758;40041.1991760165;40110.59889401109;41707.37438938418;42263.57736422635;42334.788326058326;42338.57661423385;42375.36436953448;8871.334649901251;8991.190792828644;9020;9048.819023619557;9062.139096785795;8717.866677331938;8796.69211577595;8840.646374145059;8842.690505832297;8847.159519845605;8873.68942087027;8931.821363572724;8962.058983806704;8992.595333209989;8995.055519170492;8841.734747957571;8871.77820554488;8908.643654253821;8911.064338244489;8920.687775927876;8776;8889.244414224799;8892.066333035067;8897.154770296811;8917.464952102895;39377;39758.20483590312;39964.800175999226;40027.79986100051;40038.79980600107;3384.424647809878;3508.947365789515;3510.3681337359267;3598.316319899237;3745.793981331026;29334.70665293341;29827.254318642208;29881.103566893027;29984.55023174654;30076.548851767242;3537.982310088433;3664.926701465982;3713.387291096966;3750.19370835269;3859.517560304962;264116;264641;266129;266180;266375;56619.43380566224;58394.708026460445;58841;59256.407435925954;59296.40703592995;70195.64902175457;70506.64746676234;70615;71266.28733712596;71442;15309;15333.923330383277;15403.229838508254;15452.768208476882;15550.533483995498;11269.380184089954;11421.714457138472;11443.656690299304;11469.426528673534;11485.942570287096;20253.696194557095;20509.38471845847;20598.588028239352;20625.587488250152;20704.58590828175;7430.7399241026305;7447.590382529013;7625.389968802482;7656.578888161204;7774.961125194338;874.9956250218709;938.8873335199684;940.6237504998055;1060;1069.0325255643654;28129.43741125166;28285.71714282872;28843.134705958855;28927.276818079295;28993.42013159725;994.8408254679216;1013.138831992815;1134.3817619397448;1138.2487558211706;1215.8237055627062;13841.792373114411;13926.512572060132;15183.468578599917;15721;15988.680226395407;240801;241168;243294;243451;243782.59195744403;48204;48322.516774832504;48423.273650895266;48676.5132348679;48683.756581217574;1336.8663133686553;1338.1034706746502;1343.6775173958374;1352.3238380809792;1357.0907491980397;28278;28862.278443039093;29101;29352;29509.557356639238;46323;46430.76784616191;46637.766811165726;47048.76475617737;47125;274394;277210;279035;280466;280578;30964.535531966587;31943.840280798446;32172.678273217905;32304.83847580747;32333.676663233065;42132;42379;43668.344974824766;43813;44247.336289955034;36486.45270321;36526.817365913;36729.81635091914;36968.44547331846;37288.813555933135;35428.64571354254;37100;37238.62761372352;37342.43986340153;37715.245695086494;32722.50916236306;33909.66090339065;34078.148046299044;34135.487967680005;34191.82904085464;28476.418386678797;30746.692533074383;32708.182295442803;33334.83328083505;33533.32933341271;25304.240872773848;25514.362140946625;25696.9624622607;25714.35714107162;25816.096436624626 01:07:52 INFO - 2015-11-24 01:07:52,050 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.7485860463258;352.90118766745303;356.0582259922505;356.8162396365871;361.4884937812995;16380.344786208552;17245.82754172458;17640.911795441036;18238.544036399097;18374.35689750859;10780.676579702622;11635.534578616845;15742.212889355544;15829.208539573034;15942.123183224918;4597.494275629678;4770.689905156154;4779.354787103749;4797.0645724083815;4816.542428469307;4772.141014617368;4794.065157294329;4797.832075877345;4800.231962885939;4806.0628177505405;3743.794091324976;3846.9038274043232;4813.302071199691;4875.07373599015;5132.769025393866;5170.870728231786;5182.7408629568745;5224.477552244764;5225.869353266161;5256.448072952342;5059.873503162414;5087.771050302746;5106.617003724736;5305.840824775263;5354.223637572531;19673.9016304919;19860.20559177631;20017.1993120275;20549.4862628434;20788.376348709564;2013.315472739261;2075.1491888325713;2076.1487790006026;2091.874487530753;2182.7380714314227;8609.5695215239;8638.093000234947;8703.891168946457;8866.069062748447;9383.06169383063;1717.5362652083868;1795.721663142202;1805.4493379519242;1818.8908665480114;1879.3891985104895;60254;62332;64224;64479.03281450782;64643.353566464204;10219.722534683164;10346.482675866177;10366.274360794672;10388;10390.740231494274;13433.932830335785;13495.460181592824;13555.525556605471;13565.796513052312;13575.728485430236;7207.9639601801655;7242.565446073252;7290.307420795016;7325.377342925911;7358.374538164209;6830.521863469509;6836.760713375008;6847.828804279833;6871.209810871814;6884.105066341343;4460.063386688832;4462.888427789267;4508.526604706524;4540.750258735801;4545.181867263858;1890.2155605423595;1895.4408449507152;1906.27561526619;1913.6268427656473;1918.587503686714;415.47649961049297;416.68748438670997;875.4090988582681;947.9763005924907;952.1478276942098;10600.575976960836;10878.728031799268;11024.228304018801;11080;11089.27919685218;428.70847823480335;428.9699721019561;434.18373457898946;435.7821089455272;445.37869671808295;5804.303483581997;6005.879882402328;6028.788992385245;6040.969795151084;6042.909356359658;476684;500539;509014;512571;525556;79675;81598;81801.59099204585;82144.58927705443;82592.58703706563;1152.6023521884936;1161.1813671361501;1165.906727461801;1171.800793865045;1174.9236299640495;15316.081035137928;15478.226088695295;15601.29794159243;15750;15866.761998570262;34085.147871303416;34680.479792802624;35558.46662300119;35647.82176089103;35898.28203435969;46967.06065878595;48192.5180748188;48446.27330589973;50161.74919125381;51258.48741512537;9007.459552426875;9178.632854685738;9263.490508022123;9307.72076837696;9334.2999275056;10725.731856703645;13605.795913061114;17015.91492042532;17179.65640687154;17268.136593170544;14111.082779619292;14503.709925801213;14595.489157879423;14655.413783448543;14681.70636587241;13882.722345553235;14168.645783855485;14315.498957536436;14371.712565748836;14430.711385772436;15013.474528391454;15063.397464101752;15203.923980380026;15252.694946100793;15579.532614021597;9083.45499270046;9250.121238482334;9272.72181834546;9761;10079.395236285847;14976.876734244757;15000.324985375466;15061.924690376478;15096;15246.847531524987 01:07:52 INFO - 2015-11-24 01:07:52,051 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1430.6995530938505;1487.7396455620267;1582.707199168154;1590.9522714318575;1714.8370904764042;6319.399657032586;6349.619022858632;7292.270772922705;7511.62441877906;7553.622318884061;7006.404455621278;7197.316254955784;7248.601326927017;7253.564786112837;7255.056842610466;2141.9892900535474;2180.1388451561625;2185.4208634711736;2186.0272178880405;2193.7367515898036;2240.9215677451293;2274.090363854455;2279.225063478417;2289.7710228977053;2293.942651433711;2171.706819579352;2171.9782802171935;2180.160638154306;2198.967015494769;2250.459889626486;2181.5091604389045;2208.7459942106702;2227.8774667393286;2231.4309850987975;2237.69791078204;2138.860974036683;2155.3641675705703;2166.6316726156433;2168.251953076186;2173.7608863025052;7317.707291708325;7375.778726638209;7392.55644661322;7396.926030739677;7407.407407407394;4551.749653769041;4631.4442266927845;4634.420697412824;4658.277966915133;4659.324397962277;3001.6998300170026;3005.8046226995175;3011.021418039146;3012.171652795477;3023;947.2232769129316;947.3652652722692;964.5466630683637;976.0629795396356;1015.0559979219323;9792.510374481248;9798.510074496318;9809.656662016796;9811.067948544876;9846.359986600848;4025.657819085352;4061.817218225187;4065.5121385433936;4077.041895154636;4154.667626589866;8568.400211985101;8588.656453741905;8674.6096425661;8699.521526315986;8720.12798720123;4519.954800451954;4583.564561366665;4591.816327346935;4591.862244132682;4608.9308660370125;4055.391691246278;4114.506259248909;4126.979365103155;4148.543660197376;4173.624373806372;3413;3431.8627254909525;3434.6737059979264;3450.2064525158853;3453.810040447749;1048.1352883870836;1065.4246706778408;1069.9037086662238;1071.8660167479065;1081.6322450366913;976.2482888176206;982.0523195116747;986.413084214891;1110.7056629993058;1351.047511504387;7014.964925175342;7047.083879095685;7058.858822823515;7064.470164737665;7071.186813516409;477.2840738891662;478.5358202543527;479.4510285722898;481.0835358641793;482.8937633720576;5302.68183908959;5370.597205209625;5371.274877891513;5387.892242155213;5422.240886275925;8624.78438039054;8668.739937801876;8823.073577274294;8944.239739622206;8946.373753837299;8691.826163476695;8706.825863482694;8718.956405217934;8763.956180219186;8797.164269394398;6675.732970681119;6713.865722685519;6758.121444212221;6782.287859774751;6805.047293378931;6580.5064620152725;6615.305392933865;6630.7679231226675;6662.400383965466;6667.966660166668;7629;7791.415643826849;7842.29419352261;7930.762077137464;7985.920140798517;7773.18381569927;7987.161348058603;8008.319292859939;8075.434719569574;8140.511569305861;5569.582281328835;5686.886262274814;6162.044883043135;6234.563580549318;6395.392437718409;5901.527877769854;6459.063435801876;6591.769288074895;6626.734930602915;6665.133532640726;6439.8068057958335;6513.837154071186;6617.172853393326;6752.763653272112;6772.729090836311;6341.968290158704;6477.611343319416;6484.221893372825;6521.054447105238;6523.67381630907;6368.617882927039;6416.037594360883;6449.419552240321;6456.063870738811;6501.8699626008165;6058.636481811105;6115.388461153849;6182.041783523561;6187.659678717534;6195.96902015487;6057.878842423215;6141.447269745566;6195.721192546256;6202.379762023942;6213.2233470816145 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.6385938100873;316.7560978046904;318.8708573027924;319.54305343359005;327.15756925915764;6292.898742720023;6343.492520598353;6413.615183089012;6448.000559913221;6525.543211975164;6270.184875966118;6335.239771227448;6344.984802431612;6345.968270158654;6367.917454032814;4533.455985281755;4636.281376386665;4641.767911604423;4710.764461776906;4725.976370118162;4653.348531205634;4663.137319595869;4665.300204969248;4667.113248482778;4695.060987802453;4605.4933957264675;4614.400127983357;4617.699849509788;4619.976900115495;4623.42207224097;4584.381108550353;4629.77311012582;4635.443746750411;4644.698094623838;4650.837220697276;3839.155385815116;3918.666913312372;3930.5479869815053;3956.1692044670654;3957.8416863325433;5905.4685078343155;5916.171735956969;5952.4642782149385;5962.07587823888;6007.309159446676;5396.622236443451;5409.972950135263;5414.29614150158;5414.539764120054;5434.429384914567;6641.7675381361905;6643.767468138641;6644.202695676501;6662.10061641677;6667.899981500282;4332.631726303268;4418.028033832552;4439.64482841372;4454.866354009352;4454.9777251113865;6879.828004299882;6962.477814163907;6972.407345375649;6987.580745155357;7016.017757513952;4438.334249862546;4443.6667249955735;4443.933340999887;4454.10917816438;4470.508244093147;4455.287154055336;4504.031633198878;4509.391232183679;4516.728996260234;4519.706219095749;5383.084875571162;5400.405955344909;5438.45615438453;5447.428020057916;5457.290552228185;6779.017042528806;6782.593044417351;6784.457243420613;6794.796156115324;6802.4217941474535;1620.198001989023;1635.3295148988857;1635.3703824027598;1636.7544868269617;1636.8035835699793;1079.8596182496226;1083.3066837224183;1088.7114914547492;1100.5487750022453;1113.1651261553834;6489.448396886223;6495.837604059841;6501.0573466847045;6502.447291980235;6508.349165083454;6929.514933954575;6939.6877140528795;6947.51367404287;6963;6967.198772141167;6367.968160159169;6426.74293028283;6482.643454610042;6483.2122187459845;6483.7082331295205;3781.3382658034734;3811.066288759216;3811.123441608446;3813.389857622767;3816.103215744298;7197.4961752677855;7334.559926404433;7341.963290183515;7344.339009489065;7344.742933997284;7245.275472452712;7254.238304978006;7261.963690181516;7263.455240856957;7275.563466192046;7165.713371465187;7316.56100633953;7317.0487836580905;7319.560826350436;7338.376238019828;6963.1644202696;7028.753993610199;7041.647917604202;7043.859122817617;7045.084139061889;6847.965760171167;6913.688884000131;6930.099087118844;6960.443164546926;6968.95465680152;7147.678354474165;7295.489315747846;7303.671334790053;7304.379127774198;7308.671109799965;4529.84145554904;4631.073785242897;4643.489216186149;4646.907061858811;4652.209124448784;6929.237783843672;6973.19808222061;6998.090248267693;7007.194172670208;7022.367986881205;6595.967020164869;6781.6270105144695;6788.592684438752;6803.591784492946;6814.2163651180745;6718.93281067183;6789.388954994074;6799.6600169990315;6805.353491418307;6807.251202367835;6682.46540276767;6684.899726504009;6689.26418094019;6690.899636505554;6692.464602831859;6699.363560461748;6784.2876497967;6861.142357205349;6862.588244705334;6863.519553631198;6598.439132673777;6607.57050791697;6662.200535935719;6663.433608143362;6676.766313179015 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: |5;yui.html;764.2319468933722;803.3854101612268;847.686356048262;851.3529717414763;862.5730263519558;13679.042467027311;13855.030147889653;13866;13941.233232172226;13942.721145577096;12940.935295323534;12989.80515292269;13008.869911300884;13033.34833258338;13083.869161308408;827.5241736001808;840.231188462556;857.8027053777635;857.9742607721747;858.2961971183632;830.0330115415563;849.8767678686587;856.6016802186982;856.6359297298624;856.9657213711444;857.438377862501;873.9694110706095;875.6278581602793;880.5905254056862;881.973540793774;850.26452118917;863.5639002303797;871.7689812199741;872.9432586881865;873.7116751472063;647.7927063339733;648.2124219073847;650.6161364794747;651.5374084400081;652.1228947066236;13306.933465332708;13378.331083445788;13471.797923031163;13484.865151348458;13504.864951350557;12127.272363658209;12149.331786751725;12226.75546489074;12634.178778379468;13280.136791108547;10426.635067772591;10474.633387831465;10513.474326283731;10673.412962287071;10770.138388928866;3548.308079924416;3552.3960926642535;3657.213699054716;3736.327461057009;3751.568569614502;48796.268055978835;49123.263151052764;49219;49380.259296110584;49475.75262123702;10328.948355258326;10357;10411.635592754217;10477.423741694127;10531.89468105309;16141.757873631905;16161.838381616268;16191.109488977983;16191.352345906032;16219.18904054816;7680.884786728204;7763.417743669247;7794.766157015299;7940.444168908121;7954.721584744506;4364.803583838735;4375.256206444912;4467.173572889026;4493.1013797240685;4520.367148599199;3101.519264514004;3131.232847952266;3138.1213260287154;3143.984280078585;3164.5095010273444;532.5366930770177;540.4757385336218;546.0144439287045;547.15464607182;558.8938101760652;632.5256057956533;667.6594936582378;669.681901096975;679.7281087565013;700.1842853076109;7633.503822251536;7778.144404115543;7855.921440785519;7957.7612671619945;7961.24600448685;542.2083757713782;545.5417449342572;645.7772068636312;654.5745265577318;677.8034370032734;3660.396034654252;3689.5572531296416;3693.7045036397026;3738.476613274144;3774.471573979645;56635.716821415626;57375.71312143413;57524.71237643785;57870.710646446496;58150.709246454346;50249.24127655588;50713.49286507162;50919.490805091475;50994.74502627463;51550.48449515457;46375.30437043447;46626.76686616545;46654.533454665696;46702;46974.76512617483;7598.392128629585;7700.383969282556;7715.92284077152;7764.844703105793;7895.368370530458;33903;34084.488732669524;34244;34379.65620343765;35081.82459087688;40498.797506012284;40730;43215.13569728651;44592.33111503265;44824.55175448204;10224.846627300745;10425.218108642033;10486.265961382935;10486.895131048592;10638.521266543179;11551.711207219887;11559.595414160463;11697.06423486136;11710.297382157098;11762.896367632738;10749.838752418877;10854.45727713627;10925.617603383844;10951.890481095086;11017.228793984345;10400.323978941344;10459;10463.843042354523;10522.526486308288;10793.784124317313;10234.283600147919;10485.475726213506;10497.737556560842;10601.946990265;10921.617743378943;9298.814023719353;9393.201577865959;9443.811123777623;9885.802283954137;10262.025107614765;8719.128087191484;9009.549522523717;9163.450192988443;9417.576209070472;9844.655437059955 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 01:07:52 INFO - 2015-11-24 01:07:52,055 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356072042__endTimestamp 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,056 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5505.96 Median:5742.40 stddev:634.24 (11.0%) stddev-sans-first:609.79 01:07:52 INFO - 2015-11-24 01:07:52,057 DEBUG : BROWSER_OUTPUT: Values: 3197.9 3237.1 3261.3 3284.6 3286.0 5283.8 5432.7 5465.6 5468.7 5477.5 5460.3 5464.2 5470.0 5478.8 5584.9 4918.5 5031.3 5122.1 5141.5 5149.3 4953.6 5061.5 5086.2 5101.1 5149.4 4921.2 4927.2 5029.4 5046.3 5059.7 5006.6 5013.6 5020.5 5034.6 5036.1 4956.5 4990.5 4992.9 4995.6 4996.7 5154.7 5222.8 5288.4 5399.2 5403.5 5913.3 5913.8 5924.6 5939.8 5940.4 5851.8 5945.6 5954.5 5956.8 5960.8 5557.9 5583.4 5703.5 5716.5 5761.0 6009.6 6012.4 6014.8 6020.2 6031.0 5649.2 5674.5 5791.9 5800.7 5814.5 5746.9 5821.1 5839.3 5842.2 5872.6 5917.0 5930.5 5935.7 5980.7 5989.9 5742.4 5865.2 5994.3 6009.9 6011.8 4436.1 4440.4 4441.2 4476.0 4476.6 4020.4 4042.1 4093.2 4105.2 4121.4 5474.9 5544.8 5575.4 5733.1 5743.4 5977.9 6007.7 6021.3 6028.2 6040.1 5673.1 5684.3 5714.4 5718.4 5730.5 4934.0 5007.5 5038.9 5125.1 5129.9 6137.3 6254.0 6258.9 6269.2 6273.7 5968.3 5980.0 5995.6 6009.8 6032.7 5893.5 6012.2 6040.7 6130.6 6204.8 5875.5 5894.4 5939.7 5951.0 5961.5 6047.8 6072.9 6080.5 6081.8 6082.0 5574.5 5683.7 5767.7 5857.2 5879.6 5815.5 5827.5 5861.3 5873.1 5879.9 5775.5 5792.2 5792.5 5796.2 5804.5 5653.0 5679.3 5788.0 5856.4 5868.6 5673.8 5723.0 5725.7 5759.3 5765.1 01:07:52 INFO - 2015-11-24 01:07:52,057 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,057 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44048.96 Median:36849.13 stddev:68360.87 (185.5%) stddev-sans-first:68474.58 01:07:52 INFO - 2015-11-24 01:07:52,058 DEBUG : BROWSER_OUTPUT: Values: 540.5 543.7 554.7 580.2 581.4 38788.8 39714.4 39758.0 40041.2 40110.6 41707.4 42263.6 42334.8 42338.6 42375.4 8871.3 8991.2 9020.0 9048.8 9062.1 8717.9 8796.7 8840.6 8842.7 8847.2 8873.7 8931.8 8962.1 8992.6 8995.1 8841.7 8871.8 8908.6 8911.1 8920.7 8776.0 8889.2 8892.1 8897.2 8917.5 39377.0 39758.2 39964.8 40027.8 40038.8 3384.4 3508.9 3510.4 3598.3 3745.8 29334.7 29827.3 29881.1 29984.6 30076.5 3538.0 3664.9 3713.4 3750.2 3859.5 264116.0 264641.0 266129.0 266180.0 266375.0 56619.4 58394.7 58841.0 59256.4 59296.4 70195.6 70506.6 70615.0 71266.3 71442.0 15309.0 15333.9 15403.2 15452.8 15550.5 11269.4 11421.7 11443.7 11469.4 11485.9 20253.7 20509.4 20598.6 20625.6 20704.6 7430.7 7447.6 7625.4 7656.6 7775.0 875.0 938.9 940.6 1060.0 1069.0 28129.4 28285.7 28843.1 28927.3 28993.4 994.8 1013.1 1134.4 1138.2 1215.8 13841.8 13926.5 15183.5 15721.0 15988.7 240801.0 241168.0 243294.0 243451.0 243782.6 48204.0 48322.5 48423.3 48676.5 48683.8 1336.9 1338.1 1343.7 1352.3 1357.1 28278.0 28862.3 29101.0 29352.0 29509.6 46323.0 46430.8 46637.8 47048.8 47125.0 274394.0 277210.0 279035.0 280466.0 280578.0 30964.5 31943.8 32172.7 32304.8 32333.7 42132.0 42379.0 43668.3 43813.0 44247.3 36486.5 36526.8 36729.8 36968.4 37288.8 35428.6 37100.0 37238.6 37342.4 37715.2 32722.5 33909.7 34078.1 34135.5 34191.8 28476.4 30746.7 32708.2 33334.8 33533.3 25304.2 25514.4 25697.0 25714.4 25816.1 01:07:52 INFO - 2015-11-24 01:07:52,058 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,059 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27644.89 Median:2052.64 stddev:82752.96 (4031.5%) stddev-sans-first:82959.70 01:07:52 INFO - 2015-11-24 01:07:52,060 DEBUG : BROWSER_OUTPUT: Values: 339.7 352.9 356.1 356.8 361.5 16380.3 17245.8 17640.9 18238.5 18374.4 10780.7 11635.5 15742.2 15829.2 15942.1 4597.5 4770.7 4779.4 4797.1 4816.5 4772.1 4794.1 4797.8 4800.2 4806.1 3743.8 3846.9 4813.3 4875.1 5132.8 5170.9 5182.7 5224.5 5225.9 5256.4 5059.9 5087.8 5106.6 5305.8 5354.2 19673.9 19860.2 20017.2 20549.5 20788.4 2013.3 2075.1 2076.1 2091.9 2182.7 8609.6 8638.1 8703.9 8866.1 9383.1 1717.5 1795.7 1805.4 1818.9 1879.4 60254.0 62332.0 64224.0 64479.0 64643.4 10219.7 10346.5 10366.3 10388.0 10390.7 13433.9 13495.5 13555.5 13565.8 13575.7 7208.0 7242.6 7290.3 7325.4 7358.4 6830.5 6836.8 6847.8 6871.2 6884.1 4460.1 4462.9 4508.5 4540.8 4545.2 1890.2 1895.4 1906.3 1913.6 1918.6 415.5 416.7 875.4 948.0 952.1 10600.6 10878.7 11024.2 11080.0 11089.3 428.7 429.0 434.2 435.8 445.4 5804.3 6005.9 6028.8 6041.0 6042.9 476684.0 500539.0 509014.0 512571.0 525556.0 79675.0 81598.0 81801.6 82144.6 82592.6 1152.6 1161.2 1165.9 1171.8 1174.9 15316.1 15478.2 15601.3 15750.0 15866.8 34085.1 34680.5 35558.5 35647.8 35898.3 46967.1 48192.5 48446.3 50161.7 51258.5 9007.5 9178.6 9263.5 9307.7 9334.3 10725.7 13605.8 17015.9 17179.7 17268.1 14111.1 14503.7 14595.5 14655.4 14681.7 13882.7 14168.6 14315.5 14371.7 14430.7 15013.5 15063.4 15203.9 15252.7 15579.5 9083.5 9250.1 9272.7 9761.0 10079.4 14976.9 15000.3 15061.9 15096.0 15246.8 01:07:52 INFO - 2015-11-24 01:07:52,060 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,060 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5098.45 Median:6207.80 stddev:2621.81 (42.2%) stddev-sans-first:2614.67 01:07:52 INFO - 2015-11-24 01:07:52,060 DEBUG : BROWSER_OUTPUT: Values: 1430.7 1487.7 1582.7 1591.0 1714.8 6319.4 6349.6 7292.3 7511.6 7553.6 7006.4 7197.3 7248.6 7253.6 7255.1 2142.0 2180.1 2185.4 2186.0 2193.7 2240.9 2274.1 2279.2 2289.8 2293.9 2171.7 2172.0 2180.2 2199.0 2250.5 2181.5 2208.7 2227.9 2231.4 2237.7 2138.9 2155.4 2166.6 2168.3 2173.8 7317.7 7375.8 7392.6 7396.9 7407.4 4551.7 4631.4 4634.4 4658.3 4659.3 3001.7 3005.8 3011.0 3012.2 3023.0 947.2 947.4 964.5 976.1 1015.1 9792.5 9798.5 9809.7 9811.1 9846.4 4025.7 4061.8 4065.5 4077.0 4154.7 8568.4 8588.7 8674.6 8699.5 8720.1 4520.0 4583.6 4591.8 4591.9 4608.9 4055.4 4114.5 4127.0 4148.5 4173.6 3413.0 3431.9 3434.7 3450.2 3453.8 1048.1 1065.4 1069.9 1071.9 1081.6 976.2 982.1 986.4 1110.7 1351.0 7015.0 7047.1 7058.9 7064.5 7071.2 477.3 478.5 479.5 481.1 482.9 5302.7 5370.6 5371.3 5387.9 5422.2 8624.8 8668.7 8823.1 8944.2 8946.4 8691.8 8706.8 8719.0 8764.0 8797.2 6675.7 6713.9 6758.1 6782.3 6805.0 6580.5 6615.3 6630.8 6662.4 6668.0 7629.0 7791.4 7842.3 7930.8 7985.9 7773.2 7987.2 8008.3 8075.4 8140.5 5569.6 5686.9 6162.0 6234.6 6395.4 5901.5 6459.1 6591.8 6626.7 6665.1 6439.8 6513.8 6617.2 6752.8 6772.7 6342.0 6477.6 6484.2 6521.1 6523.7 6368.6 6416.0 6449.4 6456.1 6501.9 6058.6 6115.4 6182.0 6187.7 6196.0 6057.9 6141.4 6195.7 6202.4 6213.2 01:07:52 INFO - 2015-11-24 01:07:52,060 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,061 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5580.87 Median:6465.32 stddev:1762.49 (27.3%) stddev-sans-first:1722.55 01:07:52 INFO - 2015-11-24 01:07:52,061 DEBUG : BROWSER_OUTPUT: Values: 315.6 316.8 318.9 319.5 327.2 6292.9 6343.5 6413.6 6448.0 6525.5 6270.2 6335.2 6345.0 6346.0 6367.9 4533.5 4636.3 4641.8 4710.8 4726.0 4653.3 4663.1 4665.3 4667.1 4695.1 4605.5 4614.4 4617.7 4620.0 4623.4 4584.4 4629.8 4635.4 4644.7 4650.8 3839.2 3918.7 3930.5 3956.2 3957.8 5905.5 5916.2 5952.5 5962.1 6007.3 5396.6 5410.0 5414.3 5414.5 5434.4 6641.8 6643.8 6644.2 6662.1 6667.9 4332.6 4418.0 4439.6 4454.9 4455.0 6879.8 6962.5 6972.4 6987.6 7016.0 4438.3 4443.7 4443.9 4454.1 4470.5 4455.3 4504.0 4509.4 4516.7 4519.7 5383.1 5400.4 5438.5 5447.4 5457.3 6779.0 6782.6 6784.5 6794.8 6802.4 1620.2 1635.3 1635.4 1636.8 1636.8 1079.9 1083.3 1088.7 1100.5 1113.2 6489.4 6495.8 6501.1 6502.4 6508.3 6929.5 6939.7 6947.5 6963.0 6967.2 6368.0 6426.7 6482.6 6483.2 6483.7 3781.3 3811.1 3811.1 3813.4 3816.1 7197.5 7334.6 7342.0 7344.3 7344.7 7245.3 7254.2 7262.0 7263.5 7275.6 7165.7 7316.6 7317.0 7319.6 7338.4 6963.2 7028.8 7041.6 7043.9 7045.1 6848.0 6913.7 6930.1 6960.4 6969.0 7147.7 7295.5 7303.7 7304.4 7308.7 4529.8 4631.1 4643.5 4646.9 4652.2 6929.2 6973.2 6998.1 7007.2 7022.4 6596.0 6781.6 6788.6 6803.6 6814.2 6718.9 6789.4 6799.7 6805.4 6807.3 6682.5 6684.9 6689.3 6690.9 6692.5 6699.4 6784.3 6861.1 6862.6 6863.5 6598.4 6607.6 6662.2 6663.4 6676.8 01:07:52 INFO - 2015-11-24 01:07:52,061 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,061 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13593.98 Median:25447.84 stddev:15894.62 (62.5%) stddev-sans-first:15910.01 01:07:52 INFO - 2015-11-24 01:07:52,062 DEBUG : BROWSER_OUTPUT: Values: 764.2 803.4 847.7 851.4 862.6 13679.0 13855.0 13866.0 13941.2 13942.7 12940.9 12989.8 13008.9 13033.3 13083.9 827.5 840.2 857.8 858.0 858.3 830.0 849.9 856.6 856.6 857.0 857.4 874.0 875.6 880.6 882.0 850.3 863.6 871.8 872.9 873.7 647.8 648.2 650.6 651.5 652.1 13306.9 13378.3 13471.8 13484.9 13504.9 12127.3 12149.3 12226.8 12634.2 13280.1 10426.6 10474.6 10513.5 10673.4 10770.1 3548.3 3552.4 3657.2 3736.3 3751.6 48796.3 49123.3 49219.0 49380.3 49475.8 10328.9 10357.0 10411.6 10477.4 10531.9 16141.8 16161.8 16191.1 16191.4 16219.2 7680.9 7763.4 7794.8 7940.4 7954.7 4364.8 4375.3 4467.2 4493.1 4520.4 3101.5 3131.2 3138.1 3144.0 3164.5 532.5 540.5 546.0 547.2 558.9 632.5 667.7 669.7 679.7 700.2 7633.5 7778.1 7855.9 7957.8 7961.2 542.2 545.5 645.8 654.6 677.8 3660.4 3689.6 3693.7 3738.5 3774.5 56635.7 57375.7 57524.7 57870.7 58150.7 50249.2 50713.5 50919.5 50994.7 51550.5 46375.3 46626.8 46654.5 46702.0 46974.8 7598.4 7700.4 7715.9 7764.8 7895.4 33903.0 34084.5 34244.0 34379.7 35081.8 40498.8 40730.0 43215.1 44592.3 44824.6 10224.8 10425.2 10486.3 10486.9 10638.5 11551.7 11559.6 11697.1 11710.3 11762.9 10749.8 10854.5 10925.6 10951.9 11017.2 10400.3 10459.0 10463.8 10522.5 10793.8 10234.3 10485.5 10497.7 10601.9 10921.6 9298.8 9393.2 9443.8 9885.8 10262.0 8719.1 9009.5 9163.5 9417.6 9844.7 01:07:52 INFO - 2015-11-24 01:07:52,062 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:07:52 INFO - 2015-11-24 01:07:52,062 DEBUG : BROWSER_OUTPUT: 01:07:52 INFO - 2015-11-24 01:07:52,798 INFO : Browser exited with error code: 0 01:07:52 INFO - 2015-11-24 01:07:52,817 INFO : Completed test dromaeo_css (00:18:31) 01:07:52 INFO - 2015-11-24 01:07:52,817 INFO : Starting test kraken 01:07:52 INFO - 2015-11-24 01:07:52,817 DEBUG : operating with platform_type : linux_ 01:07:52 INFO - 2015-11-24 01:07:52,817 INFO : Initialising browser for kraken test... 01:07:52 INFO - 2015-11-24 01:07:52,823 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJzmTL/profile http://localhost:46662/getInfo.html 01:07:57 INFO - 2015-11-24 01:07:57,294 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:07:57 INFO - 2015-11-24 01:07:57,294 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:07:57 INFO - 2015-11-24 01:07:57,295 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:07:57 INFO - 2015-11-24 01:07:57,295 DEBUG : BROWSER_OUTPUT: __metrics 01:07:58 INFO - 2015-11-24 01:07:58,330 INFO : Browser initialized. 01:07:58 INFO - 2015-11-24 01:07:58,331 INFO : Running cycle 1/1 for kraken test... 01:07:58 INFO - 2015-11-24 01:07:58,331 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJzmTL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:08:10 INFO - 2015-11-24 01:08:10,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 140562432 01:08:10 INFO - 2015-11-24 01:08:10,109 DEBUG : BROWSER_OUTPUT: 01:08:12 INFO - 2015-11-24 01:08:12,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:13 INFO - 2015-11-24 01:08:13,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 01:08:13 INFO - 2015-11-24 01:08:13,222 DEBUG : BROWSER_OUTPUT: 01:08:15 INFO - 2015-11-24 01:08:15,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-dft) 01:08:16 INFO - 2015-11-24 01:08:16,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 141942784 01:08:16 INFO - 2015-11-24 01:08:16,466 DEBUG : BROWSER_OUTPUT: 01:08:19 INFO - 2015-11-24 01:08:19,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-fft) 01:08:19 INFO - 2015-11-24 01:08:19,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 137789440 01:08:19 INFO - 2015-11-24 01:08:19,895 DEBUG : BROWSER_OUTPUT: 01:08:21 INFO - 2015-11-24 01:08:21,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-oscillator) 01:08:22 INFO - 2015-11-24 01:08:22,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 137179136 01:08:22 INFO - 2015-11-24 01:08:22,494 DEBUG : BROWSER_OUTPUT: 01:08:24 INFO - 2015-11-24 01:08:24,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:25 INFO - 2015-11-24 01:08:25,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 139460608 01:08:25 INFO - 2015-11-24 01:08:25,254 DEBUG : BROWSER_OUTPUT: 01:08:28 INFO - 2015-11-24 01:08:28,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:28 INFO - 2015-11-24 01:08:28,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 139857920 01:08:28 INFO - 2015-11-24 01:08:28,839 DEBUG : BROWSER_OUTPUT: 01:08:32 INFO - 2015-11-24 01:08:32,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:32 INFO - 2015-11-24 01:08:32,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 01:08:32 INFO - 2015-11-24 01:08:32,816 DEBUG : BROWSER_OUTPUT: 01:08:35 INFO - 2015-11-24 01:08:35,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46662/tests/kraken/driver.html?testName=json-parse-financial) 01:08:36 INFO - 2015-11-24 01:08:36,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 140365824 01:08:36 INFO - 2015-11-24 01:08:36,220 DEBUG : BROWSER_OUTPUT: 01:08:37 INFO - 2015-11-24 01:08:37,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:38 INFO - 2015-11-24 01:08:38,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 138960896 01:08:38 INFO - 2015-11-24 01:08:38,398 DEBUG : BROWSER_OUTPUT: 01:08:40 INFO - 2015-11-24 01:08:40,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:40 INFO - 2015-11-24 01:08:40,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 138989568 01:08:40 INFO - 2015-11-24 01:08:40,840 DEBUG : BROWSER_OUTPUT: 01:08:42 INFO - 2015-11-24 01:08:42,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:43 INFO - 2015-11-24 01:08:43,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 140746752 01:08:43 INFO - 2015-11-24 01:08:43,499 DEBUG : BROWSER_OUTPUT: 01:08:45 INFO - 2015-11-24 01:08:45,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:46 INFO - 2015-11-24 01:08:46,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 139460608 01:08:46 INFO - 2015-11-24 01:08:46,576 DEBUG : BROWSER_OUTPUT: 01:08:49 INFO - 2015-11-24 01:08:49,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:49 INFO - 2015-11-24 01:08:49,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 140361728 01:08:49 INFO - 2015-11-24 01:08:49,764 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46662/tests/kraken/driver.html?testName=ai-astar) 01:08:51 INFO - 2015-11-24 01:08:51,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 140812288 01:08:51 INFO - 2015-11-24 01:08:51,671 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;111;111;111;126;113;110;111;110 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;126;153;182;129;152;150;128;170;126 01:08:51 INFO - 2015-11-24 01:08:51,673 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;163;162;162;163;167;166;164 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;71;72;72;73;144;71;72;72 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;136;94;94;95;137;93;94;134 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;111;110 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;146;147;146;146;146;147;146 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;98;96;96;96;96 01:08:51 INFO - 2015-11-24 01:08:51,674 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;64;62;62;64;64;61;62;63;62 01:08:51 INFO - 2015-11-24 01:08:51,675 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;71;69;69;69;69;68;69;69;69 01:08:51 INFO - 2015-11-24 01:08:51,675 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;86;85;86;93;85;94;86 01:08:51 INFO - 2015-11-24 01:08:51,675 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;121;118;127;122;122;122;126;119;125 01:08:51 INFO - 2015-11-24 01:08:51,675 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;167;151;152;148;153;150;154;157 01:08:51 INFO - 2015-11-24 01:08:51,676 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;65;67;70;68;71;65;64;66 01:08:51 INFO - 2015-11-24 01:08:51,676 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:08:51 INFO - 2015-11-24 01:08:51,676 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:08:51 INFO - 2015-11-24 01:08:51,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 01:08:51 INFO - 2015-11-24 01:08:51,676 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:08:51 INFO - 2015-11-24 01:08:51,677 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356131671__endTimestamp 01:08:51 INFO - 2015-11-24 01:08:51,677 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,680 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:08:51 INFO - 2015-11-24 01:08:51,681 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:08:51 INFO - 2015-11-24 01:08:51,681 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,681 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:111.00 stddev:4.99 (4.5%) stddev-sans-first:5.29 01:08:51 INFO - 2015-11-24 01:08:51,681 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 111.0 111.0 111.0 126.0 113.0 110.0 111.0 110.0 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.60 Median:151.00 stddev:19.43 (12.9%) stddev-sans-first:20.57 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: Values: 150.0 126.0 153.0 182.0 129.0 152.0 150.0 128.0 170.0 126.0 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 01:08:51 INFO - 2015-11-24 01:08:51,682 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 163.0 162.0 162.0 163.0 167.0 166.0 164.0 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:22.82 (31.7%) stddev-sans-first:24.01 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 72.0 72.0 73.0 144.0 71.0 72.0 72.0 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:94.00 stddev:20.29 (21.6%) stddev-sans-first:20.85 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 136.0 94.0 94.0 95.0 137.0 93.0 94.0 134.0 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,683 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 110.0 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 98.0 96.0 96.0 96.0 96.0 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.50 stddev:1.29 (2.0%) stddev-sans-first:1.12 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 62.0 62.0 64.0 64.0 61.0 62.0 63.0 62.0 01:08:51 INFO - 2015-11-24 01:08:51,684 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:3.50 (4.1%) stddev-sans-first:3.54 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 86.0 85.0 86.0 93.0 85.0 94.0 86.0 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,685 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:3.07 (2.5%) stddev-sans-first:3.05 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 118.0 127.0 122.0 122.0 122.0 126.0 119.0 125.0 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.50 stddev:7.16 (4.7%) stddev-sans-first:5.87 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 167.0 151.0 152.0 148.0 153.0 150.0 154.0 157.0 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.31 (3.5%) stddev-sans-first:2.44 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 65.0 67.0 70.0 68.0 71.0 65.0 64.0 66.0 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:08:51 INFO - 2015-11-24 01:08:51,686 DEBUG : BROWSER_OUTPUT: 01:08:52 INFO - 2015-11-24 01:08:52,662 INFO : Browser exited with error code: 0 01:08:52 INFO - 2015-11-24 01:08:52,716 INFO : Completed test kraken (00:00:59) 01:08:52 INFO - 2015-11-24 01:08:52,716 INFO : Starting test v8_7 01:08:52 INFO - 2015-11-24 01:08:52,716 DEBUG : operating with platform_type : linux_ 01:08:52 INFO - 2015-11-24 01:08:52,716 INFO : Initialising browser for v8_7 test... 01:08:52 INFO - 2015-11-24 01:08:52,722 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp91tkT0/profile http://localhost:46662/getInfo.html 01:08:57 INFO - 2015-11-24 01:08:57,047 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:57 INFO - 2015-11-24 01:08:57,047 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:57 INFO - 2015-11-24 01:08:57,047 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:08:57 INFO - 2015-11-24 01:08:57,047 DEBUG : BROWSER_OUTPUT: __metrics 01:08:58 INFO - 2015-11-24 01:08:58,138 INFO : Browser initialized. 01:08:58 INFO - 2015-11-24 01:08:58,139 INFO : Running cycle 1/1 for v8_7 test... 01:08:58 INFO - 2015-11-24 01:08:58,139 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp91tkT0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:09:09 INFO - 2015-11-24 01:09:09,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 141934592 01:09:09 INFO - 2015-11-24 01:09:09,846 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46662/tests/v8_7/run.html (next: http://localhost:46662/tests/v8_7/run.html) 01:09:31 INFO - 2015-11-24 01:09:31,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 01:09:31 INFO - 2015-11-24 01:09:31,562 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: |0;Richards;185.08236165093467 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.64833462432222 01:09:31 INFO - 2015-11-24 01:09:31,564 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8199943836001 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5015 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1037.344398340249 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |5;Earley;713.4711332858161 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |7;RegExp;24878.048780487807 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |8;Splay;1214.5454545454545 01:09:31 INFO - 2015-11-24 01:09:31,565 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 01:09:31 INFO - 2015-11-24 01:09:31,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:31 INFO - 2015-11-24 01:09:31,566 DEBUG : BROWSER_OUTPUT: __startTimestamp1448356171563__endTimestamp 01:09:31 INFO - 2015-11-24 01:09:31,566 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,566 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:31 INFO - 2015-11-24 01:09:31,566 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:09:31 INFO - 2015-11-24 01:09:31,567 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,567 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.08 Median:185.08 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,568 DEBUG : BROWSER_OUTPUT: Values: 185.1 01:09:31 INFO - 2015-11-24 01:09:31,568 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.65 Median:193.65 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: Values: 193.6 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: Values: 280.8 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5015.00 Median:5015.00 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: Values: 5015.0 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1037.34 Median:1037.34 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: Values: 1037.3 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.47 Median:713.47 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: Values: 713.5 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: Values: 12132.5 01:09:31 INFO - 2015-11-24 01:09:31,570 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24878.05 Median:24878.05 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: Values: 24878.0 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1214.55 Median:1214.55 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: Values: 1214.5 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: Values: 4826.9 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:31 INFO - 2015-11-24 01:09:31,571 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-24 01:09:32,550 INFO : Browser exited with error code: 0 01:09:32 INFO - 2015-11-24 01:09:32,567 INFO : Completed test v8_7 (00:00:39) 01:09:32 INFO - 2015-11-24 01:09:32,574 INFO : Completed test suite (00:20:11) 01:09:32 INFO - 2015-11-24 01:09:32,574 DEBUG : Working with test: dromaeo_css 01:09:32 INFO - 2015-11-24 01:09:32,574 DEBUG : Generating results file: dromaeo_css 01:09:32 INFO - 2015-11-24 01:09:32,574 DEBUG : Working with test: kraken 01:09:32 INFO - 2015-11-24 01:09:32,574 DEBUG : Generating results file: kraken 01:09:32 INFO - 2015-11-24 01:09:32,574 INFO : javascript benchmark 01:09:32 INFO - 2015-11-24 01:09:32,574 DEBUG : Working with test: v8_7 01:09:32 INFO - 2015-11-24 01:09:32,575 DEBUG : Generating results file: v8_7 01:09:32 INFO - 2015-11-24 01:09:32,575 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:32 INFO - 2015-11-24 01:09:32,627 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 01:09:32 INFO - 2015-11-24 01:09:32,628 DEBUG : process_Request line: dromaeo_css 6892.88 graph.html#tests=[[72,64,43]] 01:09:32 INFO - 2015-11-24 01:09:32,628 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:32 INFO - 2015-11-24 01:09:32,658 DEBUG : process_Request line: kraken 1520.10 graph.html#tests=[[232,64,43]] 01:09:32 INFO - 2015-11-24 01:09:32,658 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:32 INFO - 2015-11-24 01:09:32,688 DEBUG : process_Request line: v8_7 19841.72 graph.html#tests=[[230,64,43]] 01:09:32 INFO - 2015-11-24 01:09:32,690 INFO : javascript benchmark 01:09:32 INFO - 2015-11-24 01:09:32,693 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3197.9040628781136, 3237.061252236853, 3261.347730453907, 3284.556584861043, 3285.999999999999, 5283.8150664726645, 5432.70120143392, 5465.644733092357, 5468.72656367182, 5477.5070243678065, 5460.262864513289, 5464.207689884965, 5470.0, 5478.808241711541, 5584.86037849053, 4918.50814918508, 5031.295618613379, 5122.052420302238, 5141.485851414847, 5149.2791009258735, 4953.578945789613, 5061.54446099851, 5086.237064440345, 5101.107306221396, 5149.433562308143, 4921.237208232729, 4927.1870141426625, 5029.446760856303, 5046.293518907356, 5059.747012649353, 5006.5744411725045, 5013.623978201613, 5020.548150666457, 5034.647574669774, 5036.068327359413, 4956.529129732669, 4990.476000020019, 4992.850214493535, 4995.55040046394, 4996.700197988096, 5154.716490593016, 5222.843314700565, 5288.444713305124, 5399.244105825188, 5403.486668766461, 5913.29040515141, 5913.822585322448, 5924.555658325643, 5939.792107276267, 5940.37626049263, 5851.824445266649, 5945.583809133363, 5954.4938680212235, 5956.761729530814, 5960.821175364746, 5557.888842223133, 5583.4137415571595, 5703.515201207943, 5716.514096301861, 5760.9711951440395, 6009.639421634716, 6012.368701286389, 6014.8195554133445, 6020.187274717945, 6030.969845150747, 5649.152627105885, 5674.4892959633835, 5791.884162316815, 5800.7099645018425, 5814.505767009767, 5746.856328591819, 5821.126830975303, 5839.270091238595, 5842.152887831241, 5872.559558033165, 5916.970415147896, 5930.466258036798, 5935.73289201987, 5980.73086711099, 5989.880202396015, 5742.397048309867, 5865.237519122486, 5994.250718660168, 6009.909851352233, 6011.789587364421, 4436.112777444524, 4440.378347031418, 4441.20058389493, 4475.977620111944, 4476.552344765498, 4020.43713880057, 4042.0905296308097, 4093.2222877653153, 4105.220008198433, 4121.423000779893, 5474.890502190014, 5544.750486228129, 5575.4424557544735, 5733.140028995684, 5743.425657434307, 5977.880442391128, 6007.699615019232, 6021.277446706424, 6028.246469191351, 6040.063790112539, 5673.1490276458035, 5684.317881854121, 5714.371419143891, 5718.399568045295, 5730.5129064030025, 4933.950660493421, 5007.524285192901, 5038.949610503848, 5125.103106956342, 5129.897402051938, 6137.285055221596, 6254.0, 6258.937410625836, 6269.185005949289, 6273.686315684197, 5968.313643931004, 5980.0, 5995.640261584319, 6009.759609615567, 6032.6983650818165, 5893.528517718658, 6012.158297838394, 6040.6979651018155, 6130.601510901777, 6204.844878877883, 5875.529957603467, 5894.351621321737, 5939.673317967553, 5951.047832346804, 5961.52307815365, 6047.848803779764, 6072.939270607414, 6080.543959202989, 6081.817545473643, 6082.0, 5574.498295153294, 5683.687397193194, 5767.711614419346, 5857.209276747755, 5879.647221166743, 5815.534757219328, 5827.475527202572, 5861.296644402529, 5873.148393483007, 5879.94120058811, 5775.509081727932, 5792.21805056312, 5792.536597072309, 5796.188533605215, 5804.477597016289, 5653.0, 5679.318481782213, 5787.971060144672, 5856.443637854397, 5868.618539794899, 5673.801416950387, 5723.0, 5725.656460612377, 5759.280089988752, 5765.077587585966], "unit": "ms", "name": "dojo.html", "value": 5463.21575990492}, {"lowerIsBetter": false, "replicates": [540.4541413172694, 543.717267021149, 554.7087778916068, 580.2109131581052, 581.3692144023734, 38788.80605596972, 39714.404283935764, 39758.0, 40041.1991760165, 40110.59889401109, 41707.37438938418, 42263.57736422635, 42334.788326058326, 42338.57661423385, 42375.36436953448, 8871.334649901251, 8991.190792828644, 9020.0, 9048.819023619557, 9062.139096785795, 8717.866677331938, 8796.69211577595, 8840.646374145059, 8842.690505832297, 8847.159519845605, 8873.68942087027, 8931.821363572724, 8962.058983806704, 8992.595333209989, 8995.055519170492, 8841.734747957571, 8871.77820554488, 8908.643654253821, 8911.064338244489, 8920.687775927876, 8776.0, 8889.244414224799, 8892.066333035067, 8897.154770296811, 8917.464952102895, 39377.0, 39758.20483590312, 39964.800175999226, 40027.79986100051, 40038.79980600107, 3384.424647809878, 3508.947365789515, 3510.3681337359267, 3598.316319899237, 3745.793981331026, 29334.70665293341, 29827.254318642208, 29881.103566893027, 29984.55023174654, 30076.548851767242, 3537.982310088433, 3664.926701465982, 3713.387291096966, 3750.19370835269, 3859.517560304962, 264116.0, 264641.0, 266129.0, 266180.0, 266375.0, 56619.43380566224, 58394.708026460445, 58841.0, 59256.407435925954, 59296.40703592995, 70195.64902175457, 70506.64746676234, 70615.0, 71266.28733712596, 71442.0, 15309.0, 15333.923330383277, 15403.229838508254, 15452.768208476882, 15550.533483995498, 11269.380184089954, 11421.714457138472, 11443.656690299304, 11469.426528673534, 11485.942570287096, 20253.696194557095, 20509.38471845847, 20598.588028239352, 20625.587488250152, 20704.58590828175, 7430.7399241026305, 7447.590382529013, 7625.389968802482, 7656.578888161204, 7774.961125194338, 874.9956250218709, 938.8873335199684, 940.6237504998055, 1060.0, 1069.0325255643654, 28129.43741125166, 28285.71714282872, 28843.134705958855, 28927.276818079295, 28993.42013159725, 994.8408254679216, 1013.138831992815, 1134.3817619397448, 1138.2487558211706, 1215.8237055627062, 13841.792373114411, 13926.512572060132, 15183.468578599917, 15721.0, 15988.680226395407, 240801.0, 241168.0, 243294.0, 243451.0, 243782.59195744403, 48204.0, 48322.516774832504, 48423.273650895266, 48676.5132348679, 48683.756581217574, 1336.8663133686553, 1338.1034706746502, 1343.6775173958374, 1352.3238380809792, 1357.0907491980397, 28278.0, 28862.278443039093, 29101.0, 29352.0, 29509.557356639238, 46323.0, 46430.76784616191, 46637.766811165726, 47048.76475617737, 47125.0, 274394.0, 277210.0, 279035.0, 280466.0, 280578.0, 30964.535531966587, 31943.840280798446, 32172.678273217905, 32304.83847580747, 32333.676663233065, 42132.0, 42379.0, 43668.344974824766, 43813.0, 44247.336289955034, 36486.45270321, 36526.817365913, 36729.81635091914, 36968.44547331846, 37288.813555933135, 35428.64571354254, 37100.0, 37238.62761372352, 37342.43986340153, 37715.245695086494, 32722.50916236306, 33909.66090339065, 34078.148046299044, 34135.487967680005, 34191.82904085464, 28476.418386678797, 30746.692533074383, 32708.182295442803, 33334.83328083505, 33533.32933341271, 25304.240872773848, 25514.362140946625, 25696.9624622607, 25714.35714107162, 25816.096436624626], "unit": "ms", "name": "ext.html", "value": 18414.870191154685}, {"lowerIsBetter": false, "replicates": [339.7485860463258, 352.90118766745303, 356.0582259922505, 356.8162396365871, 361.4884937812995, 16380.344786208552, 17245.82754172458, 17640.911795441036, 18238.544036399097, 18374.35689750859, 10780.676579702622, 11635.534578616845, 15742.212889355544, 15829.208539573034, 15942.123183224918, 4597.494275629678, 4770.689905156154, 4779.354787103749, 4797.0645724083815, 4816.542428469307, 4772.141014617368, 4794.065157294329, 4797.832075877345, 4800.231962885939, 4806.0628177505405, 3743.794091324976, 3846.9038274043232, 4813.302071199691, 4875.07373599015, 5132.769025393866, 5170.870728231786, 5182.7408629568745, 5224.477552244764, 5225.869353266161, 5256.448072952342, 5059.873503162414, 5087.771050302746, 5106.617003724736, 5305.840824775263, 5354.223637572531, 19673.9016304919, 19860.20559177631, 20017.1993120275, 20549.4862628434, 20788.376348709564, 2013.315472739261, 2075.1491888325713, 2076.1487790006026, 2091.874487530753, 2182.7380714314227, 8609.5695215239, 8638.093000234947, 8703.891168946457, 8866.069062748447, 9383.06169383063, 1717.5362652083868, 1795.721663142202, 1805.4493379519242, 1818.8908665480114, 1879.3891985104895, 60254.0, 62332.0, 64224.0, 64479.03281450782, 64643.353566464204, 10219.722534683164, 10346.482675866177, 10366.274360794672, 10388.0, 10390.740231494274, 13433.932830335785, 13495.460181592824, 13555.525556605471, 13565.796513052312, 13575.728485430236, 7207.9639601801655, 7242.565446073252, 7290.307420795016, 7325.377342925911, 7358.374538164209, 6830.521863469509, 6836.760713375008, 6847.828804279833, 6871.209810871814, 6884.105066341343, 4460.063386688832, 4462.888427789267, 4508.526604706524, 4540.750258735801, 4545.181867263858, 1890.2155605423595, 1895.4408449507152, 1906.27561526619, 1913.6268427656473, 1918.587503686714, 415.47649961049297, 416.68748438670997, 875.4090988582681, 947.9763005924907, 952.1478276942098, 10600.575976960836, 10878.728031799268, 11024.228304018801, 11080.0, 11089.27919685218, 428.70847823480335, 428.9699721019561, 434.18373457898946, 435.7821089455272, 445.37869671808295, 5804.303483581997, 6005.879882402328, 6028.788992385245, 6040.969795151084, 6042.909356359658, 476684.0, 500539.0, 509014.0, 512571.0, 525556.0, 79675.0, 81598.0, 81801.59099204585, 82144.58927705443, 82592.58703706563, 1152.6023521884936, 1161.1813671361501, 1165.906727461801, 1171.800793865045, 1174.9236299640495, 15316.081035137928, 15478.226088695295, 15601.29794159243, 15750.0, 15866.761998570262, 34085.147871303416, 34680.479792802624, 35558.46662300119, 35647.82176089103, 35898.28203435969, 46967.06065878595, 48192.5180748188, 48446.27330589973, 50161.74919125381, 51258.48741512537, 9007.459552426875, 9178.632854685738, 9263.490508022123, 9307.72076837696, 9334.2999275056, 10725.731856703645, 13605.795913061114, 17015.91492042532, 17179.65640687154, 17268.136593170544, 14111.082779619292, 14503.709925801213, 14595.489157879423, 14655.413783448543, 14681.70636587241, 13882.722345553235, 14168.645783855485, 14315.498957536436, 14371.712565748836, 14430.711385772436, 15013.474528391454, 15063.397464101752, 15203.923980380026, 15252.694946100793, 15579.532614021597, 9083.45499270046, 9250.121238482334, 9272.72181834546, 9761.0, 10079.395236285847, 14976.876734244757, 15000.324985375466, 15061.924690376478, 15096.0, 15246.847531524987], "unit": "ms", "name": "jquery.html", "value": 8259.001838168011}, {"lowerIsBetter": false, "replicates": [1430.6995530938505, 1487.7396455620267, 1582.707199168154, 1590.9522714318575, 1714.8370904764042, 6319.399657032586, 6349.619022858632, 7292.270772922705, 7511.62441877906, 7553.622318884061, 7006.404455621278, 7197.316254955784, 7248.601326927017, 7253.564786112837, 7255.056842610466, 2141.9892900535474, 2180.1388451561625, 2185.4208634711736, 2186.0272178880405, 2193.7367515898036, 2240.9215677451293, 2274.090363854455, 2279.225063478417, 2289.7710228977053, 2293.942651433711, 2171.706819579352, 2171.9782802171935, 2180.160638154306, 2198.967015494769, 2250.459889626486, 2181.5091604389045, 2208.7459942106702, 2227.8774667393286, 2231.4309850987975, 2237.69791078204, 2138.860974036683, 2155.3641675705703, 2166.6316726156433, 2168.251953076186, 2173.7608863025052, 7317.707291708325, 7375.778726638209, 7392.55644661322, 7396.926030739677, 7407.407407407394, 4551.749653769041, 4631.4442266927845, 4634.420697412824, 4658.277966915133, 4659.324397962277, 3001.6998300170026, 3005.8046226995175, 3011.021418039146, 3012.171652795477, 3023.0, 947.2232769129316, 947.3652652722692, 964.5466630683637, 976.0629795396356, 1015.0559979219323, 9792.510374481248, 9798.510074496318, 9809.656662016796, 9811.067948544876, 9846.359986600848, 4025.657819085352, 4061.817218225187, 4065.5121385433936, 4077.041895154636, 4154.667626589866, 8568.400211985101, 8588.656453741905, 8674.6096425661, 8699.521526315986, 8720.12798720123, 4519.954800451954, 4583.564561366665, 4591.816327346935, 4591.862244132682, 4608.9308660370125, 4055.391691246278, 4114.506259248909, 4126.979365103155, 4148.543660197376, 4173.624373806372, 3413.0, 3431.8627254909525, 3434.6737059979264, 3450.2064525158853, 3453.810040447749, 1048.1352883870836, 1065.4246706778408, 1069.9037086662238, 1071.8660167479065, 1081.6322450366913, 976.2482888176206, 982.0523195116747, 986.413084214891, 1110.7056629993058, 1351.047511504387, 7014.964925175342, 7047.083879095685, 7058.858822823515, 7064.470164737665, 7071.186813516409, 477.2840738891662, 478.5358202543527, 479.4510285722898, 481.0835358641793, 482.8937633720576, 5302.68183908959, 5370.597205209625, 5371.274877891513, 5387.892242155213, 5422.240886275925, 8624.78438039054, 8668.739937801876, 8823.073577274294, 8944.239739622206, 8946.373753837299, 8691.826163476695, 8706.825863482694, 8718.956405217934, 8763.956180219186, 8797.164269394398, 6675.732970681119, 6713.865722685519, 6758.121444212221, 6782.287859774751, 6805.047293378931, 6580.5064620152725, 6615.305392933865, 6630.7679231226675, 6662.400383965466, 6667.966660166668, 7629.0, 7791.415643826849, 7842.29419352261, 7930.762077137464, 7985.920140798517, 7773.18381569927, 7987.161348058603, 8008.319292859939, 8075.434719569574, 8140.511569305861, 5569.582281328835, 5686.886262274814, 6162.044883043135, 6234.563580549318, 6395.392437718409, 5901.527877769854, 6459.063435801876, 6591.769288074895, 6626.734930602915, 6665.133532640726, 6439.8068057958335, 6513.837154071186, 6617.172853393326, 6752.763653272112, 6772.729090836311, 6341.968290158704, 6477.611343319416, 6484.221893372825, 6521.054447105238, 6523.67381630907, 6368.617882927039, 6416.037594360883, 6449.419552240321, 6456.063870738811, 6501.8699626008165, 6058.636481811105, 6115.388461153849, 6182.041783523561, 6187.659678717534, 6195.96902015487, 6057.878842423215, 6141.447269745566, 6195.721192546256, 6202.379762023942, 6213.2233470816145], "unit": "ms", "name": "mootools.html", "value": 4143.91348554734}, {"lowerIsBetter": false, "replicates": [315.6385938100873, 316.7560978046904, 318.8708573027924, 319.54305343359005, 327.15756925915764, 6292.898742720023, 6343.492520598353, 6413.615183089012, 6448.000559913221, 6525.543211975164, 6270.184875966118, 6335.239771227448, 6344.984802431612, 6345.968270158654, 6367.917454032814, 4533.455985281755, 4636.281376386665, 4641.767911604423, 4710.764461776906, 4725.976370118162, 4653.348531205634, 4663.137319595869, 4665.300204969248, 4667.113248482778, 4695.060987802453, 4605.4933957264675, 4614.400127983357, 4617.699849509788, 4619.976900115495, 4623.42207224097, 4584.381108550353, 4629.77311012582, 4635.443746750411, 4644.698094623838, 4650.837220697276, 3839.155385815116, 3918.666913312372, 3930.5479869815053, 3956.1692044670654, 3957.8416863325433, 5905.4685078343155, 5916.171735956969, 5952.4642782149385, 5962.07587823888, 6007.309159446676, 5396.622236443451, 5409.972950135263, 5414.29614150158, 5414.539764120054, 5434.429384914567, 6641.7675381361905, 6643.767468138641, 6644.202695676501, 6662.10061641677, 6667.899981500282, 4332.631726303268, 4418.028033832552, 4439.64482841372, 4454.866354009352, 4454.9777251113865, 6879.828004299882, 6962.477814163907, 6972.407345375649, 6987.580745155357, 7016.017757513952, 4438.334249862546, 4443.6667249955735, 4443.933340999887, 4454.10917816438, 4470.508244093147, 4455.287154055336, 4504.031633198878, 4509.391232183679, 4516.728996260234, 4519.706219095749, 5383.084875571162, 5400.405955344909, 5438.45615438453, 5447.428020057916, 5457.290552228185, 6779.017042528806, 6782.593044417351, 6784.457243420613, 6794.796156115324, 6802.4217941474535, 1620.198001989023, 1635.3295148988857, 1635.3703824027598, 1636.7544868269617, 1636.8035835699793, 1079.8596182496226, 1083.3066837224183, 1088.7114914547492, 1100.5487750022453, 1113.1651261553834, 6489.448396886223, 6495.837604059841, 6501.0573466847045, 6502.447291980235, 6508.349165083454, 6929.514933954575, 6939.6877140528795, 6947.51367404287, 6963.0, 6967.198772141167, 6367.968160159169, 6426.74293028283, 6482.643454610042, 6483.2122187459845, 6483.7082331295205, 3781.3382658034734, 3811.066288759216, 3811.123441608446, 3813.389857622767, 3816.103215744298, 7197.4961752677855, 7334.559926404433, 7341.963290183515, 7344.339009489065, 7344.742933997284, 7245.275472452712, 7254.238304978006, 7261.963690181516, 7263.455240856957, 7275.563466192046, 7165.713371465187, 7316.56100633953, 7317.0487836580905, 7319.560826350436, 7338.376238019828, 6963.1644202696, 7028.753993610199, 7041.647917604202, 7043.859122817617, 7045.084139061889, 6847.965760171167, 6913.688884000131, 6930.099087118844, 6960.443164546926, 6968.95465680152, 7147.678354474165, 7295.489315747846, 7303.671334790053, 7304.379127774198, 7308.671109799965, 4529.84145554904, 4631.073785242897, 4643.489216186149, 4646.907061858811, 4652.209124448784, 6929.237783843672, 6973.19808222061, 6998.090248267693, 7007.194172670208, 7022.367986881205, 6595.967020164869, 6781.6270105144695, 6788.592684438752, 6803.591784492946, 6814.2163651180745, 6718.93281067183, 6789.388954994074, 6799.6600169990315, 6805.353491418307, 6807.251202367835, 6682.46540276767, 6684.899726504009, 6689.26418094019, 6690.899636505554, 6692.464602831859, 6699.363560461748, 6784.2876497967, 6861.142357205349, 6862.588244705334, 6863.519553631198, 6598.439132673777, 6607.57050791697, 6662.200535935719, 6663.433608143362, 6676.766313179015], "unit": "ms", "name": "prototype.html", "value": 4994.2572970751135}, {"lowerIsBetter": false, "replicates": [764.2319468933722, 803.3854101612268, 847.686356048262, 851.3529717414763, 862.5730263519558, 13679.042467027311, 13855.030147889653, 13866.0, 13941.233232172226, 13942.721145577096, 12940.935295323534, 12989.80515292269, 13008.869911300884, 13033.34833258338, 13083.869161308408, 827.5241736001808, 840.231188462556, 857.8027053777635, 857.9742607721747, 858.2961971183632, 830.0330115415563, 849.8767678686587, 856.6016802186982, 856.6359297298624, 856.9657213711444, 857.438377862501, 873.9694110706095, 875.6278581602793, 880.5905254056862, 881.973540793774, 850.26452118917, 863.5639002303797, 871.7689812199741, 872.9432586881865, 873.7116751472063, 647.7927063339733, 648.2124219073847, 650.6161364794747, 651.5374084400081, 652.1228947066236, 13306.933465332708, 13378.331083445788, 13471.797923031163, 13484.865151348458, 13504.864951350557, 12127.272363658209, 12149.331786751725, 12226.75546489074, 12634.178778379468, 13280.136791108547, 10426.635067772591, 10474.633387831465, 10513.474326283731, 10673.412962287071, 10770.138388928866, 3548.308079924416, 3552.3960926642535, 3657.213699054716, 3736.327461057009, 3751.568569614502, 48796.268055978835, 49123.263151052764, 49219.0, 49380.259296110584, 49475.75262123702, 10328.948355258326, 10357.0, 10411.635592754217, 10477.423741694127, 10531.89468105309, 16141.757873631905, 16161.838381616268, 16191.109488977983, 16191.352345906032, 16219.18904054816, 7680.884786728204, 7763.417743669247, 7794.766157015299, 7940.444168908121, 7954.721584744506, 4364.803583838735, 4375.256206444912, 4467.173572889026, 4493.1013797240685, 4520.367148599199, 3101.519264514004, 3131.232847952266, 3138.1213260287154, 3143.984280078585, 3164.5095010273444, 532.5366930770177, 540.4757385336218, 546.0144439287045, 547.15464607182, 558.8938101760652, 632.5256057956533, 667.6594936582378, 669.681901096975, 679.7281087565013, 700.1842853076109, 7633.503822251536, 7778.144404115543, 7855.921440785519, 7957.7612671619945, 7961.24600448685, 542.2083757713782, 545.5417449342572, 645.7772068636312, 654.5745265577318, 677.8034370032734, 3660.396034654252, 3689.5572531296416, 3693.7045036397026, 3738.476613274144, 3774.471573979645, 56635.716821415626, 57375.71312143413, 57524.71237643785, 57870.710646446496, 58150.709246454346, 50249.24127655588, 50713.49286507162, 50919.490805091475, 50994.74502627463, 51550.48449515457, 46375.30437043447, 46626.76686616545, 46654.533454665696, 46702.0, 46974.76512617483, 7598.392128629585, 7700.383969282556, 7715.92284077152, 7764.844703105793, 7895.368370530458, 33903.0, 34084.488732669524, 34244.0, 34379.65620343765, 35081.82459087688, 40498.797506012284, 40730.0, 43215.13569728651, 44592.33111503265, 44824.55175448204, 10224.846627300745, 10425.218108642033, 10486.265961382935, 10486.895131048592, 10638.521266543179, 11551.711207219887, 11559.595414160463, 11697.06423486136, 11710.297382157098, 11762.896367632738, 10749.838752418877, 10854.45727713627, 10925.617603383844, 10951.890481095086, 11017.228793984345, 10400.323978941344, 10459.0, 10463.843042354523, 10522.526486308288, 10793.784124317313, 10234.283600147919, 10485.475726213506, 10497.737556560842, 10601.946990265, 10921.617743378943, 9298.814023719353, 9393.201577865959, 9443.811123777623, 9885.802283954137, 10262.025107614765, 8719.128087191484, 9009.549522523717, 9163.450192988443, 9417.576209070472, 9844.655437059955], "unit": "ms", "name": "yui.html", "value": 6236.46613324521}], "name": "dromaeo_css", "value": 6892.878532667269}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 111.0, 126.0, 113.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 153.0, 182.0, 129.0, 152.0, 150.0, 128.0, 170.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 167.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 72.0, 72.0, 73.0, 144.0, 71.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 136.0, 94.0, 94.0, 95.0, 137.0, 93.0, 94.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 62.0, 62.0, 64.0, 64.0, 61.0, 62.0, 63.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 86.0, 85.0, 86.0, 93.0, 85.0, 94.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 118.0, 127.0, 122.0, 122.0, 122.0, 126.0, 119.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 167.0, 151.0, 152.0, 148.0, 153.0, 150.0, 154.0, 157.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 67.0, 70.0, 68.0, 71.0, 65.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1520.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [185.08236165093467], "unit": "score", "name": "Richards", "value": 190.73670599999994}, {"lowerIsBetter": false, "replicates": [193.64833462432222], "unit": "score", "name": "DeltaBlue", "value": 341.433352}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5015.0], "unit": "score", "name": "Decrypt", "value": 53.07696909272185}, {"lowerIsBetter": false, "replicates": [1037.344398340249], "unit": "score", "name": "RayTrace", "value": 713.3493960000002}, {"lowerIsBetter": false, "replicates": [713.4711332858161], "unit": "score", "name": "Earley", "value": 934.1134755244756}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [24878.048780487807], "unit": "score", "name": "RegExp", "value": 36.618024509803895}, {"lowerIsBetter": false, "replicates": [1214.5454545454545], "unit": "score", "name": "Splay", "value": 67.09588323353296}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19841.718972339168}]} 01:09:32 INFO - RETURN: dromaeo_css: 6892.88 01:09:32 INFO - RETURN: kraken: 1520.10 01:09:32 INFO - RETURN: v8_7: 19841.72 01:09:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "19841.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6892.88"}}} 01:09:32 INFO - Return code: 0 01:09:32 INFO - # TBPL SUCCESS # 01:09:32 INFO - Running post-action listener: _resource_record_post_action 01:09:32 INFO - Running post-run listener: _resource_record_post_run 01:09:33 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524214272; Read time: 132; Write time: 575572 01:09:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 141885440; Read time: 0; Write time: 292900 01:09:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382328832; Read time: 132; Write time: 282672 01:09:33 INFO - Running post-run listener: _upload_blobber_files 01:09:33 INFO - Blob upload gear active. 01:09:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:09:33 INFO - Copying logs to upload dir... 01:09:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.162028 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-24 01:09:32.596370) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:32.599874) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009870 build_url: 'https://queue.taskcluster.net/v1/task/9RrCvLWvRv6TMlyfuqV5bg/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-24 01:09:32.652230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:32.652772) ========= 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=3cd289541638898829117e0a000001bd-1448354825.407677-1831010083 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 01:09:32.703461) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:09:32.703834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 01:09:32.704164) ========= ========= Total master_lag: 0.23 =========