builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1448286037.62 results: success (0) buildid: 20151123030237 builduid: 933d95c3f7ec4a1382a9e13a65e28a4a revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.620906) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.621450) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.621795) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006533 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.656138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.656481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.750899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.751184) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.811452) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.811781) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.812208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.812804) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 05:40:38-- 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% 43.3M=0s 2015-11-23 05:40:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159915 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.005592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.005860) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015839 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.069710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.070054) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 05:40:38,836 truncating revision to first 12 chars 2015-11-23 05:40:38,837 Setting DEBUG logging. 2015-11-23 05:40:38,837 attempt 1/10 2015-11-23 05:40:38,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 05:40:39,333 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.849577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.849881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.859249) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.859569) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.859933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 05:40:38.860269) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:39 INFO - MultiFileLogger online at 20151123 05:40:39 in /builds/slave/test-pgo 05:40:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:40:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:40:39 INFO - {'append_to_log': False, 05:40:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:40:39 INFO - 'blob_upload_branch': 'Firefox', 05:40:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:40:39 INFO - 'branch': 'Firefox', 05:40:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:39 INFO - 'config_files': ('talos/linux_config.py',), 05:40:39 INFO - 'default_actions': ('clobber', 05:40:39 INFO - 'read-buildbot-config', 05:40:39 INFO - 'download-and-extract', 05:40:39 INFO - 'populate-webroot', 05:40:39 INFO - 'create-virtualenv', 05:40:39 INFO - 'install', 05:40:39 INFO - 'run-tests'), 05:40:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:39 INFO - 'download_minidump_stackwalk': True, 05:40:39 INFO - 'download_symbols': 'ondemand', 05:40:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:39 INFO - 'installer_path': 'installer.exe', 05:40:39 INFO - 'log_level': 'info', 05:40:39 INFO - 'log_name': 'talos', 05:40:39 INFO - 'log_to_console': True, 05:40:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:39 INFO - 'opt_config_files': (), 05:40:39 INFO - 'pip_index': False, 05:40:39 INFO - 'sps_profile': False, 05:40:39 INFO - 'sps_profile_interval': 0, 05:40:39 INFO - 'suite': 'dromaeojs-e10s', 05:40:39 INFO - 'system_bits': '64', 05:40:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:39 INFO - 'title': 'talos-linux64-ix-009', 05:40:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:39 INFO - 'use_talos_json': True, 05:40:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:40:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:39 INFO - 'work_dir': 'build'} 05:40:39 INFO - ##### 05:40:39 INFO - ##### Running clobber step. 05:40:39 INFO - ##### 05:40:39 INFO - Running pre-action listener: _resource_record_pre_action 05:40:39 INFO - Running main action method: clobber 05:40:39 INFO - rmtree: /builds/slave/test-pgo/build 05:40:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:40:40 INFO - Running post-action listener: _resource_record_post_action 05:40:40 INFO - ##### 05:40:40 INFO - ##### Running read-buildbot-config step. 05:40:40 INFO - ##### 05:40:40 INFO - Running pre-action listener: _resource_record_pre_action 05:40:40 INFO - Running main action method: read_buildbot_config 05:40:40 INFO - Using buildbot properties: 05:40:40 INFO - { 05:40:40 INFO - "properties": { 05:40:40 INFO - "buildnumber": 557, 05:40:40 INFO - "product": "firefox", 05:40:40 INFO - "script_repo_revision": "production", 05:40:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:40:40 INFO - "repository": "", 05:40:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:40:40 INFO - "buildid": "20151123030237", 05:40:40 INFO - "slavename": "talos-linux64-ix-009", 05:40:40 INFO - "stage_platform": "linux64-pgo", 05:40:40 INFO - "basedir": "/builds/slave/test-pgo", 05:40:40 INFO - "nightly_build": "True", 05:40:40 INFO - "project": "", 05:40:40 INFO - "platform": "ubuntu64_hw", 05:40:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:40:40 INFO - "slavebuilddir": "test", 05:40:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "branch": "mozilla-central", 05:40:40 INFO - "repo_path": "mozilla-central", 05:40:40 INFO - "pgo_build": "True", 05:40:40 INFO - "builduid": "933d95c3f7ec4a1382a9e13a65e28a4a", 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - }, 05:40:40 INFO - "sourcestamp": { 05:40:40 INFO - "repository": "", 05:40:40 INFO - "hasPatch": false, 05:40:40 INFO - "project": "", 05:40:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "changes": [ 05:40:40 INFO - { 05:40:40 INFO - "category": null, 05:40:40 INFO - "files": [ 05:40:40 INFO - { 05:40:40 INFO - "url": null, 05:40:40 INFO - "name": "https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:40:40 INFO - } 05:40:40 INFO - ], 05:40:40 INFO - "repository": "", 05:40:40 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 05:40:40 INFO - "who": "sendchange", 05:40:40 INFO - "when": 1448285996, 05:40:40 INFO - "number": 6694869, 05:40:40 INFO - "comments": "", 05:40:40 INFO - "project": "", 05:40:40 INFO - "at": "Mon 23 Nov 2015 05:39:56", 05:40:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "revlink": "", 05:40:40 INFO - "properties": [ 05:40:40 INFO - [ 05:40:40 INFO - "buildid", 05:40:40 INFO - "20151123030237", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "builduid", 05:40:40 INFO - "933d95c3f7ec4a1382a9e13a65e28a4a", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "nightly_build", 05:40:40 INFO - "True", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "pgo_build", 05:40:40 INFO - "True", 05:40:40 INFO - "Change" 05:40:40 INFO - ] 05:40:40 INFO - ], 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - } 05:40:40 INFO - ], 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - } 05:40:40 INFO - } 05:40:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:40:40 INFO - Running post-action listener: _resource_record_post_action 05:40:40 INFO - ##### 05:40:40 INFO - ##### Running download-and-extract step. 05:40:40 INFO - ##### 05:40:40 INFO - Running pre-action listener: _resource_record_pre_action 05:40:40 INFO - Running main action method: download_and_extract 05:40:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:40: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')]} 05:40:40 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json 05:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json 05:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:40:50 INFO - Downloaded 1302 bytes. 05:40:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:40:50 INFO - Using the following test package requirements: 05:40:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'jsshell-linux-x86_64.zip'], 05:40:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:50 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:40:56 INFO - Downloaded 22524652 bytes. 05:40:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:40:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:40:57 INFO - Return code: 0 05:40:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:57 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:40:58 INFO - Downloaded 22524652 bytes. 05:40:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:40:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:40:59 INFO - Return code: 0 05:40: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')]} 05:40:59 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:41:00 INFO - Downloaded 11130997 bytes. 05:41:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:41:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:41:00 INFO - Return code: 0 05:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:00 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:41:02 INFO - Downloaded 57453419 bytes. 05:41:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:02 INFO - mkdir: /builds/slave/test-pgo/properties 05:41:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:41:02 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:41:02 INFO - Contents: 05:41:02 INFO - build_url:https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:41:02 INFO - Running post-action listener: _resource_record_post_action 05:41:02 INFO - Running post-action listener: set_extra_try_arguments 05:41:02 INFO - ##### 05:41:02 INFO - ##### Running populate-webroot step. 05:41:02 INFO - ##### 05:41:02 INFO - Running pre-action listener: _resource_record_pre_action 05:41:02 INFO - Running main action method: populate_webroot 05:41:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:02 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:41:02 INFO - '../fennec_ids.txt'], 05:41:02 INFO - 'tests': ['tcheck2']}, 05:41:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:02 INFO - '--tppagecycles', 05:41:02 INFO - '7'], 05:41:02 INFO - 'tests': ['tsvgm']}}, 05:41:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:41:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:41:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'tests': ['damp', 'tps']}, 05:41:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['damp', 'tps']}, 05:41:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:41:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:02 INFO - 'other': {'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'other_l64': {'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'other_nol64': {'tests': ['a11yr', 05:41:02 INFO - 'ts_paint', 05:41:02 INFO - 'tpaint', 05:41:02 INFO - 'sessionrestore', 05:41:02 INFO - 'sessionrestore_no_auto_restore']}, 05:41:02 INFO - 'svgr': {'tests': ['tsvgx', 05:41:02 INFO - 'tsvgr_opacity', 05:41:02 INFO - 'tart', 05:41:02 INFO - 'tscrollx', 05:41:02 INFO - 'cart']}, 05:41:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['tsvgx', 05:41:02 INFO - 'tsvgr_opacity', 05:41:02 INFO - 'tart', 05:41:02 INFO - 'tscrollx', 05:41:02 INFO - 'cart']}, 05:41:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'tests': ['tp5o']}, 05:41:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'talos_options': ['--e10s'], 05:41:02 INFO - 'tests': ['tp5o']}, 05:41:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'talos_options': ['--xperf_path', 05:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:02 INFO - 'tests': ['tp5n']}, 05:41:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:02 INFO - 'talos_options': ['--e10s', 05:41:02 INFO - '--xperf_path', 05:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:02 INFO - 'tests': ['tp5n']}}, 05:41:02 INFO - 'talos.zip': {'path': '', 05:41:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:02 INFO - Running post-action listener: _resource_record_post_action 05:41:02 INFO - ##### 05:41:02 INFO - ##### Running create-virtualenv step. 05:41:02 INFO - ##### 05:41:02 INFO - Running pre-action listener: _resource_record_pre_action 05:41:02 INFO - Running main action method: create_virtualenv 05:41:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:41:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:41:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:41:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:02 INFO - Using real prefix '/usr' 05:41:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:41:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:04 INFO - Installing pip.................done. 05:41:04 INFO - Return code: 0 05:41:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:41:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:41:04 INFO - Using env: {'DISPLAY': ':0', 05:41:04 INFO - 'HOME': '/home/cltbld', 05:41:04 INFO - 'LANG': 'en_US.UTF-8', 05:41:04 INFO - 'LANGUAGE': 'en_US:en', 05:41:04 INFO - 'LOGNAME': 'cltbld', 05:41:04 INFO - 'MAIL': '/var/mail/cltbld', 05:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:04 INFO - 'MOZ_NO_REMOTE': '1', 05:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:04 INFO - 'NO_EM_RESTART': '1', 05:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:04 INFO - 'SHELL': '/bin/bash', 05:41:04 INFO - 'SHLVL': '1', 05:41:04 INFO - 'TERM': 'linux', 05:41:04 INFO - 'TMOUT': '86400', 05:41:04 INFO - 'USER': 'cltbld', 05:41:04 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:04 INFO - '_': '/tools/buildbot/bin/python'} 05:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:41:05 INFO - Cleaning up... 05:41:05 INFO - Return code: 0 05:41:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:41:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:41:05 INFO - Using env: {'DISPLAY': ':0', 05:41:05 INFO - 'HOME': '/home/cltbld', 05:41:05 INFO - 'LANG': 'en_US.UTF-8', 05:41:05 INFO - 'LANGUAGE': 'en_US:en', 05:41:05 INFO - 'LOGNAME': 'cltbld', 05:41:05 INFO - 'MAIL': '/var/mail/cltbld', 05:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:05 INFO - 'MOZ_NO_REMOTE': '1', 05:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:05 INFO - 'NO_EM_RESTART': '1', 05:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:05 INFO - 'SHELL': '/bin/bash', 05:41:05 INFO - 'SHLVL': '1', 05:41:05 INFO - 'TERM': 'linux', 05:41:05 INFO - 'TMOUT': '86400', 05:41:05 INFO - 'USER': 'cltbld', 05:41:05 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:05 INFO - '_': '/tools/buildbot/bin/python'} 05:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:05 INFO - Downloading/unpacking psutil>=0.7.1 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:41:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:41:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:07 INFO - Installing collected packages: psutil 05:41:07 INFO - Running setup.py install for psutil 05:41:07 INFO - building 'psutil._psutil_linux' extension 05:41:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:41:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:41:07 INFO - building 'psutil._psutil_posix' extension 05:41:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:41:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:07 INFO - Successfully installed psutil 05:41:07 INFO - Cleaning up... 05:41:07 INFO - Return code: 0 05:41:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:07 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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:41:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:41:07 INFO - Using env: {'DISPLAY': ':0', 05:41:07 INFO - 'HOME': '/home/cltbld', 05:41:07 INFO - 'LANG': 'en_US.UTF-8', 05:41:07 INFO - 'LANGUAGE': 'en_US:en', 05:41:07 INFO - 'LOGNAME': 'cltbld', 05:41:07 INFO - 'MAIL': '/var/mail/cltbld', 05:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:07 INFO - 'MOZ_NO_REMOTE': '1', 05:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:07 INFO - 'NO_EM_RESTART': '1', 05:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:07 INFO - 'SHELL': '/bin/bash', 05:41:07 INFO - 'SHLVL': '1', 05:41:07 INFO - 'TERM': 'linux', 05:41:07 INFO - 'TMOUT': '86400', 05:41:07 INFO - 'USER': 'cltbld', 05:41:07 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:07 INFO - '_': '/tools/buildbot/bin/python'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:41:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:41:09 INFO - Installing collected packages: mozsystemmonitor 05:41:09 INFO - Running setup.py install for mozsystemmonitor 05:41:09 INFO - Successfully installed mozsystemmonitor 05:41:09 INFO - Cleaning up... 05:41:09 INFO - Return code: 0 05:41:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:41:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:41:09 INFO - Using env: {'DISPLAY': ':0', 05:41:09 INFO - 'HOME': '/home/cltbld', 05:41:09 INFO - 'LANG': 'en_US.UTF-8', 05:41:09 INFO - 'LANGUAGE': 'en_US:en', 05:41:09 INFO - 'LOGNAME': 'cltbld', 05:41:09 INFO - 'MAIL': '/var/mail/cltbld', 05:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:09 INFO - 'MOZ_NO_REMOTE': '1', 05:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:09 INFO - 'NO_EM_RESTART': '1', 05:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:09 INFO - 'SHELL': '/bin/bash', 05:41:09 INFO - 'SHLVL': '1', 05:41:09 INFO - 'TERM': 'linux', 05:41:09 INFO - 'TMOUT': '86400', 05:41:09 INFO - 'USER': 'cltbld', 05:41:09 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:09 INFO - '_': '/tools/buildbot/bin/python'} 05:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:41:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:12 INFO - Downloading docopt-0.6.1.tar.gz 05:41:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:41:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:12 INFO - Running setup.py install for blobuploader 05:41:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:12 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:41:12 INFO - Running setup.py install for requests 05:41:12 INFO - Running setup.py install for docopt 05:41:12 INFO - Successfully installed blobuploader requests docopt 05:41:12 INFO - Cleaning up... 05:41:12 INFO - Return code: 0 05:41:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:12 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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:41:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:12 INFO - Using env: {'DISPLAY': ':0', 05:41:12 INFO - 'HOME': '/home/cltbld', 05:41:12 INFO - 'LANG': 'en_US.UTF-8', 05:41:12 INFO - 'LANGUAGE': 'en_US:en', 05:41:12 INFO - 'LOGNAME': 'cltbld', 05:41:12 INFO - 'MAIL': '/var/mail/cltbld', 05:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:12 INFO - 'MOZ_NO_REMOTE': '1', 05:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:12 INFO - 'NO_EM_RESTART': '1', 05:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:12 INFO - 'SHELL': '/bin/bash', 05:41:12 INFO - 'SHLVL': '1', 05:41:12 INFO - 'TERM': 'linux', 05:41:12 INFO - 'TMOUT': '86400', 05:41:12 INFO - 'USER': 'cltbld', 05:41:12 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:12 INFO - '_': '/tools/buildbot/bin/python'} 05:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:13 INFO - Running setup.py (path:/tmp/pip-ZEX7I0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:13 INFO - Running setup.py (path:/tmp/pip-_d507a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:13 INFO - Running setup.py (path:/tmp/pip-hv7yjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:13 INFO - Running setup.py (path:/tmp/pip-oIblXS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:13 INFO - Running setup.py (path:/tmp/pip-rJeii0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:13 INFO - Running setup.py (path:/tmp/pip-S1nViv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:13 INFO - Running setup.py (path:/tmp/pip-Wu2Sn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:13 INFO - Running setup.py (path:/tmp/pip-cIV4Ew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:13 INFO - Running setup.py (path:/tmp/pip-YHyHgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:13 INFO - Running setup.py (path:/tmp/pip-bxgb9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:13 INFO - Running setup.py (path:/tmp/pip-WVVeXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:13 INFO - Running setup.py (path:/tmp/pip-0QmhE6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:13 INFO - Running setup.py (path:/tmp/pip-QekSLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:14 INFO - Running setup.py (path:/tmp/pip-9aW9sY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:14 INFO - Running setup.py (path:/tmp/pip-GyzlvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:14 INFO - Running setup.py (path:/tmp/pip-TW7rJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:14 INFO - Running setup.py (path:/tmp/pip-lilEQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:14 INFO - Running setup.py install for manifestparser 05:41:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:41:14 INFO - Running setup.py install for mozcrash 05:41:14 INFO - Running setup.py install for mozdebug 05:41:14 INFO - Running setup.py install for mozdevice 05:41:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:41:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:41:14 INFO - Running setup.py install for mozfile 05:41:14 INFO - Running setup.py install for mozhttpd 05:41:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:41:14 INFO - Running setup.py install for mozinfo 05:41:15 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for mozInstall 05:41:15 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for mozleak 05:41:15 INFO - Running setup.py install for mozlog 05:41:15 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for moznetwork 05:41:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for mozprocess 05:41:15 INFO - Running setup.py install for mozprofile 05:41:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for mozrunner 05:41:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:41:15 INFO - Running setup.py install for mozscreenshot 05:41:15 INFO - Running setup.py install for moztest 05:41:15 INFO - Running setup.py install for mozversion 05:41:16 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:41:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:16 INFO - Cleaning up... 05:41:16 INFO - Return code: 0 05:41:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:41:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:16 INFO - Using env: {'DISPLAY': ':0', 05:41:16 INFO - 'HOME': '/home/cltbld', 05:41:16 INFO - 'LANG': 'en_US.UTF-8', 05:41:16 INFO - 'LANGUAGE': 'en_US:en', 05:41:16 INFO - 'LOGNAME': 'cltbld', 05:41:16 INFO - 'MAIL': '/var/mail/cltbld', 05:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:16 INFO - 'MOZ_NO_REMOTE': '1', 05:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:16 INFO - 'NO_EM_RESTART': '1', 05:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:16 INFO - 'SHELL': '/bin/bash', 05:41:16 INFO - 'SHLVL': '1', 05:41:16 INFO - 'TERM': 'linux', 05:41:16 INFO - 'TMOUT': '86400', 05:41:16 INFO - 'USER': 'cltbld', 05:41:16 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:16 INFO - '_': '/tools/buildbot/bin/python'} 05:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:16 INFO - Running setup.py (path:/tmp/pip-OOZjDH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:16 INFO - Running setup.py (path:/tmp/pip-lRxFP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:16 INFO - Running setup.py (path:/tmp/pip-GnzGsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:16 INFO - Running setup.py (path:/tmp/pip-P9zo6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:16 INFO - Running setup.py (path:/tmp/pip-fzHOr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:16 INFO - Running setup.py (path:/tmp/pip-YhjeQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:16 INFO - Running setup.py (path:/tmp/pip-ImjcH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:16 INFO - Running setup.py (path:/tmp/pip-ZJcJOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:16 INFO - Running setup.py (path:/tmp/pip-dAOPAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:16 INFO - Running setup.py (path:/tmp/pip-DGjiec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:17 INFO - Running setup.py (path:/tmp/pip-kG23_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:17 INFO - Running setup.py (path:/tmp/pip-RehNlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:17 INFO - Running setup.py (path:/tmp/pip-DfQAsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:17 INFO - Running setup.py (path:/tmp/pip-V4Xil4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:17 INFO - Running setup.py (path:/tmp/pip-DYD2g_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:17 INFO - Running setup.py (path:/tmp/pip-ybf7Ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:41:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:17 INFO - Running setup.py (path:/tmp/pip-YUgYVJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:19 INFO - Downloading blessings-1.5.1.tar.gz 05:41:19 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:41:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:19 INFO - Installing collected packages: blessings 05:41:19 INFO - Running setup.py install for blessings 05:41:19 INFO - Successfully installed blessings 05:41:19 INFO - Cleaning up... 05:41:19 INFO - Return code: 0 05:41:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:41:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:19 INFO - Reading from file tmpfile_stdout 05:41:19 INFO - Current package versions: 05:41:19 INFO - argparse == 1.2.1 05:41:19 INFO - blessings == 1.5.1 05:41:19 INFO - blobuploader == 1.2.4 05:41:19 INFO - docopt == 0.6.1 05:41:19 INFO - manifestparser == 1.1 05:41:19 INFO - mozInstall == 1.12 05:41:19 INFO - mozcrash == 0.16 05:41:19 INFO - mozdebug == 0.1 05:41:19 INFO - mozdevice == 0.47 05:41:19 INFO - mozfile == 1.2 05:41:19 INFO - mozhttpd == 0.7 05:41:19 INFO - mozinfo == 0.9 05:41:19 INFO - mozleak == 0.1 05:41:19 INFO - mozlog == 3.0 05:41:19 INFO - moznetwork == 0.27 05:41:19 INFO - mozprocess == 0.22 05:41:19 INFO - mozprofile == 0.27 05:41:19 INFO - mozrunner == 6.11 05:41:19 INFO - mozscreenshot == 0.1 05:41:19 INFO - mozsystemmonitor == 0.0 05:41:19 INFO - moztest == 0.7 05:41:19 INFO - mozversion == 1.4 05:41:19 INFO - psutil == 3.1.1 05:41:19 INFO - requests == 1.2.3 05:41:19 INFO - wsgiref == 0.1.2 05:41:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:19 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 0x7f2b617b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a16c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:41:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:19 INFO - Using env: {'DISPLAY': ':0', 05:41:19 INFO - 'HOME': '/home/cltbld', 05:41:19 INFO - 'LANG': 'en_US.UTF-8', 05:41:19 INFO - 'LANGUAGE': 'en_US:en', 05:41:19 INFO - 'LOGNAME': 'cltbld', 05:41:19 INFO - 'MAIL': '/var/mail/cltbld', 05:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:19 INFO - 'MOZ_NO_REMOTE': '1', 05:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:19 INFO - 'NO_EM_RESTART': '1', 05:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:19 INFO - 'SHELL': '/bin/bash', 05:41:19 INFO - 'SHLVL': '1', 05:41:19 INFO - 'TERM': 'linux', 05:41:19 INFO - 'TMOUT': '86400', 05:41:19 INFO - 'USER': 'cltbld', 05:41:19 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:19 INFO - '_': '/tools/buildbot/bin/python'} 05:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:19 INFO - Cleaning up... 05:41:19 INFO - Return code: 0 05:41:19 INFO - Running post-action listener: _resource_record_post_action 05:41:19 INFO - Running post-action listener: _start_resource_monitoring 05:41:19 INFO - Starting resource monitoring. 05:41:19 INFO - ##### 05:41:19 INFO - ##### Running install step. 05:41:19 INFO - ##### 05:41:19 INFO - Running pre-action listener: _resource_record_pre_action 05:41:19 INFO - Running main action method: install 05:41:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:20 INFO - Reading from file tmpfile_stdout 05:41:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:41:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:41:20 INFO - Reading from file tmpfile_stdout 05:41:20 INFO - Output received: 05:41:20 INFO - Usage: mozinstall [options] installer 05:41:20 INFO - Options: 05:41:20 INFO - -h, --help show this help message and exit 05:41:20 INFO - -d DEST, --destination=DEST 05:41:20 INFO - Directory to install application into. [default: 05:41:20 INFO - "/builds/slave/test-pgo"] 05:41:20 INFO - --app=APP Application being installed. [default: firefox] 05:41:20 INFO - mkdir: /builds/slave/test-pgo/build/application 05:41:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:41:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:41:34 INFO - Reading from file tmpfile_stdout 05:41:34 INFO - Output received: 05:41:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:41:34 INFO - Running post-action listener: _resource_record_post_action 05:41:34 INFO - ##### 05:41:34 INFO - ##### Running run-tests step. 05:41:34 INFO - ##### 05:41:34 INFO - Running pre-action listener: _resource_record_pre_action 05:41:34 INFO - Running main action method: run_tests 05:41:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:41:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:41:34 INFO - Python 2.7.3 05:41:34 INFO - Return code: 0 05:41:34 INFO - grabbing minidump binary from tooltool 05:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:34 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 0x2698a90>, '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 0x26eaf70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26eb2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:41:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:41:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:41:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:34 INFO - Return code: 0 05:41:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:41:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:41:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:41:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:41:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost 05:41:34 INFO - Using env: {'DISPLAY': ':0', 05:41:34 INFO - 'HOME': '/home/cltbld', 05:41:34 INFO - 'LANG': 'en_US.UTF-8', 05:41:34 INFO - 'LANGUAGE': 'en_US:en', 05:41:34 INFO - 'LOGNAME': 'cltbld', 05:41:34 INFO - 'MAIL': '/var/mail/cltbld', 05:41:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:41:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:34 INFO - 'MOZ_NO_REMOTE': '1', 05:41:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:34 INFO - 'NO_EM_RESTART': '1', 05:41:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:41:34 INFO - 'SHELL': '/bin/bash', 05:41:34 INFO - 'SHLVL': '1', 05:41:34 INFO - 'TERM': 'linux', 05:41:34 INFO - 'TMOUT': '86400', 05:41:34 INFO - 'USER': 'cltbld', 05:41:34 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269', 05:41:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:34 INFO - '_': '/tools/buildbot/bin/python'} 05:41:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost'] with output_timeout 3600 05:41:34 INFO - mozversion INFO | application_buildid: 20151123030237 05:41:34 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 05:41:34 INFO - mozversion INFO | application_display_name: Nightly 05:41:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:34 INFO - mozversion INFO | application_name: Firefox 05:41:34 INFO - mozversion INFO | application_remotingname: firefox 05:41:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:41:34 INFO - mozversion INFO | application_vendor: Mozilla 05:41:34 INFO - mozversion INFO | application_version: 45.0a1 05:41:34 INFO - mozversion INFO | platform_buildid: 20151123030237 05:41:34 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 05:41:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:41:34 INFO - mozversion INFO | platform_version: 45.0a1 05:41:34 INFO - 2015-11-23 05:41:34,914 DEBUG : using testdate: 1448286094 05:41:34 INFO - 2015-11-23 05:41:34,914 DEBUG : actual date: 1448286094 05:41:34 INFO - 2015-11-23 05:41:34,923 INFO : starting webserver on 'localhost:42652' 05:41:34 INFO - 2015-11-23 05:41:34,924 INFO : Starting test suite talos-linux64-ix-009.e 05:41:34 INFO - 2015-11-23 05:41:34,924 INFO : Starting test dromaeo_css 05:41:34 INFO - 2015-11-23 05:41:34,924 DEBUG : operating with platform_type : linux_ 05:41:34 INFO - 2015-11-23 05:41:34,925 INFO : Initialising browser for dromaeo_css test... 05:41:34 INFO - 2015-11-23 05:41:34,939 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIqVesT/profile http://localhost:42652/getInfo.html 05:41:41 INFO - 2015-11-23 05:41:41,653 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:41:41 INFO - 2015-11-23 05:41:41,653 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:41:41 INFO - 2015-11-23 05:41:41,653 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:41:41 INFO - 2015-11-23 05:41:41,653 DEBUG : BROWSER_OUTPUT: __metrics 05:41:42 INFO - 2015-11-23 05:41:42,717 INFO : Browser initialized. 05:41:42 INFO - 2015-11-23 05:41:42,718 INFO : Running cycle 1/1 for dromaeo_css test... 05:41:42 INFO - 2015-11-23 05:41:42,718 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIqVesT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:41:54 INFO - 2015-11-23 05:41:54,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 05:41:54 INFO - 2015-11-23 05:41:54,489 DEBUG : BROWSER_OUTPUT: 05:42:44 INFO - 2015-11-23 05:42:44,121 DEBUG : BROWSER_OUTPUT: 1448286164120 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:44:53 INFO - 2015-11-23 05:44:53,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42652/tests/dromaeo/cssquery-ext.html) 05:44:54 INFO - 2015-11-23 05:44:54,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 147562496 05:44:54 INFO - 2015-11-23 05:44:54,452 DEBUG : BROWSER_OUTPUT: 05:47:56 INFO - 2015-11-23 05:47:56,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-ext.html (next: http://localhost:42652/tests/dromaeo/cssquery-jquery.html) 05:47:57 INFO - 2015-11-23 05:47:57,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 142229504 05:47:57 INFO - 2015-11-23 05:47:57,038 DEBUG : BROWSER_OUTPUT: 05:50:58 INFO - 2015-11-23 05:50:58,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42652/tests/dromaeo/cssquery-mootools.html) 05:50:59 INFO - 2015-11-23 05:50:59,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 142315520 05:50:59 INFO - 2015-11-23 05:50:59,342 DEBUG : BROWSER_OUTPUT: 05:54:00 INFO - 2015-11-23 05:54:00,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42652/tests/dromaeo/cssquery-prototype.html) 05:54:01 INFO - 2015-11-23 05:54:01,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 141701120 05:54:01 INFO - 2015-11-23 05:54:01,529 DEBUG : BROWSER_OUTPUT: 05:57:03 INFO - 2015-11-23 05:57:03,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42652/tests/dromaeo/cssquery-yui.html) 05:57:04 INFO - 2015-11-23 05:57:04,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 142397440 05:57:04 INFO - 2015-11-23 05:57:04,471 DEBUG : BROWSER_OUTPUT: 06:00:06 INFO - 2015-11-23 06:00:06,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/dromaeo/cssquery-yui.html (next: http://localhost:42652/tests/dromaeo/cssquery-dojo.html) 06:00:07 INFO - 2015-11-23 06:00:07,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 144732160 06:00:07 INFO - 2015-11-23 06:00:07,110 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,110 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:07 INFO - 2015-11-23 06:00:07,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:07 INFO - 2015-11-23 06:00:07,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:07 INFO - 2015-11-23 06:00:07,112 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:07 INFO - 2015-11-23 06:00:07,113 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3221.355728854229;3243.367543329052;3259.266665000374;3292.835358232088;3301.6698330166987;5369.194620806881;5459.017376872166;5465.508104270615;5468.726563671816;5517.69652669103;5411.269478620385;5468.9726551367285;5513.669179849202;5522.530584900288;5596.804111856086;4971.925421118686;5066.113430149728;5115.488451154892;5122.8207012754565;5131.076406246874;5066.392032956032;5085.3389059422225;5109.514596113363;5152.304438900738;5165.431802501722;4928.408590969071;5015.5987520998415;5017.297578339036;5022.347094877679;5064.11378008847;4964.851054468371;5014.749262536859;5035.59715222785;5047.64666473347;5058.317127187819;4982.725950072744;4984.651074424792;4990.051890140898;5047.167217409123;5053.469385714484;5007.098722229997;5182.766775495112;5278.1818818082875;5282.630215884889;5343.797645529725;5781.913271300934;5830.883382332329;5834.708264586796;5852.12218167274;5889.528837692974;5913.7930172444185;5922.97038514809;5927.170196172539;5935.762569497215;5945.137954996501;5385.515303622654;5462.672239665632;5464.890702185974;5550.111982082888;5613.943860561424;5829.825105246765;5859.414058594191;5884.676342801187;5903.645781253139;5906.586538942232;5738.196652468658;5738.225339579187;5743.1385292206505;5784;5837.211976383219;6024.909626355608;6055.364186760415;6089.817305480843;6090.756369745161;6110.205673262448;6048.4858787003595;6062.090686396988;6070.453659170696;6074.757009719562;6080.270367555833;5770.971145144247;5871.55963302754;5959.523238140939;6017.488513476404;6102.938970610237;4626.629869610423;4630.467496237976;4648.302754586839;4650.9767451162525;4652.674312798139;4102.938455923164;4107.8973025674;4123.628873401348;4131.793410329532;4148.896277593084;5446.863828404322;5544.722763861791;5565.41563135873;5733.483986441241;5742.885142297131;5942.524598032147;5961.791337303173;5983.19226904371;5996.370381110008;5998.1602575639445;5631.267935168402;5688.800891968761;5690.459406356389;5692;5692.288463942007;5041.117804384218;5117.795288188505;5139.331886854759;5175.948240517547;5214.765335559909;6037.124616930609;6091.695415229221;6102.084687296852;6103.816885493442;6121.326654068049;5868.589198756046;5919.4968427684125;5922.555808314308;5924.31870334917;5945.3757355477055;5999.070144127667;6002.459778619946;6070.3929607038945;6127.84680382994;6160.845978850564;5859.296884373903;5895.145203945318;5900.557458190567;5909.409059094056;5988.700564971647;5708.400617935057;5859.384764599656;5932.317783454958;6002.279726432856;6006.819795406145;5730;5737.053386191232;5739.942600573941;5803.970980145241;5859.414058594107;5778.537716982715;5802.361740208489;5813.244278243801;5819.941800582109;5829.067349224104;5588.022096133079;5697.487226149667;5718.542516598579;5719.370869204301;5722.799702010409;5775.220345253337;5789.9710501447225;5875.529957603296;5897.144913987534;5973.253343332083;5713.1715901193265;5713.514351280188;5747.971260143672;5770.192173095686;5789.2763404574425 06:00:07 INFO - 2015-11-23 06:00:07,114 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.1271673414776;585.6720236667468;586.1647152807251;593.3769541980919;621.3258614403372;39416;40187.196256074894;40460;40481;40485.59514404855;40582.18835623286;41137.382939255935;41390.58609413905;41615.79192104043;41705.37441938366;8670.696525621588;8794.912050879506;8854.07032261613;8864.955675221614;8871.024187339388;8358.665653373857;8361.205685459872;8368.414211005233;8370.162983701612;8410.074891761902;8582.485050896936;8585.270252028586;8681.30549556034;8684.56577171142;8697.304215662733;8617.741467755946;8667.653293868238;8682.088380720028;8685.218330350268;8687.47875127488;8501.06488286288;8513.872291915626;8515.318774498026;8599.785005374915;8654;38611.613883861086;39445.80277098625;39520.802395988125;39575;39660.60339396598;3189.234583699895;3281.0976981330086;3359.4624860022277;3598.429524153733;3974.880753577397;30620;30823.69176308253;31454;31659.20851978696;32361.51457728136;3790.166163444038;3860.3823388257742;3886.2227554489214;3928.0572662561067;4026.295398305314;266689;267652;268313;269281;269478;52579.999999999236;53995.46004539983;59769.91955683729;60056;60273.69863150656;67764.6611766938;68071.3192868065;68324.31675683279;68493.65753171203;68815;15596.532104036896;15729.370825167094;15777.68444631101;15794.289256983464;15799;11989.64031079069;12001.39993000364;12063.21589096706;12104.939475302743;12117.515299388102;20306.492337691678;20653.58692826135;20851.374458766262;20873.060712267983;20883.164673413197;8140.83718325642;8372.665093396317;8437;8508.446950948168;8514.191151840565;857.2295177338093;947.8483442649281;950.9144177024101;968.5351031504918;1051.4059556350637;28276.43447131046;28720.85639571789;28725;28855.711442885302;28970.27574310617;998.8651532043226;1016.9288149829441;1038.7506998320348;1085.4247248958065;1139.3847322445952;15200.315985780666;16477;16767.245473953702;16769;16958;395179;400363;400995;401044;401447;55024.72487637616;55564.72217638967;55914;56033.71983140058;56316.71841640765;1298.9350532473338;1299.3568183749105;1308.653206900172;1374.8900087992936;1378.3797291218991;28676.569851452663;29265.268368290963;29585.408291834472;29681.406371872872;29709;47388.2891756617;47938;48062.519374807205;48183.27725084056;48219.27671085007;308460;308965;309621;310319;310837;33009.83495082509;45506.77246613746;46149.30776038429;46560.53439465562;46795.532044679116;44118;44220;44783;44933.42733004329;45002.54997449984;37047.444288336235;38100;38253.2349353017;38878;39009.2198156041;35884;36782.81608592047;36907.26185476222;37367.6263237375;37425.6257437433;36671;36740.44889326609;36933.63066369302;37448;37591;31962.36075278435;32764.18089547685;33259.788488331586;33361;33405.66594334123;26329.868350658126;26376;26519;26795.732042679323;26815.865920670272 06:00:07 INFO - 2015-11-23 06:00:07,118 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.67480243373655;352.84651176738134;360.2614639988024;367.1903452886386;368.49516162856884;16544.420945266902;16765.580860478494;17454.77816552842;17570.03364814936;18118.27526898926;11535.134864885145;11619.767604647903;11673.066154707623;12164.452599633016;17301.13494325285;4966.652334336589;5098.107831129556;5141.974290128544;5279.762410691528;5293.52358287754;4619.468761092484;5149.536541711245;5224.059669259532;5241.842744717665;5267.26258323835;5107.540321371076;5141.82003629873;5165.3026841376495;5251.632385733;5266.157414813631;5153.2785410042625;5260.763265653055;5282.867928301785;5288.788448462057;5567.526760225385;5270.209468579706;5377.4084850666395;5385.892282154374;5392.460753924615;5395.190721391783;12461.06542009353;13515.797263040964;17779.644407111915;19813.207471701116;19904.402867913985;1932.0726051495221;2072.512959454527;2091.173986275428;2127.2022991378235;2141.175647375756;9245.260379169651;9376.578053987587;9387.62449502019;9429.66996155138;9507.714768556954;1790.588164722108;1835.9449216523392;1842.5854182808894;1843.3087592152942;1885.8774179678278;61017.6949115256;65095.34904650987;66072.3392766071;66377;66825.33174668289;10455.320404173704;10561.471926403648;10575.947120264349;10591.682249532527;10612.734681632866;13748.587542373745;13808.723825523433;13817.861821381859;13842.792358114637;13897.79153312701;7887.9605601971625;7990.560519171501;8025.598720063974;8071.07182674;8076.676932922617;7848.13670496245;7863.174366691529;7894.565798881116;7903.170167132368;7932.762017139379;4443.533428989974;4470.949326908174;4490.146872094357;4573.588377046081;4581.770911454414;1864.4313484387392;1879.3422302194122;1900.6293772714464;1923.4614307993784;1927.759030121235;832.7002279179491;881.5680316644927;912.4570880326195;986.033686986757;997.486294558303;15571.221438928009;16660.75008874868;16995;17233.482995510156;17324.393646222576;894.4141587260355;928.382625553999;949.8100379924043;960.4381436859376;1001.1540248490014;9008.306594296308;9583.520823958774;9630.47032413224;9687.273454490942;9720.90279097214;405211;411701;412175;568717;574005;76276.61861690767;79865.60067199628;79896.60051699704;81538.59230703808;81578.59210703909;1156.6183159557327;1163.755611321615;1192.928424294545;1198.3648666206925;1225.154643296123;15124.319405626993;15274.541763747106;15465.304061317493;15591.14248716286;15900.443484477988;20173.03734489575;31723.682763172073;32060.358792823547;33219.833900830345;35948.28103437864;43998.78000610104;45779.31331030104;46356.53643463657;46627.53372466368;46746;9563.09150630689;9779.070988256104;9807.06832850878;10203.132733717717;10208.897911021091;17488.912555437142;17492.562685932953;17764;17846.732299015264;18098.27606895762;13036.869631303945;13515.59453216405;13771.517996870061;14120.717585648024;14740.189289589176;13558.593242202749;14062.507812226522;14290.928545357207;14501.564953051426;14629.92685036568;14107.083039602803;14270.072445291024;14348.784768228694;14565.417383304974;15064.849351506344;9003.234725048182;9268.285367207089;9551.379160354554;9554.952225238829;9562.18721408688;13912.930435347758;14270.305573147183;14305.356258968579;14311.355988980313;14397.352119154453 06:00:07 INFO - 2015-11-23 06:00:07,119 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1467.5083846911282;1470.6838029823587;1630.4212004738317;1769.4072485717284;1787.410154648966;6546.18172728409;6610.10763546921;7401.62991850408;7591.0890693116835;7600.695972161114;7176.354128128467;7425.851482970337;7437.925620743791;7482.5510469371875;7487.73792917248;2278.3392816083315;2303.5047464795066;2317;2324.5118525109665;2325.511642555057;2251.133313674231;2275.84069115162;2301.5051763870765;2302.792748652621;2303.285981345788;2241.081156725743;2260.7739226077424;2293.5183611441535;2296.6095763720123;2304.850184737995;2240.2159244264376;2276.5333106713165;2298.793108620232;2300.1144559344607;2308.5613733390687;2326.7673232676766;2345.3315804995495;2346.9647955280684;2351.9529609407714;2357.4577847095265;7450;7505.1369092554505;7534.321911028033;7535.73624923125;7556.65995030225;4590.196715574761;4628.652851036152;4661.813527458898;4664.043871006435;4678.111158879802;3021.456137895178;3039.9088027359217;3100.7364374028234;3101.3797240551753;3128.9530657040164;983.9963237497712;992.717075633441;1829.3780114761046;1838.5771272607242;1853.9165737541844;10126.189904807597;10187.388756674549;10203.285769996104;10209;10210.540525676288;4167.437395951508;4206.326987681956;4231.746095234295;4251.149770046003;4257.489101307801;8368.456050356708;8388.07731149573;8434.957825210835;8449.704260350982;8451.197136272045;4702.741349225757;4706.411698537683;4710.29345598163;4714.834980775657;4731.905361892743;4166.895827604273;4254.234237837219;4278.2085314216965;4331.220380331571;4360.542143074995;3560.2701446203464;3573;3585.2650206707563;3620.4750311205253;3626.202235508184;1115.1970581181536;1119.339589642115;1121.0975164992096;1125.5947858770835;1131.536070211226;1290.7676618208814;1297.9805302920463;1308.9018323625767;1316.3681432912065;1324.2716505921705;7062.71749130029;7125.144982602121;7192.172900116449;7192.676329565182;7194.244604316471;473.2782506677276;480.0734582256209;483.5672073494203;484.74550860798365;486.2293265174738;5502.422245664227;5517.668939863541;5528.75120619573;5544.69504177266;5548.306461692288;8669.306455483546;8786.297096232414;8998.100189980949;9082.046385129599;9120.8631870522;8854.86717699235;8903.332250081141;8972.775680608038;9013.414128081653;9043.140901614335;6709.966450167815;6829.9072148457;6884.277150899184;7041;7077.787666370017;7035.401990830836;7035.718571257297;7041.647917604202;7077.186123595852;7109.60897150641;7769.689212431439;7790.298873101448;7868.527888326718;7905.604719764104;7934.722284720007;8003.279704826594;8061.516309021477;8093.757187284391;8111.269985701315;8241.217084376975;6640.867182656223;6660.500462465431;6935.791926242221;7199.748008819666;7211.1707153678;6963.2340442552295;7148.714051437884;7201.567905925661;7210.783676489714;7218.3503484686635;6730.158730158731;6841.213260475109;6901.792946211622;7027.227005029545;7084.114485689289;6824.692888819915;6863.073485079451;6914;6918.757843475454;6994;6771.356721111487;6864.073350097673;6864.279250678607;6900.068490753884;6918.757843475454;6406.839829004312;6426.518011149276;6454.096426500199;6456.322086180883;6467.191601049869;6424.164858568356;6531.934680653323;6563.803085907431;6571.835704107436;6574.737010519717 06:00:07 INFO - 2015-11-23 06:00:07,122 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.8861387128376;340.1496259351621;347.9182392137847;350.18407111430355;358.5410674336849;6312.621242725434;6318.0838778377165;6352.6188428694195;6375.330590288023;6518.51111166662;6301.968490157543;6339.302676705559;6341.968290158543;6370.745170193187;6376.553641245115;4765.714057156564;4777.259524773665;4778.761061946906;4783.928241076386;4786.090642777878;4746.050789842028;4752.738599377033;4761.619070474371;4788.305695674125;4790.496997815231;4671.48613652498;4771.045790841828;4794.856154315358;4797.784099715521;4813.975930120345;4780.139574876521;4781.7370044647705;4783.569478746895;4790.640701947351;4796.784144713496;4118.464599602033;4137.834486620562;4144.461220041375;4146.647534959532;4147.97926010368;6013.278406591194;6013.278406591237;6018.8495287617725;6020;6021.939780602225;5440.809571664972;5559.277293951801;5561.721913904288;5565.165225216209;5573.804916827932;6681.164854393201;6705.463562914955;6726.630035348054;6727.125473688389;6728.730850765964;4562.840300589497;4592.058627981256;4594.701344412602;4601;4601.28680054592;6735.259121496631;6892.207396149457;6918.37734603883;6920.515563910529;6990.335918087773;4645.605123564467;4678.345031695565;4695.835645752451;4703.670743048022;4723.929141062887;4740.928886066712;4780.067886762048;4781.95218047822;4783.7129772213775;4785.377900872864;5534.667919924736;5556.722163891789;5559.638623489541;5559.861003474945;5561.555075593943;6590.967045164839;6709.731610735614;6714.362135597111;6731.629760363129;6740.966295168493;1650.6946214950271;1655.106242628991;1685.637587918579;1689.4424839802837;1692.2131208987635;1116.9221701058518;1119.2780656476689;1125.2404626876826;1135.4493070860626;1140.5779861451317;6443.0335449682925;6477.255115661665;6481.351864813481;6483.254425741005;6483.610983341015;6855.348741869514;6874.312568743186;6875.621840798704;6887.827804304932;6889.207741109736;6401.423871851555;6412.935870641327;6434.581752186093;6438.227412710505;6469.805905822833;3799.2971300308977;3818.503594532693;3820.617938206213;3825.5791862895057;3829.6744776693736;7305.305995930378;7306.342429181399;7320.633968301564;7342.192358840523;7369.852602947911;7094.077769889881;7127.358537731629;7239.131304243419;7243.275672432715;7258.056452661226;7250.129984401906;7301.853962920712;7322.121345438475;7328;7337.926620733831;7042.330978557029;7049.436045116481;7052.929470705228;7056.15326160864;7056.188538318159;6774.424173945073;6896.172459304916;6913.827154321182;6934.306569343025;6936.549124306904;7297.233790452138;7303.123625165014;7329.52358096722;7331.890021649786;7337.779866603797;4673.252279635242;4733.408323959505;4734.455537613081;4741.241401375902;4742.691725037862;6839.93160068393;6909.861802763816;6972.337627925339;7050.189228238613;7057.541259818096;6743.1908171019795;6760.594364338155;6787.151606049244;6791.89812152828;6830.009648600826;6778.966105169443;6780.423663988419;6792.76225332111;6796.184457865088;6814.1482314710665;6516.674166291572;6646.634435106115;6657.567258128206;6662.100616416722;6663.833404164935;6814.250432452525;6829.3950921532405;6854.0404343390965;6861.039454476278;6866.725330986705;6566.9343306566325;6592.945128779564;6617.139771829631;6629.867402651824;6631.734730610721 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: |5;yui.html;819.2667562531534;831.3100126894676;843.4348986179259;853.2661910756748;881.8677198420232;14478.203698796575;14516.5645030649;14596.051256668308;14687.485937992173;14841.703165936675;13593.980451466156;13644.931775341134;13717.794233086512;13737.862621373783;13744.381502832372;681.8874885643863;689.3692271571531;823.1768231768217;825.6160885188386;836.7196989008689;836.4981011393146;841.3773807382554;842.8567143585606;843.5950743643054;845.0197770586121;879.6305551668282;880.2210044110976;887.973360799177;887.9866801997975;890.6170346750895;870.851955167623;874.0865795243985;875.4003507597284;878.5738916625431;880.4805164952709;642.2453617000007;643.983900402489;647.9967600162016;648.6205569741707;649.4933951517824;12621.558245461365;12672.049596280316;12680.619581412573;12740.36298185087;12740.936295318557;12124.878751212551;12230.694232644166;12800.48798048077;13103.47586096555;13148.211107333591;10379.169666426667;10482.895171048345;10519.684409467729;10572.15422766177;10600.416977066257;3687.797171155585;3688.6495782900583;3720.4233343831747;3725.1990821973404;3859.5754467008605;47707;47909.52090479086;48001.75999120017;48103;48364.03271934577;10200.744981375377;10204.693859184088;10206.591736330463;10274.280800343904;10380.377177369382;19033.048347582844;19073;19091.522711932314;19129;19143.138558764887;7655.1962043985695;7739.651715672809;7762.7671169865;7797.9220207798335;7910.406719496061;4291.635211007099;4303.913921721611;4356.215881141425;4366.825326986948;4394.187075390999;3111.595492585949;3145.308032232905;3157.6526582075953;3167.493201087861;3172.9206769830475;556.5825630776917;572.390404219505;572.5562688916124;580.8199458167982;582.9417058294136;545.5526468296039;555.1811078658945;643.6459947029115;660.4020741370597;687.1547995964991;8596.785080372916;9135.588898499584;9612.663556775618;9623;9699.563519641633;558.4666643355586;578.2194038048601;643.723199024424;654.1300070905684;735.8822588385833;4064.4309796628495;4314.80583373749;4337.9783101084295;4347.108842687241;4398.406215160912;59733.70133149307;59801.70099149476;60182;60196;60229.39770602326;50499;52530;53047.20429193565;53192.46807531953;53463;47225.29162062572;47736.28395574069;48858.762484628736;49199;53084.469155308725;9300.906990930003;9414.576344064397;9485.762855928657;9548.85676714836;9579.712608621752;33940.49089263614;34560.13599659928;34989.30021399609;36518.26963460663;37179.814100929325;44444.33333500065;44737.55262447334;45410;45623.31565026593;46268;11067.612633557786;11451.083913287084;11728.41357932083;11860.406979651156;12189.451474683838;11479;11734.589289374831;12727.490900363882;12730.427130779322;13141.34293285351;10578.365298082139;10615.840762388725;10624.096951759188;10739.301945373525;11068.114550836075;11902.345371004678;12270.754584908073;12432.875671243171;12816.487340506275;12828.615141545768;11438.313701177956;11835.11236657237;11906.404679765803;12077.154599177973;12409.565665201675;9991.900080999389;10306.948465257627;10543.736406589896;10883.346999180074;11004.779904402027;9188.402753821249;9395.85906211421;9607.423554586747;10343.534540945526;10385.63650272237 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,289 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287207109__endTimestamp 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,123 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5503.47 Median:5733.48 stddev:609.55 (10.6%) stddev-sans-first:584.54 06:00:07 INFO - 2015-11-23 06:00:07,124 DEBUG : BROWSER_OUTPUT: Values: 3221.4 3243.4 3259.3 3292.8 3301.7 5369.2 5459.0 5465.5 5468.7 5517.7 5411.3 5469.0 5513.7 5522.5 5596.8 4971.9 5066.1 5115.5 5122.8 5131.1 5066.4 5085.3 5109.5 5152.3 5165.4 4928.4 5015.6 5017.3 5022.3 5064.1 4964.9 5014.7 5035.6 5047.6 5058.3 4982.7 4984.7 4990.1 5047.2 5053.5 5007.1 5182.8 5278.2 5282.6 5343.8 5781.9 5830.9 5834.7 5852.1 5889.5 5913.8 5923.0 5927.2 5935.8 5945.1 5385.5 5462.7 5464.9 5550.1 5613.9 5829.8 5859.4 5884.7 5903.6 5906.6 5738.2 5738.2 5743.1 5784.0 5837.2 6024.9 6055.4 6089.8 6090.8 6110.2 6048.5 6062.1 6070.5 6074.8 6080.3 5771.0 5871.6 5959.5 6017.5 6102.9 4626.6 4630.5 4648.3 4651.0 4652.7 4102.9 4107.9 4123.6 4131.8 4148.9 5446.9 5544.7 5565.4 5733.5 5742.9 5942.5 5961.8 5983.2 5996.4 5998.2 5631.3 5688.8 5690.5 5692.0 5692.3 5041.1 5117.8 5139.3 5175.9 5214.8 6037.1 6091.7 6102.1 6103.8 6121.3 5868.6 5919.5 5922.6 5924.3 5945.4 5999.1 6002.5 6070.4 6127.8 6160.8 5859.3 5895.1 5900.6 5909.4 5988.7 5708.4 5859.4 5932.3 6002.3 6006.8 5730.0 5737.1 5739.9 5804.0 5859.4 5778.5 5802.4 5813.2 5819.9 5829.1 5588.0 5697.5 5718.5 5719.4 5722.8 5775.2 5790.0 5875.5 5897.1 5973.3 5713.2 5713.5 5748.0 5770.2 5789.3 06:00:07 INFO - 2015-11-23 06:00:07,124 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,124 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50140.76 Median:39430.90 stddev:86778.28 (220.1%) stddev-sans-first:86941.92 06:00:07 INFO - 2015-11-23 06:00:07,125 DEBUG : BROWSER_OUTPUT: Values: 576.1 585.7 586.2 593.4 621.3 39416.0 40187.2 40460.0 40481.0 40485.6 40582.2 41137.4 41390.6 41615.8 41705.4 8670.7 8794.9 8854.1 8865.0 8871.0 8358.7 8361.2 8368.4 8370.2 8410.1 8582.5 8585.3 8681.3 8684.6 8697.3 8617.7 8667.7 8682.1 8685.2 8687.5 8501.1 8513.9 8515.3 8599.8 8654.0 38611.6 39445.8 39520.8 39575.0 39660.6 3189.2 3281.1 3359.5 3598.4 3974.9 30620.0 30823.7 31454.0 31659.2 32361.5 3790.2 3860.4 3886.2 3928.1 4026.3 266689.0 267652.0 268313.0 269281.0 269478.0 52580.0 53995.5 59769.9 60056.0 60273.7 67764.7 68071.3 68324.3 68493.7 68815.0 15596.5 15729.4 15777.7 15794.3 15799.0 11989.6 12001.4 12063.2 12104.9 12117.5 20306.5 20653.6 20851.4 20873.1 20883.2 8140.8 8372.7 8437.0 8508.4 8514.2 857.2 947.8 950.9 968.5 1051.4 28276.4 28720.9 28725.0 28855.7 28970.3 998.9 1016.9 1038.8 1085.4 1139.4 15200.3 16477.0 16767.2 16769.0 16958.0 395179.0 400363.0 400995.0 401044.0 401447.0 55024.7 55564.7 55914.0 56033.7 56316.7 1298.9 1299.4 1308.7 1374.9 1378.4 28676.6 29265.3 29585.4 29681.4 29709.0 47388.3 47938.0 48062.5 48183.3 48219.3 308460.0 308965.0 309621.0 310319.0 310837.0 33009.8 45506.8 46149.3 46560.5 46795.5 44118.0 44220.0 44783.0 44933.4 45002.5 37047.4 38100.0 38253.2 38878.0 39009.2 35884.0 36782.8 36907.3 37367.6 37425.6 36671.0 36740.4 36933.6 37448.0 37591.0 31962.4 32764.2 33259.8 33361.0 33405.7 26329.9 26376.0 26519.0 26795.7 26815.9 06:00:07 INFO - 2015-11-23 06:00:07,125 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,125 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26881.07 Median:363.73 stddev:78808.25 (21666.9%) stddev-sans-first:79004.15 06:00:07 INFO - 2015-11-23 06:00:07,125 DEBUG : BROWSER_OUTPUT: Values: 349.7 352.8 360.3 367.2 368.5 16544.4 16765.6 17454.8 17570.0 18118.3 11535.1 11619.8 11673.1 12164.5 17301.1 4966.7 5098.1 5142.0 5279.8 5293.5 4619.5 5149.5 5224.1 5241.8 5267.3 5107.5 5141.8 5165.3 5251.6 5266.2 5153.3 5260.8 5282.9 5288.8 5567.5 5270.2 5377.4 5385.9 5392.5 5395.2 12461.1 13515.8 17779.6 19813.2 19904.4 1932.1 2072.5 2091.2 2127.2 2141.2 9245.3 9376.6 9387.6 9429.7 9507.7 1790.6 1835.9 1842.6 1843.3 1885.9 61017.7 65095.3 66072.3 66377.0 66825.3 10455.3 10561.5 10575.9 10591.7 10612.7 13748.6 13808.7 13817.9 13842.8 13897.8 7888.0 7990.6 8025.6 8071.1 8076.7 7848.1 7863.2 7894.6 7903.2 7932.8 4443.5 4470.9 4490.1 4573.6 4581.8 1864.4 1879.3 1900.6 1923.5 1927.8 832.7 881.6 912.5 986.0 997.5 15571.2 16660.8 16995.0 17233.5 17324.4 894.4 928.4 949.8 960.4 1001.2 9008.3 9583.5 9630.5 9687.3 9720.9 405211.0 411701.0 412175.0 568717.0 574005.0 76276.6 79865.6 79896.6 81538.6 81578.6 1156.6 1163.8 1192.9 1198.4 1225.2 15124.3 15274.5 15465.3 15591.1 15900.4 20173.0 31723.7 32060.4 33219.8 35948.3 43998.8 45779.3 46356.5 46627.5 46746.0 9563.1 9779.1 9807.1 10203.1 10208.9 17488.9 17492.6 17764.0 17846.7 18098.3 13036.9 13515.6 13771.5 14120.7 14740.2 13558.6 14062.5 14290.9 14501.6 14629.9 14107.1 14270.1 14348.8 14565.4 15064.8 9003.2 9268.3 9551.4 9555.0 9562.2 13912.9 14270.3 14305.4 14311.4 14397.4 06:00:07 INFO - 2015-11-23 06:00:07,126 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,126 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5305.00 Median:6440.31 stddev:2663.40 (41.4%) stddev-sans-first:2655.25 06:00:07 INFO - 2015-11-23 06:00:07,127 DEBUG : BROWSER_OUTPUT: Values: 1467.5 1470.7 1630.4 1769.4 1787.4 6546.2 6610.1 7401.6 7591.1 7600.7 7176.4 7425.9 7437.9 7482.6 7487.7 2278.3 2303.5 2317.0 2324.5 2325.5 2251.1 2275.8 2301.5 2302.8 2303.3 2241.1 2260.8 2293.5 2296.6 2304.9 2240.2 2276.5 2298.8 2300.1 2308.6 2326.8 2345.3 2347.0 2352.0 2357.5 7450.0 7505.1 7534.3 7535.7 7556.7 4590.2 4628.7 4661.8 4664.0 4678.1 3021.5 3039.9 3100.7 3101.4 3129.0 984.0 992.7 1829.4 1838.6 1853.9 10126.2 10187.4 10203.3 10209.0 10210.5 4167.4 4206.3 4231.7 4251.1 4257.5 8368.5 8388.1 8435.0 8449.7 8451.2 4702.7 4706.4 4710.3 4714.8 4731.9 4166.9 4254.2 4278.2 4331.2 4360.5 3560.3 3573.0 3585.3 3620.5 3626.2 1115.2 1119.3 1121.1 1125.6 1131.5 1290.8 1298.0 1308.9 1316.4 1324.3 7062.7 7125.1 7192.2 7192.7 7194.2 473.3 480.1 483.6 484.7 486.2 5502.4 5517.7 5528.8 5544.7 5548.3 8669.3 8786.3 8998.1 9082.0 9120.9 8854.9 8903.3 8972.8 9013.4 9043.1 6710.0 6829.9 6884.3 7041.0 7077.8 7035.4 7035.7 7041.6 7077.2 7109.6 7769.7 7790.3 7868.5 7905.6 7934.7 8003.3 8061.5 8093.8 8111.3 8241.2 6640.9 6660.5 6935.8 7199.7 7211.2 6963.2 7148.7 7201.6 7210.8 7218.4 6730.2 6841.2 6901.8 7027.2 7084.1 6824.7 6863.1 6914.0 6918.8 6994.0 6771.4 6864.1 6864.3 6900.1 6918.8 6406.8 6426.5 6454.1 6456.3 6467.2 6424.2 6531.9 6563.8 6571.8 6574.7 06:00:07 INFO - 2015-11-23 06:00:07,127 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,127 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5628.36 Median:6423.76 stddev:1723.75 (26.8%) stddev-sans-first:1682.17 06:00:07 INFO - 2015-11-23 06:00:07,127 DEBUG : BROWSER_OUTPUT: Values: 334.9 340.1 347.9 350.2 358.5 6312.6 6318.1 6352.6 6375.3 6518.5 6302.0 6339.3 6342.0 6370.7 6376.6 4765.7 4777.3 4778.8 4783.9 4786.1 4746.1 4752.7 4761.6 4788.3 4790.5 4671.5 4771.0 4794.9 4797.8 4814.0 4780.1 4781.7 4783.6 4790.6 4796.8 4118.5 4137.8 4144.5 4146.6 4148.0 6013.3 6013.3 6018.8 6020.0 6021.9 5440.8 5559.3 5561.7 5565.2 5573.8 6681.2 6705.5 6726.6 6727.1 6728.7 4562.8 4592.1 4594.7 4601.0 4601.3 6735.3 6892.2 6918.4 6920.5 6990.3 4645.6 4678.3 4695.8 4703.7 4723.9 4740.9 4780.1 4782.0 4783.7 4785.4 5534.7 5556.7 5559.6 5559.9 5561.6 6591.0 6709.7 6714.4 6731.6 6741.0 1650.7 1655.1 1685.6 1689.4 1692.2 1116.9 1119.3 1125.2 1135.4 1140.6 6443.0 6477.3 6481.4 6483.3 6483.6 6855.3 6874.3 6875.6 6887.8 6889.2 6401.4 6412.9 6434.6 6438.2 6469.8 3799.3 3818.5 3820.6 3825.6 3829.7 7305.3 7306.3 7320.6 7342.2 7369.9 7094.1 7127.4 7239.1 7243.3 7258.1 7250.1 7301.9 7322.1 7328.0 7337.9 7042.3 7049.4 7052.9 7056.2 7056.2 6774.4 6896.2 6913.8 6934.3 6936.5 7297.2 7303.1 7329.5 7331.9 7337.8 4673.3 4733.4 4734.5 4741.2 4742.7 6839.9 6909.9 6972.3 7050.2 7057.5 6743.2 6760.6 6787.2 6791.9 6830.0 6779.0 6780.4 6792.8 6796.2 6814.1 6516.7 6646.6 6657.6 6662.1 6663.8 6814.3 6829.4 6854.0 6861.0 6866.7 6566.9 6592.9 6617.1 6629.9 6631.7 06:00:07 INFO - 2015-11-23 06:00:07,127 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,128 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14231.61 Median:24421.37 stddev:16403.58 (67.2%) stddev-sans-first:16418.68 06:00:07 INFO - 2015-11-23 06:00:07,129 DEBUG : BROWSER_OUTPUT: Values: 819.3 831.3 843.4 853.3 881.9 14478.2 14516.6 14596.1 14687.5 14841.7 13594.0 13644.9 13717.8 13737.9 13744.4 681.9 689.4 823.2 825.6 836.7 836.5 841.4 842.9 843.6 845.0 879.6 880.2 888.0 888.0 890.6 870.9 874.1 875.4 878.6 880.5 642.2 644.0 648.0 648.6 649.5 12621.6 12672.0 12680.6 12740.4 12740.9 12124.9 12230.7 12800.5 13103.5 13148.2 10379.2 10482.9 10519.7 10572.2 10600.4 3687.8 3688.6 3720.4 3725.2 3859.6 47707.0 47909.5 48001.8 48103.0 48364.0 10200.7 10204.7 10206.6 10274.3 10380.4 19033.0 19073.0 19091.5 19129.0 19143.1 7655.2 7739.7 7762.8 7797.9 7910.4 4291.6 4303.9 4356.2 4366.8 4394.2 3111.6 3145.3 3157.7 3167.5 3172.9 556.6 572.4 572.6 580.8 582.9 545.6 555.2 643.6 660.4 687.2 8596.8 9135.6 9612.7 9623.0 9699.6 558.5 578.2 643.7 654.1 735.9 4064.4 4314.8 4338.0 4347.1 4398.4 59733.7 59801.7 60182.0 60196.0 60229.4 50499.0 52530.0 53047.2 53192.5 53463.0 47225.3 47736.3 48858.8 49199.0 53084.5 9300.9 9414.6 9485.8 9548.9 9579.7 33940.5 34560.1 34989.3 36518.3 37179.8 44444.3 44737.6 45410.0 45623.3 46268.0 11067.6 11451.1 11728.4 11860.4 12189.5 11479.0 11734.6 12727.5 12730.4 13141.3 10578.4 10615.8 10624.1 10739.3 11068.1 11902.3 12270.8 12432.9 12816.5 12828.6 11438.3 11835.1 11906.4 12077.2 12409.6 9991.9 10306.9 10543.7 10883.3 11004.8 9188.4 9395.9 9607.4 10343.5 10385.6 06:00:07 INFO - 2015-11-23 06:00:07,129 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:07 INFO - 2015-11-23 06:00:07,129 DEBUG : BROWSER_OUTPUT: 06:00:07 INFO - 2015-11-23 06:00:07,826 INFO : Browser exited with error code: 0 06:00:07 INFO - 2015-11-23 06:00:07,847 INFO : Completed test dromaeo_css (00:18:32) 06:00:07 INFO - 2015-11-23 06:00:07,847 INFO : Starting test kraken 06:00:07 INFO - 2015-11-23 06:00:07,847 DEBUG : operating with platform_type : linux_ 06:00:07 INFO - 2015-11-23 06:00:07,847 INFO : Initialising browser for kraken test... 06:00:07 INFO - 2015-11-23 06:00:07,853 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCzyGwl/profile http://localhost:42652/getInfo.html 06:00:11 INFO - 2015-11-23 06:00:11,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:11 INFO - 2015-11-23 06:00:11,989 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:11 INFO - 2015-11-23 06:00:11,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 06:00:11 INFO - 2015-11-23 06:00:11,990 DEBUG : BROWSER_OUTPUT: __metrics 06:00:13 INFO - 2015-11-23 06:00:13,025 INFO : Browser initialized. 06:00:13 INFO - 2015-11-23 06:00:13,026 INFO : Running cycle 1/1 for kraken test... 06:00:13 INFO - 2015-11-23 06:00:13,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCzyGwl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:24 INFO - 2015-11-23 06:00:24,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 140177408 06:00:24 INFO - 2015-11-23 06:00:24,823 DEBUG : BROWSER_OUTPUT: 06:00:27 INFO - 2015-11-23 06:00:27,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42652/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:27 INFO - 2015-11-23 06:00:27,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 141688832 06:00:27 INFO - 2015-11-23 06:00:27,961 DEBUG : BROWSER_OUTPUT: 06:00:30 INFO - 2015-11-23 06:00:30,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42652/tests/kraken/driver.html?testName=audio-dft) 06:00:31 INFO - 2015-11-23 06:00:31,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 142049280 06:00:31 INFO - 2015-11-23 06:00:31,220 DEBUG : BROWSER_OUTPUT: 06:00:34 INFO - 2015-11-23 06:00:34,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42652/tests/kraken/driver.html?testName=audio-fft) 06:00:34 INFO - 2015-11-23 06:00:34,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 137068544 06:00:34 INFO - 2015-11-23 06:00:34,647 DEBUG : BROWSER_OUTPUT: 06:00:36 INFO - 2015-11-23 06:00:36,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42652/tests/kraken/driver.html?testName=audio-oscillator) 06:00:37 INFO - 2015-11-23 06:00:37,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 137474048 06:00:37 INFO - 2015-11-23 06:00:37,252 DEBUG : BROWSER_OUTPUT: 06:00:39 INFO - 2015-11-23 06:00:39,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:40 INFO - 2015-11-23 06:00:40,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 137469952 06:00:40 INFO - 2015-11-23 06:00:40,013 DEBUG : BROWSER_OUTPUT: 06:00:43 INFO - 2015-11-23 06:00:43,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42652/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:43 INFO - 2015-11-23 06:00:43,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 138338304 06:00:43 INFO - 2015-11-23 06:00:43,649 DEBUG : BROWSER_OUTPUT: 06:00:47 INFO - 2015-11-23 06:00:47,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42652/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:47 INFO - 2015-11-23 06:00:47,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 139476992 06:00:47 INFO - 2015-11-23 06:00:47,625 DEBUG : BROWSER_OUTPUT: 06:00:50 INFO - 2015-11-23 06:00:50,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42652/tests/kraken/driver.html?testName=json-parse-financial) 06:00:51 INFO - 2015-11-23 06:00:51,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 06:00:51 INFO - 2015-11-23 06:00:51,054 DEBUG : BROWSER_OUTPUT: 06:00:52 INFO - 2015-11-23 06:00:52,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:53 INFO - 2015-11-23 06:00:53,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 06:00:53 INFO - 2015-11-23 06:00:53,196 DEBUG : BROWSER_OUTPUT: 06:00:55 INFO - 2015-11-23 06:00:55,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:55 INFO - 2015-11-23 06:00:55,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 140042240 06:00:55 INFO - 2015-11-23 06:00:55,651 DEBUG : BROWSER_OUTPUT: 06:00:57 INFO - 2015-11-23 06:00:57,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:58 INFO - 2015-11-23 06:00:58,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 06:00:58 INFO - 2015-11-23 06:00:58,290 DEBUG : BROWSER_OUTPUT: 06:01:00 INFO - 2015-11-23 06:01:00,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:01 INFO - 2015-11-23 06:01:01,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 140267520 06:01:01 INFO - 2015-11-23 06:01:01,412 DEBUG : BROWSER_OUTPUT: 06:01:03 INFO - 2015-11-23 06:01:03,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:04 INFO - 2015-11-23 06:01:04,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 06:01:04 INFO - 2015-11-23 06:01:04,583 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42652/tests/kraken/driver.html?testName=ai-astar) 06:01:06 INFO - 2015-11-23 06:01:06,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 06:01:06 INFO - 2015-11-23 06:01:06,517 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,518 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;110;111;111;122;113;111;110;109 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;125;151;167;126;150;156;135;176;126 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;163;162;163;160;161;170;166;163 06:01:06 INFO - 2015-11-23 06:01:06,520 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;73;72;73;72;128;73;72;73 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;134;91;91;90;138;90;90;140 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;111;111;110;110;110 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;148;147;149;146;146;147;149 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;97;96;96;96;96 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;59;63;59;64;60;59;60;57;57 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;70;69;70;70;69;70 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;90;85;86;87;84;84;84;84;85 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;125;122;129;127;123;118;125;131;127 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;153;150;152;149;139;155;156;151;147 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;69;69;67;67;69;67;69 06:01:06 INFO - 2015-11-23 06:01:06,521 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:06 INFO - 2015-11-23 06:01:06,522 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:01:06 INFO - 2015-11-23 06:01:06,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 06:01:06 INFO - 2015-11-23 06:01:06,522 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:01:06 INFO - 2015-11-23 06:01:06,522 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287266518__endTimestamp 06:01:06 INFO - 2015-11-23 06:01:06,522 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,525 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:06 INFO - 2015-11-23 06:01:06,525 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:01:06 INFO - 2015-11-23 06:01:06,525 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.30 (3.9%) stddev-sans-first:4.56 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 110.0 111.0 111.0 122.0 113.0 111.0 110.0 109.0 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.80 Median:153.50 stddev:18.07 (11.8%) stddev-sans-first:18.85 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: Values: 156.0 125.0 151.0 167.0 126.0 150.0 156.0 135.0 176.0 126.0 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 163.0 162.0 163.0 160.0 161.0 170.0 166.0 163.0 06:01:06 INFO - 2015-11-23 06:01:06,526 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.10 Median:73.00 stddev:17.54 (24.0%) stddev-sans-first:18.51 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 72.0 73.0 72.0 128.0 73.0 72.0 73.0 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.00 stddev:22.71 (25.2%) stddev-sans-first:23.47 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 134.0 91.0 91.0 90.0 138.0 90.0 90.0 140.0 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.12 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 148.0 147.0 149.0 146.0 146.0 147.0 149.0 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,527 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.00 stddev:2.28 (3.8%) stddev-sans-first:2.39 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: Values: 61.0 59.0 63.0 59.0 64.0 60.0 59.0 60.0 57.0 57.0 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.71 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 70.0 69.0 70.0 70.0 69.0 70.0 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:1.90 (2.2%) stddev-sans-first:2.01 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: Values: 85.0 90.0 85.0 86.0 87.0 84.0 84.0 84.0 84.0 85.0 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.00 stddev:5.33 (4.2%) stddev-sans-first:3.90 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: Values: 113.0 125.0 122.0 129.0 127.0 123.0 118.0 125.0 131.0 127.0 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,528 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.00 Median:151.50 stddev:6.15 (4.1%) stddev-sans-first:5.07 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: Values: 138.0 153.0 150.0 152.0 149.0 139.0 155.0 156.0 151.0 147.0 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 69.0 69.0 67.0 67.0 69.0 67.0 69.0 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:06 INFO - 2015-11-23 06:01:06,529 DEBUG : BROWSER_OUTPUT: 06:01:07 INFO - 2015-11-23 06:01:07,365 INFO : Browser exited with error code: 0 06:01:07 INFO - 2015-11-23 06:01:07,416 INFO : Completed test kraken (00:00:59) 06:01:07 INFO - 2015-11-23 06:01:07,416 INFO : Starting test v8_7 06:01:07 INFO - 2015-11-23 06:01:07,416 DEBUG : operating with platform_type : linux_ 06:01:07 INFO - 2015-11-23 06:01:07,416 INFO : Initialising browser for v8_7 test... 06:01:07 INFO - 2015-11-23 06:01:07,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4nIUw4/profile http://localhost:42652/getInfo.html 06:01:11 INFO - 2015-11-23 06:01:11,819 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:11 INFO - 2015-11-23 06:01:11,819 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:11 INFO - 2015-11-23 06:01:11,819 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 06:01:11 INFO - 2015-11-23 06:01:11,819 DEBUG : BROWSER_OUTPUT: __metrics 06:01:12 INFO - 2015-11-23 06:01:12,929 INFO : Browser initialized. 06:01:12 INFO - 2015-11-23 06:01:12,930 INFO : Running cycle 1/1 for v8_7 test... 06:01:12 INFO - 2015-11-23 06:01:12,930 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4nIUw4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:24 INFO - 2015-11-23 06:01:24,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 139796480 06:01:24 INFO - 2015-11-23 06:01:24,777 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42652/tests/v8_7/run.html (next: http://localhost:42652/tests/v8_7/run.html) 06:01:46 INFO - 2015-11-23 06:01:46,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 138682368 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: |0;Richards;161.91709844559585 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.60758766047135 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.68794326241135 06:01:46 INFO - 2015-11-23 06:01:46,522 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1070.6638115631692 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |5;Earley;709.2198581560284 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |7;RegExp;27916.666666666668 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |8;Splay;610.718492343934 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287306519__endTimestamp 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:46 INFO - 2015-11-23 06:01:46,523 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:161.92 Median:161.92 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: Values: 161.9 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: Values: 191.6 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.69 Median:283.69 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: Values: 283.7 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: Values: 5060.6 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,525 DEBUG : BROWSER_OUTPUT: Values: 1070.7 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: Values: 709.2 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: Values: 12256.1 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27916.67 Median:27916.67 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: Values: 27916.7 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.72 Median:610.72 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: Values: 610.7 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: Values: 4850.2 06:01:46 INFO - 2015-11-23 06:01:46,526 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:46 INFO - 2015-11-23 06:01:46,527 DEBUG : BROWSER_OUTPUT: 06:01:47 INFO - 2015-11-23 06:01:47,422 INFO : Browser exited with error code: 0 06:01:47 INFO - 2015-11-23 06:01:47,440 INFO : Completed test v8_7 (00:00:40) 06:01:47 INFO - 2015-11-23 06:01:47,499 INFO : Completed test suite (00:20:12) 06:01:47 INFO - 2015-11-23 06:01:47,499 DEBUG : Working with test: dromaeo_css 06:01:47 INFO - 2015-11-23 06:01:47,499 DEBUG : Generating results file: dromaeo_css 06:01:47 INFO - 2015-11-23 06:01:47,500 DEBUG : Working with test: kraken 06:01:47 INFO - 2015-11-23 06:01:47,500 DEBUG : Generating results file: kraken 06:01:47 INFO - 2015-11-23 06:01:47,500 INFO : javascript benchmark 06:01:47 INFO - 2015-11-23 06:01:47,501 DEBUG : Working with test: v8_7 06:01:47 INFO - 2015-11-23 06:01:47,501 DEBUG : Generating results file: v8_7 06:01:47 INFO - 2015-11-23 06:01:47,501 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:47 INFO - 2015-11-23 06:01:47,557 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:01:47 INFO - 2015-11-23 06:01:47,557 DEBUG : process_Request line: dromaeo_css 7134.31 graph.html#tests=[[72,1,43]] 06:01:47 INFO - 2015-11-23 06:01:47,557 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:47 INFO - 2015-11-23 06:01:47,591 DEBUG : process_Request line: kraken 1513.10 graph.html#tests=[[232,1,43]] 06:01:47 INFO - 2015-11-23 06:01:47,591 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:47 INFO - 2015-11-23 06:01:47,619 DEBUG : process_Request line: v8_7 21186.10 graph.html#tests=[[230,1,43]] 06:01:47 INFO - 2015-11-23 06:01:47,621 INFO : javascript benchmark 06:01:47 INFO - 2015-11-23 06:01:47,624 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3221.355728854229, 3243.367543329052, 3259.266665000374, 3292.835358232088, 3301.6698330166987, 5369.194620806881, 5459.017376872166, 5465.508104270615, 5468.726563671816, 5517.69652669103, 5411.269478620385, 5468.9726551367285, 5513.669179849202, 5522.530584900288, 5596.804111856086, 4971.925421118686, 5066.113430149728, 5115.488451154892, 5122.8207012754565, 5131.076406246874, 5066.392032956032, 5085.3389059422225, 5109.514596113363, 5152.304438900738, 5165.431802501722, 4928.408590969071, 5015.5987520998415, 5017.297578339036, 5022.347094877679, 5064.11378008847, 4964.851054468371, 5014.749262536859, 5035.59715222785, 5047.64666473347, 5058.317127187819, 4982.725950072744, 4984.651074424792, 4990.051890140898, 5047.167217409123, 5053.469385714484, 5007.098722229997, 5182.766775495112, 5278.1818818082875, 5282.630215884889, 5343.797645529725, 5781.913271300934, 5830.883382332329, 5834.708264586796, 5852.12218167274, 5889.528837692974, 5913.7930172444185, 5922.97038514809, 5927.170196172539, 5935.762569497215, 5945.137954996501, 5385.515303622654, 5462.672239665632, 5464.890702185974, 5550.111982082888, 5613.943860561424, 5829.825105246765, 5859.414058594191, 5884.676342801187, 5903.645781253139, 5906.586538942232, 5738.196652468658, 5738.225339579187, 5743.1385292206505, 5784.0, 5837.211976383219, 6024.909626355608, 6055.364186760415, 6089.817305480843, 6090.756369745161, 6110.205673262448, 6048.4858787003595, 6062.090686396988, 6070.453659170696, 6074.757009719562, 6080.270367555833, 5770.971145144247, 5871.55963302754, 5959.523238140939, 6017.488513476404, 6102.938970610237, 4626.629869610423, 4630.467496237976, 4648.302754586839, 4650.9767451162525, 4652.674312798139, 4102.938455923164, 4107.8973025674, 4123.628873401348, 4131.793410329532, 4148.896277593084, 5446.863828404322, 5544.722763861791, 5565.41563135873, 5733.483986441241, 5742.885142297131, 5942.524598032147, 5961.791337303173, 5983.19226904371, 5996.370381110008, 5998.1602575639445, 5631.267935168402, 5688.800891968761, 5690.459406356389, 5692.0, 5692.288463942007, 5041.117804384218, 5117.795288188505, 5139.331886854759, 5175.948240517547, 5214.765335559909, 6037.124616930609, 6091.695415229221, 6102.084687296852, 6103.816885493442, 6121.326654068049, 5868.589198756046, 5919.4968427684125, 5922.555808314308, 5924.31870334917, 5945.3757355477055, 5999.070144127667, 6002.459778619946, 6070.3929607038945, 6127.84680382994, 6160.845978850564, 5859.296884373903, 5895.145203945318, 5900.557458190567, 5909.409059094056, 5988.700564971647, 5708.400617935057, 5859.384764599656, 5932.317783454958, 6002.279726432856, 6006.819795406145, 5730.0, 5737.053386191232, 5739.942600573941, 5803.970980145241, 5859.414058594107, 5778.537716982715, 5802.361740208489, 5813.244278243801, 5819.941800582109, 5829.067349224104, 5588.022096133079, 5697.487226149667, 5718.542516598579, 5719.370869204301, 5722.799702010409, 5775.220345253337, 5789.9710501447225, 5875.529957603296, 5897.144913987534, 5973.253343332083, 5713.1715901193265, 5713.514351280188, 5747.971260143672, 5770.192173095686, 5789.2763404574425], "unit": "ms", "name": "dojo.html", "value": 5463.831443723807}, {"lowerIsBetter": false, "replicates": [576.1271673414776, 585.6720236667468, 586.1647152807251, 593.3769541980919, 621.3258614403372, 39416.0, 40187.196256074894, 40460.0, 40481.0, 40485.59514404855, 40582.18835623286, 41137.382939255935, 41390.58609413905, 41615.79192104043, 41705.37441938366, 8670.696525621588, 8794.912050879506, 8854.07032261613, 8864.955675221614, 8871.024187339388, 8358.665653373857, 8361.205685459872, 8368.414211005233, 8370.162983701612, 8410.074891761902, 8582.485050896936, 8585.270252028586, 8681.30549556034, 8684.56577171142, 8697.304215662733, 8617.741467755946, 8667.653293868238, 8682.088380720028, 8685.218330350268, 8687.47875127488, 8501.06488286288, 8513.872291915626, 8515.318774498026, 8599.785005374915, 8654.0, 38611.613883861086, 39445.80277098625, 39520.802395988125, 39575.0, 39660.60339396598, 3189.234583699895, 3281.0976981330086, 3359.4624860022277, 3598.429524153733, 3974.880753577397, 30620.0, 30823.69176308253, 31454.0, 31659.20851978696, 32361.51457728136, 3790.166163444038, 3860.3823388257742, 3886.2227554489214, 3928.0572662561067, 4026.295398305314, 266689.0, 267652.0, 268313.0, 269281.0, 269478.0, 52579.999999999236, 53995.46004539983, 59769.91955683729, 60056.0, 60273.69863150656, 67764.6611766938, 68071.3192868065, 68324.31675683279, 68493.65753171203, 68815.0, 15596.532104036896, 15729.370825167094, 15777.68444631101, 15794.289256983464, 15799.0, 11989.64031079069, 12001.39993000364, 12063.21589096706, 12104.939475302743, 12117.515299388102, 20306.492337691678, 20653.58692826135, 20851.374458766262, 20873.060712267983, 20883.164673413197, 8140.83718325642, 8372.665093396317, 8437.0, 8508.446950948168, 8514.191151840565, 857.2295177338093, 947.8483442649281, 950.9144177024101, 968.5351031504918, 1051.4059556350637, 28276.43447131046, 28720.85639571789, 28725.0, 28855.711442885302, 28970.27574310617, 998.8651532043226, 1016.9288149829441, 1038.7506998320348, 1085.4247248958065, 1139.3847322445952, 15200.315985780666, 16477.0, 16767.245473953702, 16769.0, 16958.0, 395179.0, 400363.0, 400995.0, 401044.0, 401447.0, 55024.72487637616, 55564.72217638967, 55914.0, 56033.71983140058, 56316.71841640765, 1298.9350532473338, 1299.3568183749105, 1308.653206900172, 1374.8900087992936, 1378.3797291218991, 28676.569851452663, 29265.268368290963, 29585.408291834472, 29681.406371872872, 29709.0, 47388.2891756617, 47938.0, 48062.519374807205, 48183.27725084056, 48219.27671085007, 308460.0, 308965.0, 309621.0, 310319.0, 310837.0, 33009.83495082509, 45506.77246613746, 46149.30776038429, 46560.53439465562, 46795.532044679116, 44118.0, 44220.0, 44783.0, 44933.42733004329, 45002.54997449984, 37047.444288336235, 38100.0, 38253.2349353017, 38878.0, 39009.2198156041, 35884.0, 36782.81608592047, 36907.26185476222, 37367.6263237375, 37425.6257437433, 36671.0, 36740.44889326609, 36933.63066369302, 37448.0, 37591.0, 31962.36075278435, 32764.18089547685, 33259.788488331586, 33361.0, 33405.66594334123, 26329.868350658126, 26376.0, 26519.0, 26795.732042679323, 26815.865920670272], "unit": "ms", "name": "ext.html", "value": 19169.143113632632}, {"lowerIsBetter": false, "replicates": [349.67480243373655, 352.84651176738134, 360.2614639988024, 367.1903452886386, 368.49516162856884, 16544.420945266902, 16765.580860478494, 17454.77816552842, 17570.03364814936, 18118.27526898926, 11535.134864885145, 11619.767604647903, 11673.066154707623, 12164.452599633016, 17301.13494325285, 4966.652334336589, 5098.107831129556, 5141.974290128544, 5279.762410691528, 5293.52358287754, 4619.468761092484, 5149.536541711245, 5224.059669259532, 5241.842744717665, 5267.26258323835, 5107.540321371076, 5141.82003629873, 5165.3026841376495, 5251.632385733, 5266.157414813631, 5153.2785410042625, 5260.763265653055, 5282.867928301785, 5288.788448462057, 5567.526760225385, 5270.209468579706, 5377.4084850666395, 5385.892282154374, 5392.460753924615, 5395.190721391783, 12461.06542009353, 13515.797263040964, 17779.644407111915, 19813.207471701116, 19904.402867913985, 1932.0726051495221, 2072.512959454527, 2091.173986275428, 2127.2022991378235, 2141.175647375756, 9245.260379169651, 9376.578053987587, 9387.62449502019, 9429.66996155138, 9507.714768556954, 1790.588164722108, 1835.9449216523392, 1842.5854182808894, 1843.3087592152942, 1885.8774179678278, 61017.6949115256, 65095.34904650987, 66072.3392766071, 66377.0, 66825.33174668289, 10455.320404173704, 10561.471926403648, 10575.947120264349, 10591.682249532527, 10612.734681632866, 13748.587542373745, 13808.723825523433, 13817.861821381859, 13842.792358114637, 13897.79153312701, 7887.9605601971625, 7990.560519171501, 8025.598720063974, 8071.07182674, 8076.676932922617, 7848.13670496245, 7863.174366691529, 7894.565798881116, 7903.170167132368, 7932.762017139379, 4443.533428989974, 4470.949326908174, 4490.146872094357, 4573.588377046081, 4581.770911454414, 1864.4313484387392, 1879.3422302194122, 1900.6293772714464, 1923.4614307993784, 1927.759030121235, 832.7002279179491, 881.5680316644927, 912.4570880326195, 986.033686986757, 997.486294558303, 15571.221438928009, 16660.75008874868, 16995.0, 17233.482995510156, 17324.393646222576, 894.4141587260355, 928.382625553999, 949.8100379924043, 960.4381436859376, 1001.1540248490014, 9008.306594296308, 9583.520823958774, 9630.47032413224, 9687.273454490942, 9720.90279097214, 405211.0, 411701.0, 412175.0, 568717.0, 574005.0, 76276.61861690767, 79865.60067199628, 79896.60051699704, 81538.59230703808, 81578.59210703909, 1156.6183159557327, 1163.755611321615, 1192.928424294545, 1198.3648666206925, 1225.154643296123, 15124.319405626993, 15274.541763747106, 15465.304061317493, 15591.14248716286, 15900.443484477988, 20173.03734489575, 31723.682763172073, 32060.358792823547, 33219.833900830345, 35948.28103437864, 43998.78000610104, 45779.31331030104, 46356.53643463657, 46627.53372466368, 46746.0, 9563.09150630689, 9779.070988256104, 9807.06832850878, 10203.132733717717, 10208.897911021091, 17488.912555437142, 17492.562685932953, 17764.0, 17846.732299015264, 18098.27606895762, 13036.869631303945, 13515.59453216405, 13771.517996870061, 14120.717585648024, 14740.189289589176, 13558.593242202749, 14062.507812226522, 14290.928545357207, 14501.564953051426, 14629.92685036568, 14107.083039602803, 14270.072445291024, 14348.784768228694, 14565.417383304974, 15064.849351506344, 9003.234725048182, 9268.285367207089, 9551.379160354554, 9554.952225238829, 9562.18721408688, 13912.930435347758, 14270.305573147183, 14305.356258968579, 14311.355988980313, 14397.352119154453], "unit": "ms", "name": "jquery.html", "value": 8766.879659806535}, {"lowerIsBetter": false, "replicates": [1467.5083846911282, 1470.6838029823587, 1630.4212004738317, 1769.4072485717284, 1787.410154648966, 6546.18172728409, 6610.10763546921, 7401.62991850408, 7591.0890693116835, 7600.695972161114, 7176.354128128467, 7425.851482970337, 7437.925620743791, 7482.5510469371875, 7487.73792917248, 2278.3392816083315, 2303.5047464795066, 2317.0, 2324.5118525109665, 2325.511642555057, 2251.133313674231, 2275.84069115162, 2301.5051763870765, 2302.792748652621, 2303.285981345788, 2241.081156725743, 2260.7739226077424, 2293.5183611441535, 2296.6095763720123, 2304.850184737995, 2240.2159244264376, 2276.5333106713165, 2298.793108620232, 2300.1144559344607, 2308.5613733390687, 2326.7673232676766, 2345.3315804995495, 2346.9647955280684, 2351.9529609407714, 2357.4577847095265, 7450.0, 7505.1369092554505, 7534.321911028033, 7535.73624923125, 7556.65995030225, 4590.196715574761, 4628.652851036152, 4661.813527458898, 4664.043871006435, 4678.111158879802, 3021.456137895178, 3039.9088027359217, 3100.7364374028234, 3101.3797240551753, 3128.9530657040164, 983.9963237497712, 992.717075633441, 1829.3780114761046, 1838.5771272607242, 1853.9165737541844, 10126.189904807597, 10187.388756674549, 10203.285769996104, 10209.0, 10210.540525676288, 4167.437395951508, 4206.326987681956, 4231.746095234295, 4251.149770046003, 4257.489101307801, 8368.456050356708, 8388.07731149573, 8434.957825210835, 8449.704260350982, 8451.197136272045, 4702.741349225757, 4706.411698537683, 4710.29345598163, 4714.834980775657, 4731.905361892743, 4166.895827604273, 4254.234237837219, 4278.2085314216965, 4331.220380331571, 4360.542143074995, 3560.2701446203464, 3573.0, 3585.2650206707563, 3620.4750311205253, 3626.202235508184, 1115.1970581181536, 1119.339589642115, 1121.0975164992096, 1125.5947858770835, 1131.536070211226, 1290.7676618208814, 1297.9805302920463, 1308.9018323625767, 1316.3681432912065, 1324.2716505921705, 7062.71749130029, 7125.144982602121, 7192.172900116449, 7192.676329565182, 7194.244604316471, 473.2782506677276, 480.0734582256209, 483.5672073494203, 484.74550860798365, 486.2293265174738, 5502.422245664227, 5517.668939863541, 5528.75120619573, 5544.69504177266, 5548.306461692288, 8669.306455483546, 8786.297096232414, 8998.100189980949, 9082.046385129599, 9120.8631870522, 8854.86717699235, 8903.332250081141, 8972.775680608038, 9013.414128081653, 9043.140901614335, 6709.966450167815, 6829.9072148457, 6884.277150899184, 7041.0, 7077.787666370017, 7035.401990830836, 7035.718571257297, 7041.647917604202, 7077.186123595852, 7109.60897150641, 7769.689212431439, 7790.298873101448, 7868.527888326718, 7905.604719764104, 7934.722284720007, 8003.279704826594, 8061.516309021477, 8093.757187284391, 8111.269985701315, 8241.217084376975, 6640.867182656223, 6660.500462465431, 6935.791926242221, 7199.748008819666, 7211.1707153678, 6963.2340442552295, 7148.714051437884, 7201.567905925661, 7210.783676489714, 7218.3503484686635, 6730.158730158731, 6841.213260475109, 6901.792946211622, 7027.227005029545, 7084.114485689289, 6824.692888819915, 6863.073485079451, 6914.0, 6918.757843475454, 6994.0, 6771.356721111487, 6864.073350097673, 6864.279250678607, 6900.068490753884, 6918.757843475454, 6406.839829004312, 6426.518011149276, 6454.096426500199, 6456.322086180883, 6467.191601049869, 6424.164858568356, 6531.934680653323, 6563.803085907431, 6571.835704107436, 6574.737010519717], "unit": "ms", "name": "mootools.html", "value": 4367.380665239988}, {"lowerIsBetter": false, "replicates": [334.8861387128376, 340.1496259351621, 347.9182392137847, 350.18407111430355, 358.5410674336849, 6312.621242725434, 6318.0838778377165, 6352.6188428694195, 6375.330590288023, 6518.51111166662, 6301.968490157543, 6339.302676705559, 6341.968290158543, 6370.745170193187, 6376.553641245115, 4765.714057156564, 4777.259524773665, 4778.761061946906, 4783.928241076386, 4786.090642777878, 4746.050789842028, 4752.738599377033, 4761.619070474371, 4788.305695674125, 4790.496997815231, 4671.48613652498, 4771.045790841828, 4794.856154315358, 4797.784099715521, 4813.975930120345, 4780.139574876521, 4781.7370044647705, 4783.569478746895, 4790.640701947351, 4796.784144713496, 4118.464599602033, 4137.834486620562, 4144.461220041375, 4146.647534959532, 4147.97926010368, 6013.278406591194, 6013.278406591237, 6018.8495287617725, 6020.0, 6021.939780602225, 5440.809571664972, 5559.277293951801, 5561.721913904288, 5565.165225216209, 5573.804916827932, 6681.164854393201, 6705.463562914955, 6726.630035348054, 6727.125473688389, 6728.730850765964, 4562.840300589497, 4592.058627981256, 4594.701344412602, 4601.0, 4601.28680054592, 6735.259121496631, 6892.207396149457, 6918.37734603883, 6920.515563910529, 6990.335918087773, 4645.605123564467, 4678.345031695565, 4695.835645752451, 4703.670743048022, 4723.929141062887, 4740.928886066712, 4780.067886762048, 4781.95218047822, 4783.7129772213775, 4785.377900872864, 5534.667919924736, 5556.722163891789, 5559.638623489541, 5559.861003474945, 5561.555075593943, 6590.967045164839, 6709.731610735614, 6714.362135597111, 6731.629760363129, 6740.966295168493, 1650.6946214950271, 1655.106242628991, 1685.637587918579, 1689.4424839802837, 1692.2131208987635, 1116.9221701058518, 1119.2780656476689, 1125.2404626876826, 1135.4493070860626, 1140.5779861451317, 6443.0335449682925, 6477.255115661665, 6481.351864813481, 6483.254425741005, 6483.610983341015, 6855.348741869514, 6874.312568743186, 6875.621840798704, 6887.827804304932, 6889.207741109736, 6401.423871851555, 6412.935870641327, 6434.581752186093, 6438.227412710505, 6469.805905822833, 3799.2971300308977, 3818.503594532693, 3820.617938206213, 3825.5791862895057, 3829.6744776693736, 7305.305995930378, 7306.342429181399, 7320.633968301564, 7342.192358840523, 7369.852602947911, 7094.077769889881, 7127.358537731629, 7239.131304243419, 7243.275672432715, 7258.056452661226, 7250.129984401906, 7301.853962920712, 7322.121345438475, 7328.0, 7337.926620733831, 7042.330978557029, 7049.436045116481, 7052.929470705228, 7056.15326160864, 7056.188538318159, 6774.424173945073, 6896.172459304916, 6913.827154321182, 6934.306569343025, 6936.549124306904, 7297.233790452138, 7303.123625165014, 7329.52358096722, 7331.890021649786, 7337.779866603797, 4673.252279635242, 4733.408323959505, 4734.455537613081, 4741.241401375902, 4742.691725037862, 6839.93160068393, 6909.861802763816, 6972.337627925339, 7050.189228238613, 7057.541259818096, 6743.1908171019795, 6760.594364338155, 6787.151606049244, 6791.89812152828, 6830.009648600826, 6778.966105169443, 6780.423663988419, 6792.76225332111, 6796.184457865088, 6814.1482314710665, 6516.674166291572, 6646.634435106115, 6657.567258128206, 6662.100616416722, 6663.833404164935, 6814.250432452525, 6829.3950921532405, 6854.0404343390965, 6861.039454476278, 6866.725330986705, 6566.9343306566325, 6592.945128779564, 6617.139771829631, 6629.867402651824, 6631.734730610721], "unit": "ms", "name": "prototype.html", "value": 5063.662275169479}, {"lowerIsBetter": false, "replicates": [819.2667562531534, 831.3100126894676, 843.4348986179259, 853.2661910756748, 881.8677198420232, 14478.203698796575, 14516.5645030649, 14596.051256668308, 14687.485937992173, 14841.703165936675, 13593.980451466156, 13644.931775341134, 13717.794233086512, 13737.862621373783, 13744.381502832372, 681.8874885643863, 689.3692271571531, 823.1768231768217, 825.6160885188386, 836.7196989008689, 836.4981011393146, 841.3773807382554, 842.8567143585606, 843.5950743643054, 845.0197770586121, 879.6305551668282, 880.2210044110976, 887.973360799177, 887.9866801997975, 890.6170346750895, 870.851955167623, 874.0865795243985, 875.4003507597284, 878.5738916625431, 880.4805164952709, 642.2453617000007, 643.983900402489, 647.9967600162016, 648.6205569741707, 649.4933951517824, 12621.558245461365, 12672.049596280316, 12680.619581412573, 12740.36298185087, 12740.936295318557, 12124.878751212551, 12230.694232644166, 12800.48798048077, 13103.47586096555, 13148.211107333591, 10379.169666426667, 10482.895171048345, 10519.684409467729, 10572.15422766177, 10600.416977066257, 3687.797171155585, 3688.6495782900583, 3720.4233343831747, 3725.1990821973404, 3859.5754467008605, 47707.0, 47909.52090479086, 48001.75999120017, 48103.0, 48364.03271934577, 10200.744981375377, 10204.693859184088, 10206.591736330463, 10274.280800343904, 10380.377177369382, 19033.048347582844, 19073.0, 19091.522711932314, 19129.0, 19143.138558764887, 7655.1962043985695, 7739.651715672809, 7762.7671169865, 7797.9220207798335, 7910.406719496061, 4291.635211007099, 4303.913921721611, 4356.215881141425, 4366.825326986948, 4394.187075390999, 3111.595492585949, 3145.308032232905, 3157.6526582075953, 3167.493201087861, 3172.9206769830475, 556.5825630776917, 572.390404219505, 572.5562688916124, 580.8199458167982, 582.9417058294136, 545.5526468296039, 555.1811078658945, 643.6459947029115, 660.4020741370597, 687.1547995964991, 8596.785080372916, 9135.588898499584, 9612.663556775618, 9623.0, 9699.563519641633, 558.4666643355586, 578.2194038048601, 643.723199024424, 654.1300070905684, 735.8822588385833, 4064.4309796628495, 4314.80583373749, 4337.9783101084295, 4347.108842687241, 4398.406215160912, 59733.70133149307, 59801.70099149476, 60182.0, 60196.0, 60229.39770602326, 50499.0, 52530.0, 53047.20429193565, 53192.46807531953, 53463.0, 47225.29162062572, 47736.28395574069, 48858.762484628736, 49199.0, 53084.469155308725, 9300.906990930003, 9414.576344064397, 9485.762855928657, 9548.85676714836, 9579.712608621752, 33940.49089263614, 34560.13599659928, 34989.30021399609, 36518.26963460663, 37179.814100929325, 44444.33333500065, 44737.55262447334, 45410.0, 45623.31565026593, 46268.0, 11067.612633557786, 11451.083913287084, 11728.41357932083, 11860.406979651156, 12189.451474683838, 11479.0, 11734.589289374831, 12727.490900363882, 12730.427130779322, 13141.34293285351, 10578.365298082139, 10615.840762388725, 10624.096951759188, 10739.301945373525, 11068.114550836075, 11902.345371004678, 12270.754584908073, 12432.875671243171, 12816.487340506275, 12828.615141545768, 11438.313701177956, 11835.11236657237, 11906.404679765803, 12077.154599177973, 12409.565665201675, 9991.900080999389, 10306.948465257627, 10543.736406589896, 10883.346999180074, 11004.779904402027, 9188.402753821249, 9395.85906211421, 9607.423554586747, 10343.534540945526, 10385.63650272237], "unit": "ms", "name": "yui.html", "value": 6492.969704771192}], "name": "dromaeo_css", "value": 7134.312340972791}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 111.0, 111.0, 122.0, 113.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [156.0, 125.0, 151.0, 167.0, 126.0, 150.0, 156.0, 135.0, 176.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 162.0, 163.0, 160.0, 161.0, 170.0, 166.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 72.0, 73.0, 72.0, 128.0, 73.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.1}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 134.0, 91.0, 91.0, 90.0, 138.0, 90.0, 90.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 104.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 149.0, 146.0, 146.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 63.0, 59.0, 64.0, 60.0, 59.0, 60.0, 57.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 70.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 85.0, 86.0, 87.0, 84.0, 84.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [113.0, 125.0, 122.0, 129.0, 127.0, 123.0, 118.0, 125.0, 131.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [138.0, 153.0, 150.0, 152.0, 149.0, 139.0, 155.0, 156.0, 151.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 69.0, 69.0, 67.0, 67.0, 69.0, 67.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1513.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [161.91709844559585], "unit": "score", "name": "Richards", "value": 218.02515199999996}, {"lowerIsBetter": false, "replicates": [191.60758766047135], "unit": "score", "name": "DeltaBlue", "value": 345.06984200000005}, {"lowerIsBetter": false, "replicates": [283.68794326241135], "unit": "score", "name": "Encrypt", "value": 938.2880249999996}, {"lowerIsBetter": false, "replicates": [5060.606060606061], "unit": "score", "name": "Decrypt", "value": 52.59864071856286}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [27916.666666666668], "unit": "score", "name": "RegExp", "value": 32.63229850746267}, {"lowerIsBetter": false, "replicates": [610.718492343934], "unit": "score", "name": "Splay", "value": 133.43463645130188}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21186.0984249359}]} 06:01:47 INFO - RETURN: dromaeo_css: 7134.31 06:01:47 INFO - RETURN: kraken: 1513.10 06:01:47 INFO - RETURN: v8_7: 21186.10 06:01:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21186.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1513.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7134.31"}}} 06:01:47 INFO - Return code: 0 06:01:47 INFO - # TBPL SUCCESS # 06:01:47 INFO - Running post-action listener: _resource_record_post_action 06:01:47 INFO - Running post-run listener: _resource_record_post_run 06:01:48 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 24576; Write bytes: 508862464; Read time: 264; Write time: 580108 06:01:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 57307136; Read time: 0; Write time: 52312 06:01:48 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 374722560; Read time: 264; Write time: 425492 06:01:48 INFO - Running post-run listener: _upload_blobber_files 06:01:48 INFO - Blob upload gear active. 06:01:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:01:48 INFO - Copying logs to upload dir... 06:01:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.247503 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 06:01:48.124768) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:48.128594) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010003 build_url: 'https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/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-23 06:01:48.179953) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:48.180410) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a732b360c9c0c9a4a8cfc42c000001d9-1448282637.75230-1915772269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:48.230000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:01:48.230323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:01:48.230600) ========= ========= Total master_lag: 0.28 =========