builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1447939955.71 results: success (0) buildid: 20151119030404 builduid: 501e3dd1b6c343c983c59c1c7961f024 revision: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.707550) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.707969) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.708723) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006622 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.752861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.753192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.795018) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.795326) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.844539) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.844811) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.845154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:35.845455) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 05:32:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-19 05:32:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.382945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.240638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.241012) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.290557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.290913) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --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 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 05:32:36,626 truncating revision to first 12 chars 2015-11-19 05:32:36,626 Setting DEBUG logging. 2015-11-19 05:32:36,626 attempt 1/10 2015-11-19 05:32:36,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d6155d7e6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 05:32:36,880 unpacking tar archive at: mozilla-central-1d6155d7e6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.597585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.900795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.901103) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.910365) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.910639) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 05:32:36.911031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-11-19 05:32:36.911339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:32:37 INFO - MultiFileLogger online at 20151119 05:32:37 in /builds/slave/test-pgo 05:32:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:32:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:32:37 INFO - {'append_to_log': False, 05:32:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:32:37 INFO - 'blob_upload_branch': 'Firefox', 05:32:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:32:37 INFO - 'branch': 'Firefox', 05:32:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:37 INFO - 'config_files': ('talos/linux_config.py',), 05:32:37 INFO - 'default_actions': ('clobber', 05:32:37 INFO - 'read-buildbot-config', 05:32:37 INFO - 'download-and-extract', 05:32:37 INFO - 'populate-webroot', 05:32:37 INFO - 'create-virtualenv', 05:32:37 INFO - 'install', 05:32:37 INFO - 'run-tests'), 05:32:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:37 INFO - 'download_minidump_stackwalk': True, 05:32:37 INFO - 'download_symbols': 'ondemand', 05:32:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:37 INFO - 'installer_path': 'installer.exe', 05:32:37 INFO - 'log_level': 'info', 05:32:37 INFO - 'log_name': 'talos', 05:32:37 INFO - 'log_to_console': True, 05:32:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:32:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:32:37 INFO - 'opt_config_files': (), 05:32:37 INFO - 'pip_index': False, 05:32:37 INFO - 'sps_profile': False, 05:32:37 INFO - 'sps_profile_interval': 0, 05:32:37 INFO - 'suite': 'dromaeojs', 05:32:37 INFO - 'system_bits': '64', 05:32:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:37 INFO - 'title': 'talos-linux64-ix-042', 05:32:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:37 INFO - 'use_talos_json': True, 05:32:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:32:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:37 INFO - 'work_dir': 'build'} 05:32:37 INFO - ##### 05:32:37 INFO - ##### Running clobber step. 05:32:37 INFO - ##### 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: clobber 05:32:37 INFO - rmtree: /builds/slave/test-pgo/build 05:32:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:32:37 INFO - Running post-action listener: _resource_record_post_action 05:32:37 INFO - ##### 05:32:37 INFO - ##### Running read-buildbot-config step. 05:32:37 INFO - ##### 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: read_buildbot_config 05:32:37 INFO - Using buildbot properties: 05:32:37 INFO - { 05:32:37 INFO - "properties": { 05:32:37 INFO - "buildnumber": 566, 05:32:37 INFO - "product": "firefox", 05:32:37 INFO - "script_repo_revision": "production", 05:32:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:32:37 INFO - "repository": "", 05:32:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:32:37 INFO - "buildid": "20151119030404", 05:32:37 INFO - "slavename": "talos-linux64-ix-042", 05:32:37 INFO - "stage_platform": "linux64-pgo", 05:32:37 INFO - "basedir": "/builds/slave/test-pgo", 05:32:37 INFO - "nightly_build": "True", 05:32:37 INFO - "project": "", 05:32:37 INFO - "platform": "ubuntu64_hw", 05:32:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:32:37 INFO - "slavebuilddir": "test", 05:32:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:32:37 INFO - "branch": "mozilla-central", 05:32:37 INFO - "repo_path": "mozilla-central", 05:32:37 INFO - "pgo_build": "True", 05:32:37 INFO - "builduid": "501e3dd1b6c343c983c59c1c7961f024", 05:32:37 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 05:32:37 INFO - }, 05:32:37 INFO - "sourcestamp": { 05:32:37 INFO - "repository": "", 05:32:37 INFO - "hasPatch": false, 05:32:37 INFO - "project": "", 05:32:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:32:37 INFO - "changes": [ 05:32:37 INFO - { 05:32:37 INFO - "category": null, 05:32:37 INFO - "files": [ 05:32:37 INFO - { 05:32:37 INFO - "url": null, 05:32:37 INFO - "name": "https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:32:37 INFO - } 05:32:37 INFO - ], 05:32:37 INFO - "repository": "", 05:32:37 INFO - "rev": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d", 05:32:37 INFO - "who": "sendchange", 05:32:37 INFO - "when": 1447939915, 05:32:37 INFO - "number": 6682425, 05:32:37 INFO - "comments": "", 05:32:37 INFO - "project": "", 05:32:37 INFO - "at": "Thu 19 Nov 2015 05:31:55", 05:32:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:32:37 INFO - "revlink": "", 05:32:37 INFO - "properties": [ 05:32:37 INFO - [ 05:32:37 INFO - "buildid", 05:32:37 INFO - "20151119030404", 05:32:37 INFO - "Change" 05:32:37 INFO - ], 05:32:37 INFO - [ 05:32:37 INFO - "builduid", 05:32:37 INFO - "501e3dd1b6c343c983c59c1c7961f024", 05:32:37 INFO - "Change" 05:32:37 INFO - ], 05:32:37 INFO - [ 05:32:37 INFO - "nightly_build", 05:32:37 INFO - "True", 05:32:37 INFO - "Change" 05:32:37 INFO - ], 05:32:37 INFO - [ 05:32:37 INFO - "pgo_build", 05:32:37 INFO - "True", 05:32:37 INFO - "Change" 05:32:37 INFO - ] 05:32:37 INFO - ], 05:32:37 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 05:32:37 INFO - } 05:32:37 INFO - ], 05:32:37 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 05:32:37 INFO - } 05:32:37 INFO - } 05:32:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:32:37 INFO - Running post-action listener: _resource_record_post_action 05:32:37 INFO - ##### 05:32:37 INFO - ##### Running download-and-extract step. 05:32:37 INFO - ##### 05:32:37 INFO - Running pre-action listener: _resource_record_pre_action 05:32:37 INFO - Running main action method: download_and_extract 05:32:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:37 INFO - https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/test_packages.json 05:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/test_packages.json 05:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:32:50 INFO - Downloaded 1302 bytes. 05:32:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:32:50 INFO - Using the following test package requirements: 05:32:50 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:50 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:32:50 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'jsshell-linux-x86_64.zip'], 05:32:50 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:32:50 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:50 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:32:50 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:32:50 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:32:50 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:32:50 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:32:50 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:32:50 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:32: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:32:50 INFO - https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:32:51 INFO - Downloaded 22461635 bytes. 05:32:51 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:32:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:32:51 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:32:52 INFO - Return code: 0 05:32:52 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:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:52 INFO - https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:33:19 INFO - Downloaded 22461635 bytes. 05:33:19 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:33:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:33:19 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:33:20 INFO - Return code: 0 05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:20 INFO - https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:33:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:33:29 INFO - Downloaded 11130997 bytes. 05:33:29 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:33:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:33:29 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:33:29 INFO - Return code: 0 05:33:29 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:33:29 INFO - https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:33:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:33:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:33:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4BCKR2TQICXWQQunOtFDQ/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:33:30 INFO - Downloaded 57200719 bytes. 05:33:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:33:30 INFO - mkdir: /builds/slave/test-pgo/properties 05:33:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:33:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:33:30 INFO - Contents: 05:33:30 INFO - build_url:https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:33:30 INFO - Running post-action listener: _resource_record_post_action 05:33:30 INFO - Running post-action listener: set_extra_try_arguments 05:33:30 INFO - ##### 05:33:30 INFO - ##### Running populate-webroot step. 05:33:30 INFO - ##### 05:33:30 INFO - Running pre-action listener: _resource_record_pre_action 05:33:30 INFO - Running main action method: populate_webroot 05:33:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:30 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:33:30 INFO - '../fennec_ids.txt'], 05:33:30 INFO - 'tests': ['tcheck2']}, 05:33:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:30 INFO - '--tppagecycles', 05:33:30 INFO - '7'], 05:33:30 INFO - 'tests': ['tsvgm']}}, 05:33:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:33:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:33:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'tests': ['damp', 'tps']}, 05:33:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['damp', 'tps']}, 05:33:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:33:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:30 INFO - 'other': {'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'other_l64': {'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'other_nol64': {'tests': ['a11yr', 05:33:30 INFO - 'ts_paint', 05:33:30 INFO - 'tpaint', 05:33:30 INFO - 'sessionrestore', 05:33:30 INFO - 'sessionrestore_no_auto_restore']}, 05:33:30 INFO - 'svgr': {'tests': ['tsvgx', 05:33:30 INFO - 'tsvgr_opacity', 05:33:30 INFO - 'tart', 05:33:30 INFO - 'tscrollx', 05:33:30 INFO - 'cart']}, 05:33:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['tsvgx', 05:33:30 INFO - 'tsvgr_opacity', 05:33:30 INFO - 'tart', 05:33:30 INFO - 'tscrollx', 05:33:30 INFO - 'cart']}, 05:33:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'tests': ['tp5o']}, 05:33:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'talos_options': ['--e10s'], 05:33:30 INFO - 'tests': ['tp5o']}, 05:33:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'talos_options': ['--xperf_path', 05:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:30 INFO - 'tests': ['tp5n']}, 05:33:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:30 INFO - 'talos_options': ['--e10s', 05:33:30 INFO - '--xperf_path', 05:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:30 INFO - 'tests': ['tp5n']}}, 05:33:30 INFO - 'talos.zip': {'path': '', 05:33:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:30 INFO - Running post-action listener: _resource_record_post_action 05:33:30 INFO - ##### 05:33:30 INFO - ##### Running create-virtualenv step. 05:33:30 INFO - ##### 05:33:30 INFO - Running pre-action listener: _resource_record_pre_action 05:33:30 INFO - Running main action method: create_virtualenv 05:33:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:33:30 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:33:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:33:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:30 INFO - Using real prefix '/usr' 05:33:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:33:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:33 INFO - Installing pip.................done. 05:33:33 INFO - Return code: 0 05:33:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:33:33 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:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 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:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:33 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:33:33 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:33:33 INFO - Using env: {'DISPLAY': ':0', 05:33:33 INFO - 'HOME': '/home/cltbld', 05:33:33 INFO - 'LANG': 'en_US.UTF-8', 05:33:33 INFO - 'LANGUAGE': 'en_US:en', 05:33:33 INFO - 'LOGNAME': 'cltbld', 05:33:33 INFO - 'MAIL': '/var/mail/cltbld', 05:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:33 INFO - 'MOZ_NO_REMOTE': '1', 05:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:33 INFO - 'NO_EM_RESTART': '1', 05:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:33 INFO - 'SHELL': '/bin/bash', 05:33:33 INFO - 'SHLVL': '1', 05:33:33 INFO - 'TERM': 'linux', 05:33:33 INFO - 'TMOUT': '86400', 05:33:33 INFO - 'USER': 'cltbld', 05:33:33 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:33 INFO - '_': '/tools/buildbot/bin/python'} 05:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:33 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:33:33 INFO - Cleaning up... 05:33:33 INFO - Return code: 0 05:33:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:33:33 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:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 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:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:33 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:33:33 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:33:33 INFO - Using env: {'DISPLAY': ':0', 05:33:33 INFO - 'HOME': '/home/cltbld', 05:33:33 INFO - 'LANG': 'en_US.UTF-8', 05:33:33 INFO - 'LANGUAGE': 'en_US:en', 05:33:33 INFO - 'LOGNAME': 'cltbld', 05:33:33 INFO - 'MAIL': '/var/mail/cltbld', 05:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:33 INFO - 'MOZ_NO_REMOTE': '1', 05:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:33 INFO - 'NO_EM_RESTART': '1', 05:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:33 INFO - 'SHELL': '/bin/bash', 05:33:33 INFO - 'SHLVL': '1', 05:33:33 INFO - 'TERM': 'linux', 05:33:33 INFO - 'TMOUT': '86400', 05:33:33 INFO - 'USER': 'cltbld', 05:33:33 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:33 INFO - '_': '/tools/buildbot/bin/python'} 05:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:33 INFO - Downloading/unpacking psutil>=0.7.1 05:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:33 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:33:35 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:33:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:33:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:35 INFO - Installing collected packages: psutil 05:33:35 INFO - Running setup.py install for psutil 05:33:35 INFO - building 'psutil._psutil_linux' extension 05:33:35 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:33:35 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:33:35 INFO - building 'psutil._psutil_posix' extension 05:33:35 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:33:36 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:33:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:36 INFO - Successfully installed psutil 05:33:36 INFO - Cleaning up... 05:33:36 INFO - Return code: 0 05:33:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:36 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:36 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:33:36 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:33:36 INFO - Using env: {'DISPLAY': ':0', 05:33:36 INFO - 'HOME': '/home/cltbld', 05:33:36 INFO - 'LANG': 'en_US.UTF-8', 05:33:36 INFO - 'LANGUAGE': 'en_US:en', 05:33:36 INFO - 'LOGNAME': 'cltbld', 05:33:36 INFO - 'MAIL': '/var/mail/cltbld', 05:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:36 INFO - 'MOZ_NO_REMOTE': '1', 05:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:36 INFO - 'NO_EM_RESTART': '1', 05:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:36 INFO - 'SHELL': '/bin/bash', 05:33:36 INFO - 'SHLVL': '1', 05:33:36 INFO - 'TERM': 'linux', 05:33:36 INFO - 'TMOUT': '86400', 05:33:36 INFO - 'USER': 'cltbld', 05:33:36 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:36 INFO - '_': '/tools/buildbot/bin/python'} 05:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:33:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:33:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:38 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:33:38 INFO - Installing collected packages: mozsystemmonitor 05:33:38 INFO - Running setup.py install for mozsystemmonitor 05:33:38 INFO - Successfully installed mozsystemmonitor 05:33:38 INFO - Cleaning up... 05:33:38 INFO - Return code: 0 05:33:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:33:38 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:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 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:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:38 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:38 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:33:38 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:33:38 INFO - Using env: {'DISPLAY': ':0', 05:33:38 INFO - 'HOME': '/home/cltbld', 05:33:38 INFO - 'LANG': 'en_US.UTF-8', 05:33:38 INFO - 'LANGUAGE': 'en_US:en', 05:33:38 INFO - 'LOGNAME': 'cltbld', 05:33:38 INFO - 'MAIL': '/var/mail/cltbld', 05:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:38 INFO - 'MOZ_NO_REMOTE': '1', 05:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:38 INFO - 'NO_EM_RESTART': '1', 05:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:38 INFO - 'SHELL': '/bin/bash', 05:33:38 INFO - 'SHLVL': '1', 05:33:38 INFO - 'TERM': 'linux', 05:33:38 INFO - 'TMOUT': '86400', 05:33:38 INFO - 'USER': 'cltbld', 05:33:38 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:38 INFO - '_': '/tools/buildbot/bin/python'} 05:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:33:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:40 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:33:40 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:33:40 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:33:40 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:33:40 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:33:40 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:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:33:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:40 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:33:40 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:33:40 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:33:40 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:33:40 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:33:40 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:33:40 INFO - Downloading docopt-0.6.1.tar.gz 05:33:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:33:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:40 INFO - Running setup.py install for blobuploader 05:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:33:40 INFO - Running setup.py install for requests 05:33:41 INFO - Running setup.py install for docopt 05:33:41 INFO - Successfully installed blobuploader requests docopt 05:33:41 INFO - Cleaning up... 05:33:41 INFO - Return code: 0 05:33:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:41 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:41 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:33:41 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:33:41 INFO - Using env: {'DISPLAY': ':0', 05:33:41 INFO - 'HOME': '/home/cltbld', 05:33:41 INFO - 'LANG': 'en_US.UTF-8', 05:33:41 INFO - 'LANGUAGE': 'en_US:en', 05:33:41 INFO - 'LOGNAME': 'cltbld', 05:33:41 INFO - 'MAIL': '/var/mail/cltbld', 05:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:41 INFO - 'MOZ_NO_REMOTE': '1', 05:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:41 INFO - 'NO_EM_RESTART': '1', 05:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:41 INFO - 'SHELL': '/bin/bash', 05:33:41 INFO - 'SHLVL': '1', 05:33:41 INFO - 'TERM': 'linux', 05:33:41 INFO - 'TMOUT': '86400', 05:33:41 INFO - 'USER': 'cltbld', 05:33:41 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:41 INFO - '_': '/tools/buildbot/bin/python'} 05:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:41 INFO - Running setup.py (path:/tmp/pip-KPT4Ae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:41 INFO - Running setup.py (path:/tmp/pip-8OM30h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:41 INFO - Running setup.py (path:/tmp/pip-QOu8J3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:41 INFO - Running setup.py (path:/tmp/pip-T8BkiH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:41 INFO - Running setup.py (path:/tmp/pip-VwO060-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:42 INFO - Running setup.py (path:/tmp/pip-kIyjPa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:42 INFO - Running setup.py (path:/tmp/pip-XCv0Ba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:42 INFO - Running setup.py (path:/tmp/pip-CuGuL9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:42 INFO - Running setup.py (path:/tmp/pip-MXwfp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:42 INFO - Running setup.py (path:/tmp/pip-6TtQuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:42 INFO - Running setup.py (path:/tmp/pip-f2Il_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:42 INFO - Running setup.py (path:/tmp/pip-FktYq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:42 INFO - Running setup.py (path:/tmp/pip-UH6uSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:42 INFO - Running setup.py (path:/tmp/pip-x2HEJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:42 INFO - Running setup.py (path:/tmp/pip-11SQj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:42 INFO - Running setup.py (path:/tmp/pip-78IgLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:42 INFO - Running setup.py (path:/tmp/pip-tAfUmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:42 INFO - Running setup.py install for manifestparser 05:33:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:33:42 INFO - Running setup.py install for mozcrash 05:33:43 INFO - Running setup.py install for mozdebug 05:33:43 INFO - Running setup.py install for mozdevice 05:33:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Running setup.py install for mozfile 05:33:43 INFO - Running setup.py install for mozhttpd 05:33:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Running setup.py install for mozinfo 05:33:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Running setup.py install for mozInstall 05:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Running setup.py install for mozleak 05:33:43 INFO - Running setup.py install for mozlog 05:33:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:33:43 INFO - Running setup.py install for moznetwork 05:33:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Running setup.py install for mozprocess 05:33:44 INFO - Running setup.py install for mozprofile 05:33:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Running setup.py install for mozrunner 05:33:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Running setup.py install for mozscreenshot 05:33:44 INFO - Running setup.py install for moztest 05:33:44 INFO - Running setup.py install for mozversion 05:33:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:44 INFO - Cleaning up... 05:33:44 INFO - Return code: 0 05:33:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:44 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:44 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:33:44 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:33:44 INFO - Using env: {'DISPLAY': ':0', 05:33:44 INFO - 'HOME': '/home/cltbld', 05:33:44 INFO - 'LANG': 'en_US.UTF-8', 05:33:44 INFO - 'LANGUAGE': 'en_US:en', 05:33:44 INFO - 'LOGNAME': 'cltbld', 05:33:44 INFO - 'MAIL': '/var/mail/cltbld', 05:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:44 INFO - 'MOZ_NO_REMOTE': '1', 05:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:44 INFO - 'NO_EM_RESTART': '1', 05:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:44 INFO - 'SHELL': '/bin/bash', 05:33:44 INFO - 'SHLVL': '1', 05:33:44 INFO - 'TERM': 'linux', 05:33:44 INFO - 'TMOUT': '86400', 05:33:44 INFO - 'USER': 'cltbld', 05:33:44 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:44 INFO - '_': '/tools/buildbot/bin/python'} 05:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:44 INFO - Running setup.py (path:/tmp/pip-LEHOUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:33:44 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:33:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:44 INFO - Running setup.py (path:/tmp/pip-TeWljV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:45 INFO - Running setup.py (path:/tmp/pip-nDyUlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:45 INFO - Running setup.py (path:/tmp/pip-kyBgPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:45 INFO - Running setup.py (path:/tmp/pip-gt569b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:45 INFO - Running setup.py (path:/tmp/pip-zmGAvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:45 INFO - Running setup.py (path:/tmp/pip-XNxqSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:45 INFO - Running setup.py (path:/tmp/pip-m0YfSx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:45 INFO - Running setup.py (path:/tmp/pip-ZQfoFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:45 INFO - Running setup.py (path:/tmp/pip-T1avzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:45 INFO - Running setup.py (path:/tmp/pip-XTgOg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:45 INFO - Running setup.py (path:/tmp/pip-mI_kZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:45 INFO - Running setup.py (path:/tmp/pip-VqLhkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:45 INFO - Running setup.py (path:/tmp/pip-gx8BsD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:45 INFO - Running setup.py (path:/tmp/pip-4b_obR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:33:45 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:33:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:45 INFO - Running setup.py (path:/tmp/pip-p30Jon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:33:46 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:33:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:46 INFO - Running setup.py (path:/tmp/pip-iSPlVl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:33:46 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:33:46 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:33:46 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:33:46 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:33:46 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:33:46 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:33:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:46 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:33:46 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:33:46 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:33:46 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:33:46 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:33:46 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:33:47 INFO - Downloading blessings-1.5.1.tar.gz 05:33:47 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:33:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:47 INFO - Installing collected packages: blessings 05:33:47 INFO - Running setup.py install for blessings 05:33:47 INFO - Successfully installed blessings 05:33:47 INFO - Cleaning up... 05:33:48 INFO - Return code: 0 05:33:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:33:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:33:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:33:48 INFO - Reading from file tmpfile_stdout 05:33:48 INFO - Current package versions: 05:33:48 INFO - argparse == 1.2.1 05:33:48 INFO - blessings == 1.5.1 05:33:48 INFO - blobuploader == 1.2.4 05:33:48 INFO - docopt == 0.6.1 05:33:48 INFO - manifestparser == 1.1 05:33:48 INFO - mozInstall == 1.12 05:33:48 INFO - mozcrash == 0.16 05:33:48 INFO - mozdebug == 0.1 05:33:48 INFO - mozdevice == 0.47 05:33:48 INFO - mozfile == 1.2 05:33:48 INFO - mozhttpd == 0.7 05:33:48 INFO - mozinfo == 0.9 05:33:48 INFO - mozleak == 0.1 05:33:48 INFO - mozlog == 3.0 05:33:48 INFO - moznetwork == 0.27 05:33:48 INFO - mozprocess == 0.22 05:33:48 INFO - mozprofile == 0.27 05:33:48 INFO - mozrunner == 6.11 05:33:48 INFO - mozscreenshot == 0.1 05:33:48 INFO - mozsystemmonitor == 0.0 05:33:48 INFO - moztest == 0.7 05:33:48 INFO - mozversion == 1.4 05:33:48 INFO - psutil == 3.1.1 05:33:48 INFO - requests == 1.2.3 05:33:48 INFO - wsgiref == 0.1.2 05:33:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:48 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 0x7f3cb9e63c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, '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': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', '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:33:48 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:33:48 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:33:48 INFO - Using env: {'DISPLAY': ':0', 05:33:48 INFO - 'HOME': '/home/cltbld', 05:33:48 INFO - 'LANG': 'en_US.UTF-8', 05:33:48 INFO - 'LANGUAGE': 'en_US:en', 05:33:48 INFO - 'LOGNAME': 'cltbld', 05:33:48 INFO - 'MAIL': '/var/mail/cltbld', 05:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:48 INFO - 'MOZ_NO_REMOTE': '1', 05:33:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:33:48 INFO - 'NO_EM_RESTART': '1', 05:33:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:33:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:33:48 INFO - 'SHELL': '/bin/bash', 05:33:48 INFO - 'SHLVL': '1', 05:33:48 INFO - 'TERM': 'linux', 05:33:48 INFO - 'TMOUT': '86400', 05:33:48 INFO - 'USER': 'cltbld', 05:33:48 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:48 INFO - '_': '/tools/buildbot/bin/python'} 05:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 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:33:48 INFO - Cleaning up... 05:33:48 INFO - Return code: 0 05:33:48 INFO - Running post-action listener: _resource_record_post_action 05:33:48 INFO - Running post-action listener: _start_resource_monitoring 05:33:48 INFO - Starting resource monitoring. 05:33:48 INFO - ##### 05:33:48 INFO - ##### Running install step. 05:33:48 INFO - ##### 05:33:48 INFO - Running pre-action listener: _resource_record_pre_action 05:33:48 INFO - Running main action method: install 05:33:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:33:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:33:48 INFO - Reading from file tmpfile_stdout 05:33:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:33:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:33:48 INFO - Reading from file tmpfile_stdout 05:33:48 INFO - Output received: 05:33:48 INFO - Usage: mozinstall [options] installer 05:33:48 INFO - Options: 05:33:48 INFO - -h, --help show this help message and exit 05:33:48 INFO - -d DEST, --destination=DEST 05:33:48 INFO - Directory to install application into. [default: 05:33:48 INFO - "/builds/slave/test-pgo"] 05:33:48 INFO - --app=APP Application being installed. [default: firefox] 05:33:48 INFO - mkdir: /builds/slave/test-pgo/build/application 05:33:48 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:33:48 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:34:03 INFO - Reading from file tmpfile_stdout 05:34:03 INFO - Output received: 05:34:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:34:03 INFO - Running post-action listener: _resource_record_post_action 05:34:03 INFO - ##### 05:34:03 INFO - ##### Running run-tests step. 05:34:03 INFO - ##### 05:34:03 INFO - Running pre-action listener: _resource_record_pre_action 05:34:03 INFO - Running main action method: run_tests 05:34:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:34:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:34:03 INFO - Python 2.7.3 05:34:03 INFO - Return code: 0 05:34:03 INFO - grabbing minidump binary from tooltool 05:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:03 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 0x1fbed70>, '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 0x1fbfb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbffb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:34:03 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:34:03 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:34:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:03 INFO - Return code: 0 05:34:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:34:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:34:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:34:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:34:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:34:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 05:34:03 INFO - Using env: {'DISPLAY': ':0', 05:34:03 INFO - 'HOME': '/home/cltbld', 05:34:03 INFO - 'LANG': 'en_US.UTF-8', 05:34:03 INFO - 'LANGUAGE': 'en_US:en', 05:34:03 INFO - 'LOGNAME': 'cltbld', 05:34:03 INFO - 'MAIL': '/var/mail/cltbld', 05:34:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:34:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:03 INFO - 'MOZ_NO_REMOTE': '1', 05:34:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:34:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:03 INFO - 'NO_EM_RESTART': '1', 05:34:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:34:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:34:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:34:03 INFO - 'SHELL': '/bin/bash', 05:34:03 INFO - 'SHLVL': '1', 05:34:03 INFO - 'TERM': 'linux', 05:34:03 INFO - 'TMOUT': '86400', 05:34:03 INFO - 'USER': 'cltbld', 05:34:03 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068', 05:34:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:03 INFO - '_': '/tools/buildbot/bin/python'} 05:34:03 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 05:34:03 INFO - mozversion INFO | application_buildid: 20151119030404 05:34:03 INFO - mozversion INFO | application_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 05:34:03 INFO - mozversion INFO | application_display_name: Nightly 05:34:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:03 INFO - mozversion INFO | application_name: Firefox 05:34:03 INFO - mozversion INFO | application_remotingname: firefox 05:34:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:34:03 INFO - mozversion INFO | application_vendor: Mozilla 05:34:03 INFO - mozversion INFO | application_version: 45.0a1 05:34:03 INFO - mozversion INFO | platform_buildid: 20151119030404 05:34:03 INFO - mozversion INFO | platform_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 05:34:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:34:03 INFO - mozversion INFO | platform_version: 45.0a1 05:34:03 INFO - 2015-11-19 05:34:03,454 DEBUG : using testdate: 1447940043 05:34:03 INFO - 2015-11-19 05:34:03,454 DEBUG : actual date: 1447940043 05:34:03 INFO - 2015-11-19 05:34:03,471 INFO : starting webserver on 'localhost:55482' 05:34:03 INFO - 2015-11-19 05:34:03,472 INFO : Starting test suite talos-linux64-ix-042 05:34:03 INFO - 2015-11-19 05:34:03,473 INFO : Starting test dromaeo_css 05:34:03 INFO - 2015-11-19 05:34:03,473 DEBUG : operating with platform_type : linux_ 05:34:03 INFO - 2015-11-19 05:34:03,474 INFO : Initialising browser for dromaeo_css test... 05:34:03 INFO - 2015-11-19 05:34:03,490 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp91jGpn/profile http://localhost:55482/getInfo.html 05:34:08 INFO - 2015-11-19 05:34:08,660 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:34:08 INFO - 2015-11-19 05:34:08,660 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:34:08 INFO - 2015-11-19 05:34:08,660 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:34:08 INFO - 2015-11-19 05:34:08,660 DEBUG : BROWSER_OUTPUT: __metrics 05:34:08 INFO - 2015-11-19 05:34:08,870 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:10 INFO - 2015-11-19 05:34:10,112 INFO : Browser initialized. 05:34:10 INFO - 2015-11-19 05:34:10,112 INFO : Running cycle 1/1 for dromaeo_css test... 05:34:10 INFO - 2015-11-19 05:34:10,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp91jGpn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:34:21 INFO - 2015-11-19 05:34:21,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 137986048 05:34:21 INFO - 2015-11-19 05:34:21,840 DEBUG : BROWSER_OUTPUT: 05:35:12 INFO - 2015-11-19 05:35:12,531 DEBUG : BROWSER_OUTPUT: 1447940112527 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:37:22 INFO - 2015-11-19 05:37:22,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55482/tests/dromaeo/cssquery-ext.html) 05:37:23 INFO - 2015-11-19 05:37:23,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 225390592 05:37:23 INFO - 2015-11-19 05:37:23,331 DEBUG : BROWSER_OUTPUT: 05:40:25 INFO - 2015-11-19 05:40:25,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-ext.html (next: http://localhost:55482/tests/dromaeo/cssquery-jquery.html) 05:40:26 INFO - 2015-11-19 05:40:26,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 223576064 05:40:26 INFO - 2015-11-19 05:40:26,243 DEBUG : BROWSER_OUTPUT: 05:43:28 INFO - 2015-11-19 05:43:28,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55482/tests/dromaeo/cssquery-mootools.html) 05:43:28 INFO - 2015-11-19 05:43:28,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 220667904 05:43:28 INFO - 2015-11-19 05:43:28,791 DEBUG : BROWSER_OUTPUT: 05:46:30 INFO - 2015-11-19 05:46:30,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55482/tests/dromaeo/cssquery-prototype.html) 05:46:31 INFO - 2015-11-19 05:46:31,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 197795840 05:46:31 INFO - 2015-11-19 05:46:31,322 DEBUG : BROWSER_OUTPUT: 05:49:33 INFO - 2015-11-19 05:49:33,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55482/tests/dromaeo/cssquery-yui.html) 05:49:34 INFO - 2015-11-19 05:49:34,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 203980800 05:49:34 INFO - 2015-11-19 05:49:34,333 DEBUG : BROWSER_OUTPUT: 05:52:36 INFO - 2015-11-19 05:52:36,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/dromaeo/cssquery-yui.html (next: http://localhost:55482/tests/dromaeo/cssquery-dojo.html) 05:52:37 INFO - 2015-11-19 05:52:37,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 279105536 05:52:37 INFO - 2015-11-19 05:52:37,101 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,101 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3150.495920652696;3257.2182676157713;3291.588551431071;3293.8353082345875;3314.419976504111;5225.085610018251;5318.414974352818;5419.078756611376;5438.428964958677;5472.452754724531;5327.067763141454;5340.49265319795;5367.436419175979;5377.085895397782;5460.208269800876;4940.901181976367;4961.107000739866;4973.552380285773;4998.4751601081725;5012.949870501303;4802.59177969873;5015.5486006259425;5023.949760502403;5079.847604571869;5083.237514372855;4885.6335774817035;4951.0592987332475;4960.603151747851;4961.18140506816;5006.324146240284;4841.007593443371;4863.392075990501;4879.072976134523;4902.803887844518;4908.190148625473;4840.080384726891;4869.537393947569;4876.878078048042;4902.338184345139;4974.825881094181;5210.687358758487;5298.417174110845;5311.548518375943;5312.521873031407;5337.039332920072;5880.235569375996;5930;5932.703364831785;5934.881302373971;5939.821805345847;5643.435656434323;5804.622699524517;5824.097264923944;5973.342932277446;5995.760169593211;5546.750396232179;5557.166425036277;5562.3047119110115;5566.888662226733;5601.859953501154;6033.698315084228;6035.185249991283;6047.9395206047375;6054.666993315322;6057.666828324396;5633.324001119892;5648.237487939158;5777.566682498829;5796.130580412888;5840.5035571976005;5838.562107841929;5844.240248767633;5850.736716847752;5853.765849365977;5891.764329426861;5833.7374818133285;5835.503982161564;5836.9124463133085;5838.941610583925;5845.795397161164;5690.829275121753;5706.686132262683;5746.942530574641;5746.9425305747245;5839.357670656224;4484.484284307281;4515.5484451554585;4539.931901021488;4551.067031258584;4584.037352156018;4016.3172260715746;4019.21625283067;4025.2352053109817;4026.1947610478023;4031.3348297531165;5318.282031925641;5439.401665816757;5446.782128714886;5516.586256030814;5560.972195138998;5920.733566989496;5920.911186332209;5922.8815423691285;5929.73316200772;5930.377310382348;5289.973550132302;5576.024195765806;5583.637063590853;5586.413426590231;5589.385167631557;5022.372203474566;5088.5420312171345;5088.974555127201;5096.847094587169;5108.208227724708;6081.726322315506;6095.847603809941;6101.96949015261;6107.144999700045;6108.9920163173465;5761.5102716269585;5906.940930590811;5926.170336153028;5939.762409503572;5940.287165540163;5909.23179986599;5964.9105263420215;6010.579259451972;6033.879322413615;6057.909131362945;5814.3604203538425;5816.185733997159;5824.94175058244;5843.532517398513;5845.941540584539;5697.7151142443545;5886.05823068307;5889.293284805851;5907.616004959664;5907.822765317047;5690.601657883908;5705;5713.714314284352;5795.043817770021;5821.301443826768;5706.229658995982;5707.1724599933605;5749.310082790092;5751.683657398883;5755.71221438918;5506.944930550643;5632.859178520406;5648.406917273627;5656;5659.858503537444;5685;5697.971510142423;5717.714114294352;5796.94203057964;5849.61977471463;5661.603687741818;5675.68783716883;5676.091825308096;5677.744501497526;5727.369989301257 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.1080703295827;586.074003075141;596.3321080389964;609.734765377061;621.19244981524;31273.84363078184;40608;40887;40901.38647920283;40953.38569921454;41220.38169427461;41699.58300416995;41731.37402938951;41787.58212417875;41801.790991045076;7612.847743045136;7727.150013498539;8510.44682095665;8678.609462574168;8683.739487815345;10379.169666426706;10604;10608.416537090457;10611.416372099531;10629.84055239168;10410.167186625053;10451;10503.422311772849;10524.263301568893;10533.947330263338;7623.771286861403;7764.37884969204;10434.113100386476;10524.15806735467;10800.513976870981;10246.9487652562;10307.175425965905;10369.170466362748;10391.84412233817;10397.584096636125;39904;40003.7999810002;40301.59698403037;40368.596314036775;40432.39351409731;3196.280836811722;3231.951520727191;3294.621118571371;3301.4387554115856;3651.519731984014;30536.236594085105;30746.692533074605;30834.53748193779;30878.536821947688;31089.222769430944;3586.910327241814;3614.1461181762274;3622.37601957179;3628.147385364464;3720.404735242348;271029;273271;273355;273804;274380;56074.71962640161;56800.431995679515;58145;58639;59170.40829591649;56468.717656411456;56925;57061.42938570644;57231.42768572344;57287.71356143193;13012.089153759336;13060.542880999119;13166.47334106625;13274.867251327556;13285.468581256835;10909.618163364245;10911.83632245517;10918.23572349928;10951.288166269167;10961;19329.80670193308;19685.40943771689;19717.309894153637;19750.901245493682;19826.90086549558;7329.19378868324;7506.1743208248145;7511.8497630047095;7534.698612055457;7618.428617853683;987.698751880669;988.1699372527112;1015.1827778638119;1036.6786296248188;1071.6999240212754;27713;28850.054066444303;29013.56479652807;29152.708472915423;29169.687364068242;1026.0556245913951;1068.2842495528014;1075.6282397313903;1090.6182836007492;1151.5624062856061;14618.63453413652;14716.705665886837;14720.92639536817;14776.187309698069;14782.334794934253;337946;344420;344765;345355;347462;53187.734061329444;53489.1976620351;53519;53539.464605354224;53595.19607205817;1168.3690806964144;1235.6169587427926;1236.8144778283329;1337.6388375138852;1337.7057047449546;25966.221013369628;27019.72980270172;27178;27253;27819.582706259018;42128.78935605425;44572;44583.10833783371;44793.328100079176;44820;207665;310771;321168;321775;323933;30072.097837064925;30742.846285768428;30773.23066923345;30775.2306192347;30800.53799192969;41070.38394424146;43197;43198;44241;44273.77863110664;36651;37104.44343334798;37734;38135.80932095433;38412.80793596126;36298.49554651851;37245;37245.6275437253;37398.626013739515;37661.435078473296;35586.82206588951;36240.637593623724;36885;37064;37157.071073223386;31791.682083178872;32836.179095522806;32908.83545582257;33318.333633326714;33389.833050835565;25252.621210681486;25522.617160742233;26075.348116297246;26751.331216719736;26919.461610767285 05:52:37 INFO - 2015-11-19 05:52:37,102 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.2117550808648;350.59856464348314;351.9489673997272;352.5733862026949;357.19809028730504;14077.155370677741;14305.570832875004;17020.489385318444;17289.65420691587;18912.43262702118;15876.36494540217;16683.416080437186;16994.405195818148;17191.140442977863;17231.483055508354;5385.272988146589;5476.507114359707;5497;5498.092814685572;5504.559635229192;3974;4099.0162361033435;5454.072807622694;5504.862378440531;5947;5960.463558279754;5986.132010858445;6010.038393856984;6017.308009578889;6025.9096113558335;4742.051589682077;4856.562909338177;4861.440934292531;4862.7568621569135;5978.163057171978;4178.809533314707;4209.5579964103945;4210.32634778434;4212.157568486315;4361.280388735887;13456.327183640877;13568.59294221175;13789.862101379058;13803.792943105762;13888.375023123983;2125.883076430796;2159.9352019439443;2175.1843058852774;2182.7053347798;2212.048819007826;9998.250131240186;10062.89937100627;10086.798264034678;10102.040306170902;10282.280240383176;1574.110627495473;1666.2002238925263;1678.0015890545105;1715.4253325136094;1724.3706047292774;59193.40806591922;61491.692541537006;61713;61714.074288885706;61919.07121393183;6900.930990690029;6969.721211151598;7016.2632923543315;7102.147742270858;7136.250693677193;8573.74278771638;8579.785505362292;8584.699535516227;8590.91409085901;8591.871121933176;5561.110222364483;5597.804076857372;5626.887462250814;5682.460166284196;5683.60214784961;5638.97180514103;5707.885842283131;5711;5735.369109397963;5748.741306641211;3301.7193538549013;3310.0897253255066;3315.1049216711353;3336.5328853960464;3344.2976974835556;1114.6266000889793;1121.85415895933;1161.3786624156205;1202.3387137074574;1231.0766924806396;469.89427378840173;475.05701183151416;475.9357486739315;486.6325923927483;492.6748346091562;11375.374354410422;11532.654020379403;11752.58865939688;11966.22219555726;12551.497940082478;473.1483330006044;504.87882908102523;505.3077284120778;514.3288009148098;530.0212804041236;6538.869222615521;6703.664816759143;6857.074294970215;6864.4165245954655;6866.553674011173;398126;398337;401007;402069;560753;67822;68401.65799170973;71438.64280678668;74247.25752742511;78212.60893695494;573.9770409183669;585.9121131830345;586.1647152807233;586.560079940045;588.4351023017865;10659.360438373413;10772.299800512941;11037.392943388191;11076.723081923017;11395.658130256106;33254;33498.497522536694;33710.32579348448;34838.82580587081;36908.44637330389;44851.775741121084;45895.31157032714;46497.76751116223;47804.7609761949;50896.74551627218;6681.69932353055;6749.122614060338;6776.356246156607;6831.795046148623;6847.383735463832;12036.939815300868;12156.149069565046;12187.451564679433;12253.509859605516;12264;10293.53679084458;10454.947725261325;10613.9469302653;10627.415492148006;10884;10377.636782712569;10608.734781630521;10610.522526486173;10655.733606659896;10740.462976851282;9194.49430281341;9382.906170938477;9667.226621870373;11416.885831141582;11565.826512602149;6392.009238568029;6882.174139103339;6906.723731050702;6956.2695916930015;6979.755708550177;11077.279976801483;11137.55449782032;11178.888211117785;11299.661010169708;11420.086393088366 05:52:37 INFO - 2015-11-19 05:52:37,103 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1331.2811082015712;1702.7360759082342;1764.1532064608987;1771.7519547263385;1804.864635152363;6693.330666933304;7435.442341824364;7578.090629124499;7594.354479869204;7594.582297973623;7314.561126332411;7550.282723141307;7552.282533159355;7556.131044929834;7561.810954726135;1986.0566231040284;2012.1850650486504;2160.4274867160216;2284.132029828667;2306.8039216666602;2350.4123969007746;2355.693759811231;2356;2357.1867705641525;2357.7524359942217;2262.954740905181;2337.836351455399;2337.9883100584557;2341.1220792202926;2343.7304709958316;1954.3159894037044;1967.5868067705799;2250.336150835499;2302.044651469638;2304.2396009316885;2298.5632729781287;2313.34069790109;2330.52224294021;2333.6849525314205;2337.672725818387;7617.961910190469;7683.116441609231;7695.230476952316;7701.922980770177;7707.653155607955;4573.679842411033;4642.419697537808;4657.580817726387;4670.859874203746;4682.180618391768;2991.685872983327;3044.58898048765;3079.6766339534474;3089.119600913729;3106.223444138965;991.5686676295834;996.7059717383389;999.0259496990449;1030.443560477349;1035.694470131313;10531.210159238011;10672.306300090548;10696.572137114506;10713.517891694892;10713.946430267877;4192.434021407071;4218.240716671029;4262.360645903077;4363.38912552243;4371.0820727646915;8615.353848461391;8618.525981070976;8623.698170564126;8627.6980305689;8634.956825215959;4663.440387153563;4693.389859318267;4696.38946936896;4698.694584851974;4700.271457923959;4218.451601291812;4249.830006799693;4251.617354438115;4265.829366825355;4266.978665106654;3467.2718729066673;3504.7196224301993;3518.806465644363;3526.559180102487;3548.7693299935936;1088.357868857378;1096.5230124895695;1103.8730545987314;1114.331401159298;1115.5593540551438;954.2413781044087;1005.2812239248826;1271.9046071544672;1280.36621872172;1283.9358032098357;7253.709851605982;7303.671334789948;7412.555246685216;7454.85090298191;7473;678.6878036103448;680.6018479189729;682.2461180395592;706.8586282743369;716.9354758071798;5700;5742.684152371659;5748.45389687979;5750.971245143831;5754.338251101093;9002;9033.232175265044;9266.258699304039;9403.059694030679;9405.294602904809;9131.406458580172;9169.35814492979;9242.21441177494;9248.028956959557;9263.397879137834;7062.364387205176;7175.174854891754;7176.354128128389;7201.495895287279;7230.276972302833;6852.45180385558;6853.862922741617;6858.211305699909;6869.725210991704;6873.621950792754;7994.800129996796;8112.02655681322;8339.166083391612;8344.624491898001;8359.707410240613;8306.460080094774;8521.744347669579;8523.019852716769;8533.53065581399;8548.059713431394;6492.902606460812;6506.642134682638;6581.243157036811;6606.075149479173;6623.3376662333385;7189.460790440842;7217.963910180625;7239.457040721862;7242.203357630762;7242.637868106468;6935.965320173367;7065.823354415975;7086.751963681247;7202.279772022755;7205.675744591611;6932.306769323028;6960.234374218933;7025.613591252531;7066.152061752623;7093.6453177341955;6304.495640348669;6432.839179020375;6740.393364597014;6887.7244910203035;6891.552049116792;6117.908231376444;6317.273513546001;6343.492520598434;6343.968280158754;6348.269948955929;6266.279377871603;6428.710708018244;6452.967735161482;6453.064305675557;6487.643179624977 05:52:37 INFO - 2015-11-19 05:52:37,104 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.9224986003359;328.34331337325347;334.26128256553017;339.6790033418421;340.86706184588;6051.9697401512985;6059.909101363478;6078.817635470932;6091.878162436748;6102.725377358019;5756.251687280658;5833.82498525045;5858.41415858414;5960.701964901748;5970.761169553223;4613.746243956581;4626.329182268569;4638.0491999140095;4638.907221855561;4647.86056418308;4390.714603550775;4602.424696912886;4636.86089417318;4643.094596553673;4643.117807616542;4478.261086920655;4478.305862591304;4581.79381927814;4582.518835522272;4587.747673877935;4537.137943790669;4549.181147393468;4560.8859778505475;4576.656750743708;4597.494275629678;4025.657819085381;4033.2135233629456;4038.9192216155807;4045.110075783323;4059.3505039193883;5501.697406642633;5589.524890384322;5631.0708733059;5632.098864181711;5634.098544232944;5314.4951229633125;5320.946790532123;5321.281626980347;5330.253764472977;5338.759755810997;6311.52663550231;6314.494840412756;6332.33510481402;6336.366363363627;6340.492760579143;4456.910861782779;4458.598726114633;4459.777011149462;4467.82128714851;4486.8878278042985;6476.287608363124;6574.868502629968;6582.440492558138;6647.135872336614;6681.966590167018;4438.378626992224;4468.151051300242;4477.485089214782;4479.328100784908;4485.282354823213;4521.61566266871;4530.026044400403;4533.274676051882;4535.387722657465;4548.658850586153;5280.287161233261;5283.550898173621;5284.7886084556185;5285.101532739443;5287.995280896695;6249.593776404519;6397.136386587844;6413.903791443132;6425.485961123099;6442.903356449657;1586.294099125901;1605.1011433597223;1608.6702226043633;1609.4769200010044;1609.6700176463796;1055.6938487838595;1062.18211976779;1064.4784055812595;1066.8826429092794;1077.0737166037202;6197.81406557804;6208.875822483525;6210.254769427697;6213.440790328892;6217;6610.140681711443;6612.338766123446;6612.404883560503;6613.570117942319;6618.900716489256;6025.15647809307;6129.417705317987;6146.108814221912;6269.843253918597;6272.5922815016875;3574.6425357464564;3599.1182160370877;3602.5496812898386;3607.332643460968;3607.3506768781344;6891.138607674041;6892.828219202747;6904.896426553606;6912.170539535288;6914.965425172842;6609.471242300604;6720.462363010947;6771.4582833373215;6778.491613129035;6785.287544807823;6894;6899.517033807585;6904.689288982008;6908.1364829396325;6908.481863860231;6626.469882409299;6645.800625981228;6648.268690443951;6650.401463868275;6658.43403310724;6443.420092191725;6599.340065993554;6610;6610.8347291318105;6625.304343043911;6894.965525172543;6901.654917254017;6909.619970901648;6916.515843890879;6917;4526.366308716716;4563.977180114078;4578.221702310549;4579.061292434976;4581.679282450196;6488.383603557654;6538.869222615616;6543.70553325092;6591.868162636816;6612.537122401578;6454.128692626623;6463.418292353711;6465.353464653497;6469.514786390945;6480.189976252968;6386.9680651596445;6421.839454013687;6446.323136070832;6453.45145662624;6459.547831651739;6146.262448506208;6308.306086330408;6315.3053164152825;6353.52348573868;6355.078513615592;6494.805155845143;6497.902531462127;6499.642519661464;6501.934980650133;6502.674866256573;6177.536684748572;6308.558400911892;6309.1167236586;6309.337519560564;6322.589031712924 05:52:37 INFO - 2015-11-19 05:52:37,105 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.787363790863;709.3934685843607;791.9010123734533;830.1739768929914;860.2773670117102;13065.804012939814;13341.466341346359;13423.798643020338;13431.7313653727;13457.865421345808;13095.54165604204;13151.408186631601;13151.605451836436;13167.144135631177;13172.34138293084;677.945764338853;693.2235895796715;822.0382152881114;836.573347592726;837.1544739812803;832.3549249331755;832.3923535818856;837.2506606587101;837.815680550278;839.3159574946429;870.1733353314345;871.6208449324532;871.7515508080198;874.4884242718017;876.023234093987;705.428602831708;715.7029832619456;853.5390888920007;865.2429124516049;865.7143142762936;634.9619022858597;636.07133584966;638.5370606310388;638.9297177310492;638.9680515974183;13231.272280024596;13517.391717372742;13523.661908452268;13568.932155339258;13664.65838354039;12438.378081096;12754.872451275554;12845.807312890314;12894.67763305925;13388.397522111529;9972.800543989151;10008.249381296431;10009.099181073665;10019.549120289605;10115.898841011569;3284.7584823998736;3315.270640459095;3373.1567108222944;3387.6104248011547;3418.743594230418;43937.78031109856;44196.11607767826;44609.77695111504;44865.32702009472;44974.100517989784;6833.384995350442;6841.692123854438;6948.965255173692;7182.066331376992;7242.311980361963;12076.879231207751;12541.56104536355;12665.810012849815;12710;12714.491420343267;6943.166819981635;7011.439084873198;7034.085568876116;7139.785806425815;7205.135383753878;4046.838126474967;4195.181939521825;4210.894727631834;4211.599898009684;4213.536510983789;2810.889698569054;2843.5308174151446;2844.033028770187;2849.102532702192;2851.871665775045;437.6608128700283;445.66797735687123;451.19011374582703;452.1567277028384;459.7586267209742;566.1705601294042;625.4777260987036;625.9874802504015;628.0986783965025;642.3063091860779;7761.4566980311965;8115.310198633064;8198.467099638505;8239.340852731768;8407.369447291356;522.5949888836107;537.8735997040692;538.1389776357875;584.9122631605209;609.5702529716539;3592.3713350163616;3690.557133143986;3729.627037296303;3876.7867767272505;4196.81114349855;56937;57327.71336143293;57796;57856.71071644699;58789;53296;54388.456115439134;54826.72586637041;54938.450615494134;55281.72359138259;47891.521084789405;48507.272390914164;48977;49558.50441495611;49920.00639948795;8216.794580135544;8282.697479828716;8316.334693224648;8460.280876125598;8480.618372173143;36122.63877361193;36306;36926.261474770894;37072;37093.6290637101;42255.7887210562;46264.30603540882;46413.3038004437;46805.531944680115;46877.53122468868;8043.316318113026;8096.109427962801;8485.575721214038;8490.800968214253;8587.720567326143;12055.397230138282;12085.274883507018;12139.757204855678;12266.080043996915;12381.257124572554;10197.388156710622;10269.794604108025;10273.383596984206;10449.111825494918;10555.52500137511;11307.434628268718;11555.711107222387;11569.710757231136;11946.641600751991;12092.334921579397;11245.156613253876;11374.146938979775;11612.535498579962;11657.300561966309;11691.590794322157;9869.555869985725;9898.653547125816;10015.849762253427;10163.796724065329;10497.9475102624;9899.1585715215;9933.701988940344;9953.701388958343;9985.900140998498;9988.350757200758 05:52:37 INFO - 2015-11-19 05:52:37,105 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:52:37 INFO - 2015-11-19 05:52:37,105 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: __startTimestamp1447941157095__endTimestamp 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,106 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5434.15 Median:5659.86 stddev:611.80 (10.8%) stddev-sans-first:586.86 05:52:37 INFO - 2015-11-19 05:52:37,107 DEBUG : BROWSER_OUTPUT: Values: 3150.5 3257.2 3291.6 3293.8 3314.4 5225.1 5318.4 5419.1 5438.4 5472.5 5327.1 5340.5 5367.4 5377.1 5460.2 4940.9 4961.1 4973.6 4998.5 5012.9 4802.6 5015.5 5023.9 5079.8 5083.2 4885.6 4951.1 4960.6 4961.2 5006.3 4841.0 4863.4 4879.1 4902.8 4908.2 4840.1 4869.5 4876.9 4902.3 4974.8 5210.7 5298.4 5311.5 5312.5 5337.0 5880.2 5930.0 5932.7 5934.9 5939.8 5643.4 5804.6 5824.1 5973.3 5995.8 5546.8 5557.2 5562.3 5566.9 5601.9 6033.7 6035.2 6047.9 6054.7 6057.7 5633.3 5648.2 5777.6 5796.1 5840.5 5838.6 5844.2 5850.7 5853.8 5891.8 5833.7 5835.5 5836.9 5838.9 5845.8 5690.8 5706.7 5746.9 5746.9 5839.4 4484.5 4515.5 4539.9 4551.1 4584.0 4016.3 4019.2 4025.2 4026.2 4031.3 5318.3 5439.4 5446.8 5516.6 5561.0 5920.7 5920.9 5922.9 5929.7 5930.4 5290.0 5576.0 5583.6 5586.4 5589.4 5022.4 5088.5 5089.0 5096.8 5108.2 6081.7 6095.8 6102.0 6107.1 6109.0 5761.5 5906.9 5926.2 5939.8 5940.3 5909.2 5964.9 6010.6 6033.9 6057.9 5814.4 5816.2 5824.9 5843.5 5845.9 5697.7 5886.1 5889.3 5907.6 5907.8 5690.6 5705.0 5713.7 5795.0 5821.3 5706.2 5707.2 5749.3 5751.7 5755.7 5506.9 5632.9 5648.4 5656.0 5659.9 5685.0 5698.0 5717.7 5796.9 5849.6 5661.6 5675.7 5676.1 5677.7 5727.4 05:52:37 INFO - 2015-11-19 05:52:37,107 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,107 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47337.88 Median:32872.51 stddev:80416.93 (244.6%) stddev-sans-first:80565.85 05:52:37 INFO - 2015-11-19 05:52:37,107 DEBUG : BROWSER_OUTPUT: Values: 568.1 586.1 596.3 609.7 621.2 31273.8 40608.0 40887.0 40901.4 40953.4 41220.4 41699.6 41731.4 41787.6 41801.8 7612.8 7727.2 8510.4 8678.6 8683.7 10379.2 10604.0 10608.4 10611.4 10629.8 10410.2 10451.0 10503.4 10524.3 10533.9 7623.8 7764.4 10434.1 10524.2 10800.5 10246.9 10307.2 10369.2 10391.8 10397.6 39904.0 40003.8 40301.6 40368.6 40432.4 3196.3 3232.0 3294.6 3301.4 3651.5 30536.2 30746.7 30834.5 30878.5 31089.2 3586.9 3614.1 3622.4 3628.1 3720.4 271029.0 273271.0 273355.0 273804.0 274380.0 56074.7 56800.4 58145.0 58639.0 59170.4 56468.7 56925.0 57061.4 57231.4 57287.7 13012.1 13060.5 13166.5 13274.9 13285.5 10909.6 10911.8 10918.2 10951.3 10961.0 19329.8 19685.4 19717.3 19750.9 19826.9 7329.2 7506.2 7511.8 7534.7 7618.4 987.7 988.2 1015.2 1036.7 1071.7 27713.0 28850.1 29013.6 29152.7 29169.7 1026.1 1068.3 1075.6 1090.6 1151.6 14618.6 14716.7 14720.9 14776.2 14782.3 337946.0 344420.0 344765.0 345355.0 347462.0 53187.7 53489.2 53519.0 53539.5 53595.2 1168.4 1235.6 1236.8 1337.6 1337.7 25966.2 27019.7 27178.0 27253.0 27819.6 42128.8 44572.0 44583.1 44793.3 44820.0 207665.0 310771.0 321168.0 321775.0 323933.0 30072.1 30742.8 30773.2 30775.2 30800.5 41070.4 43197.0 43198.0 44241.0 44273.8 36651.0 37104.4 37734.0 38135.8 38412.8 36298.5 37245.0 37245.6 37398.6 37661.4 35586.8 36240.6 36885.0 37064.0 37157.1 31791.7 32836.2 32908.8 33318.3 33389.8 25252.6 25522.6 26075.3 26751.3 26919.5 05:52:37 INFO - 2015-11-19 05:52:37,108 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,108 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24022.75 Median:4286.72 stddev:71808.33 (1675.1%) stddev-sans-first:71987.76 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: Values: 344.2 350.6 351.9 352.6 357.2 14077.2 14305.6 17020.5 17289.7 18912.4 15876.4 16683.4 16994.4 17191.1 17231.5 5385.3 5476.5 5497.0 5498.1 5504.6 3974.0 4099.0 5454.1 5504.9 5947.0 5960.5 5986.1 6010.0 6017.3 6025.9 4742.1 4856.6 4861.4 4862.8 5978.2 4178.8 4209.6 4210.3 4212.2 4361.3 13456.3 13568.6 13789.9 13803.8 13888.4 2125.9 2159.9 2175.2 2182.7 2212.0 9998.3 10062.9 10086.8 10102.0 10282.3 1574.1 1666.2 1678.0 1715.4 1724.4 59193.4 61491.7 61713.0 61714.1 61919.1 6900.9 6969.7 7016.3 7102.1 7136.3 8573.7 8579.8 8584.7 8590.9 8591.9 5561.1 5597.8 5626.9 5682.5 5683.6 5639.0 5707.9 5711.0 5735.4 5748.7 3301.7 3310.1 3315.1 3336.5 3344.3 1114.6 1121.9 1161.4 1202.3 1231.1 469.9 475.1 475.9 486.6 492.7 11375.4 11532.7 11752.6 11966.2 12551.5 473.1 504.9 505.3 514.3 530.0 6538.9 6703.7 6857.1 6864.4 6866.6 398126.0 398337.0 401007.0 402069.0 560753.0 67822.0 68401.7 71438.6 74247.3 78212.6 574.0 585.9 586.2 586.6 588.4 10659.4 10772.3 11037.4 11076.7 11395.7 33254.0 33498.5 33710.3 34838.8 36908.4 44851.8 45895.3 46497.8 47804.8 50896.7 6681.7 6749.1 6776.4 6831.8 6847.4 12036.9 12156.1 12187.5 12253.5 12264.0 10293.5 10454.9 10613.9 10627.4 10884.0 10377.6 10608.7 10610.5 10655.7 10740.5 9194.5 9382.9 9667.2 11416.9 11565.8 6392.0 6882.2 6906.7 6956.3 6979.8 11077.3 11137.6 11178.9 11299.7 11420.1 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5356.00 Median:6453.02 stddev:2772.89 (43.0%) stddev-sans-first:2764.17 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: Values: 1331.3 1702.7 1764.2 1771.8 1804.9 6693.3 7435.4 7578.1 7594.4 7594.6 7314.6 7550.3 7552.3 7556.1 7561.8 1986.1 2012.2 2160.4 2284.1 2306.8 2350.4 2355.7 2356.0 2357.2 2357.8 2263.0 2337.8 2338.0 2341.1 2343.7 1954.3 1967.6 2250.3 2302.0 2304.2 2298.6 2313.3 2330.5 2333.7 2337.7 7618.0 7683.1 7695.2 7701.9 7707.7 4573.7 4642.4 4657.6 4670.9 4682.2 2991.7 3044.6 3079.7 3089.1 3106.2 991.6 996.7 999.0 1030.4 1035.7 10531.2 10672.3 10696.6 10713.5 10713.9 4192.4 4218.2 4262.4 4363.4 4371.1 8615.4 8618.5 8623.7 8627.7 8635.0 4663.4 4693.4 4696.4 4698.7 4700.3 4218.5 4249.8 4251.6 4265.8 4267.0 3467.3 3504.7 3518.8 3526.6 3548.8 1088.4 1096.5 1103.9 1114.3 1115.6 954.2 1005.3 1271.9 1280.4 1283.9 7253.7 7303.7 7412.6 7454.9 7473.0 678.7 680.6 682.2 706.9 716.9 5700.0 5742.7 5748.5 5751.0 5754.3 9002.0 9033.2 9266.3 9403.1 9405.3 9131.4 9169.4 9242.2 9248.0 9263.4 7062.4 7175.2 7176.4 7201.5 7230.3 6852.5 6853.9 6858.2 6869.7 6873.6 7994.8 8112.0 8339.2 8344.6 8359.7 8306.5 8521.7 8523.0 8533.5 8548.1 6492.9 6506.6 6581.2 6606.1 6623.3 7189.5 7218.0 7239.5 7242.2 7242.6 6936.0 7065.8 7086.8 7202.3 7205.7 6932.3 6960.2 7025.6 7066.2 7093.6 6304.5 6432.8 6740.4 6887.7 6891.6 6117.9 6317.3 6343.5 6344.0 6348.3 6266.3 6428.7 6453.0 6453.1 6487.6 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,109 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5351.73 Median:6116.07 stddev:1623.68 (26.5%) stddev-sans-first:1583.75 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: Values: 322.9 328.3 334.3 339.7 340.9 6052.0 6059.9 6078.8 6091.9 6102.7 5756.3 5833.8 5858.4 5960.7 5970.8 4613.7 4626.3 4638.0 4638.9 4647.9 4390.7 4602.4 4636.9 4643.1 4643.1 4478.3 4478.3 4581.8 4582.5 4587.7 4537.1 4549.2 4560.9 4576.7 4597.5 4025.7 4033.2 4038.9 4045.1 4059.4 5501.7 5589.5 5631.1 5632.1 5634.1 5314.5 5320.9 5321.3 5330.3 5338.8 6311.5 6314.5 6332.3 6336.4 6340.5 4456.9 4458.6 4459.8 4467.8 4486.9 6476.3 6574.9 6582.4 6647.1 6682.0 4438.4 4468.2 4477.5 4479.3 4485.3 4521.6 4530.0 4533.3 4535.4 4548.7 5280.3 5283.6 5284.8 5285.1 5288.0 6249.6 6397.1 6413.9 6425.5 6442.9 1586.3 1605.1 1608.7 1609.5 1609.7 1055.7 1062.2 1064.5 1066.9 1077.1 6197.8 6208.9 6210.3 6213.4 6217.0 6610.1 6612.3 6612.4 6613.6 6618.9 6025.2 6129.4 6146.1 6269.8 6272.6 3574.6 3599.1 3602.5 3607.3 3607.4 6891.1 6892.8 6904.9 6912.2 6915.0 6609.5 6720.5 6771.5 6778.5 6785.3 6894.0 6899.5 6904.7 6908.1 6908.5 6626.5 6645.8 6648.3 6650.4 6658.4 6443.4 6599.3 6610.0 6610.8 6625.3 6895.0 6901.7 6909.6 6916.5 6917.0 4526.4 4564.0 4578.2 4579.1 4581.7 6488.4 6538.9 6543.7 6591.9 6612.5 6454.1 6463.4 6465.4 6469.5 6480.2 6387.0 6421.8 6446.3 6453.5 6459.5 6146.3 6308.3 6315.3 6353.5 6355.1 6494.8 6497.9 6499.6 6501.9 6502.7 6177.5 6308.6 6309.1 6309.3 6322.6 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13578.91 Median:46841.53 stddev:16322.05 (34.8%) stddev-sans-first:16339.22 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: Values: 708.8 709.4 791.9 830.2 860.3 13065.8 13341.5 13423.8 13431.7 13457.9 13095.5 13151.4 13151.6 13167.1 13172.3 677.9 693.2 822.0 836.6 837.2 832.4 832.4 837.3 837.8 839.3 870.2 871.6 871.8 874.5 876.0 705.4 715.7 853.5 865.2 865.7 635.0 636.1 638.5 638.9 639.0 13231.3 13517.4 13523.7 13568.9 13664.7 12438.4 12754.9 12845.8 12894.7 13388.4 9972.8 10008.2 10009.1 10019.5 10115.9 3284.8 3315.3 3373.2 3387.6 3418.7 43937.8 44196.1 44609.8 44865.3 44974.1 6833.4 6841.7 6949.0 7182.1 7242.3 12076.9 12541.6 12665.8 12710.0 12714.5 6943.2 7011.4 7034.1 7139.8 7205.1 4046.8 4195.2 4210.9 4211.6 4213.5 2810.9 2843.5 2844.0 2849.1 2851.9 437.7 445.7 451.2 452.2 459.8 566.2 625.5 626.0 628.1 642.3 7761.5 8115.3 8198.5 8239.3 8407.4 522.6 537.9 538.1 584.9 609.6 3592.4 3690.6 3729.6 3876.8 4196.8 56937.0 57327.7 57796.0 57856.7 58789.0 53296.0 54388.5 54826.7 54938.5 55281.7 47891.5 48507.3 48977.0 49558.5 49920.0 8216.8 8282.7 8316.3 8460.3 8480.6 36122.6 36306.0 36926.3 37072.0 37093.6 42255.8 46264.3 46413.3 46805.5 46877.5 8043.3 8096.1 8485.6 8490.8 8587.7 12055.4 12085.3 12139.8 12266.1 12381.3 10197.4 10269.8 10273.4 10449.1 10555.5 11307.4 11555.7 11569.7 11946.6 12092.3 11245.2 11374.1 11612.5 11657.3 11691.6 9869.6 9898.7 10015.8 10163.8 10497.9 9899.2 9933.7 9953.7 9985.9 9988.4 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:52:37 INFO - 2015-11-19 05:52:37,111 DEBUG : BROWSER_OUTPUT: 05:52:37 INFO - 2015-11-19 05:52:37,777 INFO : Browser exited with error code: 0 05:52:37 INFO - 2015-11-19 05:52:37,798 INFO : Completed test dromaeo_css (00:18:34) 05:52:37 INFO - 2015-11-19 05:52:37,799 INFO : Starting test kraken 05:52:37 INFO - 2015-11-19 05:52:37,799 DEBUG : operating with platform_type : linux_ 05:52:37 INFO - 2015-11-19 05:52:37,799 INFO : Initialising browser for kraken test... 05:52:37 INFO - 2015-11-19 05:52:37,805 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoKDSje/profile http://localhost:55482/getInfo.html 05:52:41 INFO - 2015-11-19 05:52:41,641 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:52:41 INFO - 2015-11-19 05:52:41,641 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:52:41 INFO - 2015-11-19 05:52:41,642 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:52:41 INFO - 2015-11-19 05:52:41,642 DEBUG : BROWSER_OUTPUT: __metrics 05:52:41 INFO - 2015-11-19 05:52:41,698 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:43 INFO - 2015-11-19 05:52:43,023 INFO : Browser initialized. 05:52:43 INFO - 2015-11-19 05:52:43,024 INFO : Running cycle 1/1 for kraken test... 05:52:43 INFO - 2015-11-19 05:52:43,024 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoKDSje/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:52:54 INFO - 2015-11-19 05:52:54,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 140431360 05:52:54 INFO - 2015-11-19 05:52:54,818 DEBUG : BROWSER_OUTPUT: 05:52:57 INFO - 2015-11-19 05:52:57,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:57 INFO - 2015-11-19 05:52:57,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 180641792 05:52:57 INFO - 2015-11-19 05:52:57,863 DEBUG : BROWSER_OUTPUT: 05:53:00 INFO - 2015-11-19 05:53:00,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-dft) 05:53:01 INFO - 2015-11-19 05:53:01,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 168038400 05:53:01 INFO - 2015-11-19 05:53:01,066 DEBUG : BROWSER_OUTPUT: 05:53:03 INFO - 2015-11-19 05:53:03,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-fft) 05:53:04 INFO - 2015-11-19 05:53:04,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 150986752 05:53:04 INFO - 2015-11-19 05:53:04,487 DEBUG : BROWSER_OUTPUT: 05:53:06 INFO - 2015-11-19 05:53:06,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55482/tests/kraken/driver.html?testName=audio-oscillator) 05:53:07 INFO - 2015-11-19 05:53:07,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 152682496 05:53:07 INFO - 2015-11-19 05:53:07,025 DEBUG : BROWSER_OUTPUT: 05:53:09 INFO - 2015-11-19 05:53:09,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:09 INFO - 2015-11-19 05:53:09,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 154570752 05:53:09 INFO - 2015-11-19 05:53:09,759 DEBUG : BROWSER_OUTPUT: 05:53:12 INFO - 2015-11-19 05:53:12,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:13 INFO - 2015-11-19 05:53:13,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 156708864 05:53:13 INFO - 2015-11-19 05:53:13,225 DEBUG : BROWSER_OUTPUT: 05:53:16 INFO - 2015-11-19 05:53:16,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55482/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:17 INFO - 2015-11-19 05:53:17,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 158027776 05:53:17 INFO - 2015-11-19 05:53:17,257 DEBUG : BROWSER_OUTPUT: 05:53:20 INFO - 2015-11-19 05:53:20,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55482/tests/kraken/driver.html?testName=json-parse-financial) 05:53:20 INFO - 2015-11-19 05:53:20,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 157110272 05:53:20 INFO - 2015-11-19 05:53:20,596 DEBUG : BROWSER_OUTPUT: 05:53:22 INFO - 2015-11-19 05:53:22,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:22 INFO - 2015-11-19 05:53:22,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 166699008 05:53:22 INFO - 2015-11-19 05:53:22,697 DEBUG : BROWSER_OUTPUT: 05:53:24 INFO - 2015-11-19 05:53:24,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:25 INFO - 2015-11-19 05:53:25,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 166060032 05:53:25 INFO - 2015-11-19 05:53:25,109 DEBUG : BROWSER_OUTPUT: 05:53:27 INFO - 2015-11-19 05:53:27,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:27 INFO - 2015-11-19 05:53:27,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 176066560 05:53:27 INFO - 2015-11-19 05:53:27,756 DEBUG : BROWSER_OUTPUT: 05:53:30 INFO - 2015-11-19 05:53:30,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:30 INFO - 2015-11-19 05:53:30,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 182980608 05:53:30 INFO - 2015-11-19 05:53:30,745 DEBUG : BROWSER_OUTPUT: 05:53:33 INFO - 2015-11-19 05:53:33,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:33 INFO - 2015-11-19 05:53:33,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 182091776 05:53:33 INFO - 2015-11-19 05:53:33,854 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55482/tests/kraken/driver.html?testName=ai-astar) 05:53:35 INFO - 2015-11-19 05:53:35,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 241061888 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;109;110;110;117;110;110;110;111 05:53:35 INFO - 2015-11-19 05:53:35,806 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;139;150;163;130;145;158;125;166;128 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;161;161;160;160;159;160;163;163;162 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;94;73;72;73;94;91;72 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;92;138;90;91;90;141;91;92;142 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;111;111;109;109;110;110;109 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;145;147;148;147;147;147;146;145 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;95;96;95;95 05:53:35 INFO - 2015-11-19 05:53:35,807 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;57;57;57;57;66;55;55 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;70;69;69;69;69 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;84;84;93;84;85;92;84 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;115;125;120;114;123;117;127;117;115 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;152;151;148;147;138;149;151;151;148 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;68;67;68;67;68;66;66;66 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:53:35 INFO - 2015-11-19 05:53:35,808 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: __startTimestamp1447941215800__endTimestamp 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,809 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:3.11 (2.8%) stddev-sans-first:3.30 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 109.0 110.0 110.0 117.0 110.0 110.0 110.0 111.0 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.00 stddev:14.60 (9.8%) stddev-sans-first:15.45 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: Values: 148.0 139.0 150.0 163.0 130.0 145.0 158.0 125.0 166.0 128.0 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.64 (1.0%) stddev-sans-first:1.41 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: Values: 164.0 161.0 161.0 160.0 160.0 159.0 160.0 163.0 163.0 162.0 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:79.50 stddev:10.02 (12.6%) stddev-sans-first:10.21 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 94.0 73.0 72.0 73.0 94.0 91.0 72.0 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,810 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:90.50 stddev:23.93 (26.4%) stddev-sans-first:24.70 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: Values: 90.0 92.0 138.0 90.0 91.0 90.0 141.0 91.0 92.0 142.0 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 111.0 111.0 109.0 109.0 110.0 110.0 109.0 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 145.0 147.0 148.0 147.0 147.0 147.0 146.0 145.0 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,811 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.10 (5.4%) stddev-sans-first:3.28 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 57.0 57.0 57.0 57.0 66.0 55.0 55.0 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.00 stddev:3.78 (4.5%) stddev-sans-first:3.79 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 84.0 84.0 93.0 84.0 85.0 92.0 84.0 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,812 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:118.50 stddev:4.79 (4.0%) stddev-sans-first:4.76 05:53:35 INFO - 2015-11-19 05:53:35,813 DEBUG : BROWSER_OUTPUT: Values: 114.0 115.0 125.0 120.0 114.0 123.0 117.0 127.0 117.0 115.0 05:53:35 INFO - 2015-11-19 05:53:35,813 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,813 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:150.00 stddev:5.17 (3.4%) stddev-sans-first:4.24 05:53:35 INFO - 2015-11-19 05:53:35,813 DEBUG : BROWSER_OUTPUT: Values: 138.0 152.0 151.0 148.0 147.0 138.0 149.0 151.0 151.0 148.0 05:53:35 INFO - 2015-11-19 05:53:35,813 DEBUG : BROWSER_OUTPUT: 05:53:35 INFO - 2015-11-19 05:53:35,814 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 05:53:35 INFO - 2015-11-19 05:53:35,814 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 67.0 68.0 67.0 68.0 66.0 66.0 66.0 05:53:35 INFO - 2015-11-19 05:53:35,814 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:53:35 INFO - 2015-11-19 05:53:35,814 DEBUG : BROWSER_OUTPUT: 05:53:36 INFO - 2015-11-19 05:53:36,681 INFO : Browser exited with error code: 0 05:53:36 INFO - 2015-11-19 05:53:36,737 INFO : Completed test kraken (00:00:58) 05:53:36 INFO - 2015-11-19 05:53:36,738 INFO : Starting test v8_7 05:53:36 INFO - 2015-11-19 05:53:36,738 DEBUG : operating with platform_type : linux_ 05:53:36 INFO - 2015-11-19 05:53:36,738 INFO : Initialising browser for v8_7 test... 05:53:36 INFO - 2015-11-19 05:53:36,744 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplvTnkU/profile http://localhost:55482/getInfo.html 05:53:40 INFO - 2015-11-19 05:53:40,665 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:40 INFO - 2015-11-19 05:53:40,666 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:40 INFO - 2015-11-19 05:53:40,666 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:53:40 INFO - 2015-11-19 05:53:40,666 DEBUG : BROWSER_OUTPUT: __metrics 05:53:40 INFO - 2015-11-19 05:53:40,843 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:42 INFO - 2015-11-19 05:53:42,063 INFO : Browser initialized. 05:53:42 INFO - 2015-11-19 05:53:42,063 INFO : Running cycle 1/1 for v8_7 test... 05:53:42 INFO - 2015-11-19 05:53:42,064 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplvTnkU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:53 INFO - 2015-11-19 05:53:53,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 140165120 05:53:53 INFO - 2015-11-19 05:53:53,861 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55482/tests/v8_7/run.html (next: http://localhost:55482/tests/v8_7/run.html) 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 554876928 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:54:15 INFO - 2015-11-19 05:54:15,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |0;Richards;162.46953696181967 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.5903872348706 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.0264064293915 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1943.6893203883494 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |5;Earley;798.8826815642458 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 05:54:15 INFO - 2015-11-19 05:54:15,536 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: |8;Splay;634.1154090044388 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1447941255527__endTimestamp 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:54:15 INFO - 2015-11-19 05:54:15,537 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.47 Median:162.47 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: Values: 162.5 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.59 Median:194.59 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: Values: 194.6 05:54:15 INFO - 2015-11-19 05:54:15,538 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.03 Median:287.03 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: Values: 287.0 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: Values: 5020.0 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1943.69 Median:1943.69 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,539 DEBUG : BROWSER_OUTPUT: Values: 1943.7 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.88 Median:798.88 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: Values: 798.9 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: Values: 12216.9 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,540 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: Values: 25692.3 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.12 Median:634.12 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: Values: 634.1 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:54:15 INFO - 2015-11-19 05:54:15,541 DEBUG : BROWSER_OUTPUT: 05:54:16 INFO - 2015-11-19 05:54:16,369 INFO : Browser exited with error code: 0 05:54:16 INFO - 2015-11-19 05:54:16,384 INFO : Completed test v8_7 (00:00:39) 05:54:16 INFO - 2015-11-19 05:54:16,521 INFO : Completed test suite (00:20:13) 05:54:16 INFO - 2015-11-19 05:54:16,521 DEBUG : Working with test: dromaeo_css 05:54:16 INFO - 2015-11-19 05:54:16,521 DEBUG : Generating results file: dromaeo_css 05:54:16 INFO - 2015-11-19 05:54:16,522 DEBUG : Working with test: kraken 05:54:16 INFO - 2015-11-19 05:54:16,522 DEBUG : Generating results file: kraken 05:54:16 INFO - 2015-11-19 05:54:16,523 INFO : javascript benchmark 05:54:16 INFO - 2015-11-19 05:54:16,523 DEBUG : Working with test: v8_7 05:54:16 INFO - 2015-11-19 05:54:16,523 DEBUG : Generating results file: v8_7 05:54:16 INFO - 2015-11-19 05:54:16,523 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:16 INFO - 2015-11-19 05:54:16,578 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:54:16 INFO - 2015-11-19 05:54:16,579 DEBUG : process_Request line: dromaeo_css 6694.95 graph.html#tests=[[72,1,35]] 05:54:16 INFO - 2015-11-19 05:54:16,579 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:16 INFO - 2015-11-19 05:54:16,614 DEBUG : process_Request line: kraken 1499.70 graph.html#tests=[[232,1,35]] 05:54:16 INFO - 2015-11-19 05:54:16,614 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:54:16 INFO - 2015-11-19 05:54:16,652 DEBUG : process_Request line: v8_7 19774.55 graph.html#tests=[[230,1,35]] 05:54:16 INFO - 2015-11-19 05:54:16,654 INFO : javascript benchmark 05:54:16 INFO - 2015-11-19 05:54:16,657 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.495920652696, 3257.2182676157713, 3291.588551431071, 3293.8353082345875, 3314.419976504111, 5225.085610018251, 5318.414974352818, 5419.078756611376, 5438.428964958677, 5472.452754724531, 5327.067763141454, 5340.49265319795, 5367.436419175979, 5377.085895397782, 5460.208269800876, 4940.901181976367, 4961.107000739866, 4973.552380285773, 4998.4751601081725, 5012.949870501303, 4802.59177969873, 5015.5486006259425, 5023.949760502403, 5079.847604571869, 5083.237514372855, 4885.6335774817035, 4951.0592987332475, 4960.603151747851, 4961.18140506816, 5006.324146240284, 4841.007593443371, 4863.392075990501, 4879.072976134523, 4902.803887844518, 4908.190148625473, 4840.080384726891, 4869.537393947569, 4876.878078048042, 4902.338184345139, 4974.825881094181, 5210.687358758487, 5298.417174110845, 5311.548518375943, 5312.521873031407, 5337.039332920072, 5880.235569375996, 5930.0, 5932.703364831785, 5934.881302373971, 5939.821805345847, 5643.435656434323, 5804.622699524517, 5824.097264923944, 5973.342932277446, 5995.760169593211, 5546.750396232179, 5557.166425036277, 5562.3047119110115, 5566.888662226733, 5601.859953501154, 6033.698315084228, 6035.185249991283, 6047.9395206047375, 6054.666993315322, 6057.666828324396, 5633.324001119892, 5648.237487939158, 5777.566682498829, 5796.130580412888, 5840.5035571976005, 5838.562107841929, 5844.240248767633, 5850.736716847752, 5853.765849365977, 5891.764329426861, 5833.7374818133285, 5835.503982161564, 5836.9124463133085, 5838.941610583925, 5845.795397161164, 5690.829275121753, 5706.686132262683, 5746.942530574641, 5746.9425305747245, 5839.357670656224, 4484.484284307281, 4515.5484451554585, 4539.931901021488, 4551.067031258584, 4584.037352156018, 4016.3172260715746, 4019.21625283067, 4025.2352053109817, 4026.1947610478023, 4031.3348297531165, 5318.282031925641, 5439.401665816757, 5446.782128714886, 5516.586256030814, 5560.972195138998, 5920.733566989496, 5920.911186332209, 5922.8815423691285, 5929.73316200772, 5930.377310382348, 5289.973550132302, 5576.024195765806, 5583.637063590853, 5586.413426590231, 5589.385167631557, 5022.372203474566, 5088.5420312171345, 5088.974555127201, 5096.847094587169, 5108.208227724708, 6081.726322315506, 6095.847603809941, 6101.96949015261, 6107.144999700045, 6108.9920163173465, 5761.5102716269585, 5906.940930590811, 5926.170336153028, 5939.762409503572, 5940.287165540163, 5909.23179986599, 5964.9105263420215, 6010.579259451972, 6033.879322413615, 6057.909131362945, 5814.3604203538425, 5816.185733997159, 5824.94175058244, 5843.532517398513, 5845.941540584539, 5697.7151142443545, 5886.05823068307, 5889.293284805851, 5907.616004959664, 5907.822765317047, 5690.601657883908, 5705.0, 5713.714314284352, 5795.043817770021, 5821.301443826768, 5706.229658995982, 5707.1724599933605, 5749.310082790092, 5751.683657398883, 5755.71221438918, 5506.944930550643, 5632.859178520406, 5648.406917273627, 5656.0, 5659.858503537444, 5685.0, 5697.971510142423, 5717.714114294352, 5796.94203057964, 5849.61977471463, 5661.603687741818, 5675.68783716883, 5676.091825308096, 5677.744501497526, 5727.369989301257], "unit": "ms", "name": "dojo.html", "value": 5394.075934024717}, {"lowerIsBetter": false, "replicates": [568.1080703295827, 586.074003075141, 596.3321080389964, 609.734765377061, 621.19244981524, 31273.84363078184, 40608.0, 40887.0, 40901.38647920283, 40953.38569921454, 41220.38169427461, 41699.58300416995, 41731.37402938951, 41787.58212417875, 41801.790991045076, 7612.847743045136, 7727.150013498539, 8510.44682095665, 8678.609462574168, 8683.739487815345, 10379.169666426706, 10604.0, 10608.416537090457, 10611.416372099531, 10629.84055239168, 10410.167186625053, 10451.0, 10503.422311772849, 10524.263301568893, 10533.947330263338, 7623.771286861403, 7764.37884969204, 10434.113100386476, 10524.15806735467, 10800.513976870981, 10246.9487652562, 10307.175425965905, 10369.170466362748, 10391.84412233817, 10397.584096636125, 39904.0, 40003.7999810002, 40301.59698403037, 40368.596314036775, 40432.39351409731, 3196.280836811722, 3231.951520727191, 3294.621118571371, 3301.4387554115856, 3651.519731984014, 30536.236594085105, 30746.692533074605, 30834.53748193779, 30878.536821947688, 31089.222769430944, 3586.910327241814, 3614.1461181762274, 3622.37601957179, 3628.147385364464, 3720.404735242348, 271029.0, 273271.0, 273355.0, 273804.0, 274380.0, 56074.71962640161, 56800.431995679515, 58145.0, 58639.0, 59170.40829591649, 56468.717656411456, 56925.0, 57061.42938570644, 57231.42768572344, 57287.71356143193, 13012.089153759336, 13060.542880999119, 13166.47334106625, 13274.867251327556, 13285.468581256835, 10909.618163364245, 10911.83632245517, 10918.23572349928, 10951.288166269167, 10961.0, 19329.80670193308, 19685.40943771689, 19717.309894153637, 19750.901245493682, 19826.90086549558, 7329.19378868324, 7506.1743208248145, 7511.8497630047095, 7534.698612055457, 7618.428617853683, 987.698751880669, 988.1699372527112, 1015.1827778638119, 1036.6786296248188, 1071.6999240212754, 27713.0, 28850.054066444303, 29013.56479652807, 29152.708472915423, 29169.687364068242, 1026.0556245913951, 1068.2842495528014, 1075.6282397313903, 1090.6182836007492, 1151.5624062856061, 14618.63453413652, 14716.705665886837, 14720.92639536817, 14776.187309698069, 14782.334794934253, 337946.0, 344420.0, 344765.0, 345355.0, 347462.0, 53187.734061329444, 53489.1976620351, 53519.0, 53539.464605354224, 53595.19607205817, 1168.3690806964144, 1235.6169587427926, 1236.8144778283329, 1337.6388375138852, 1337.7057047449546, 25966.221013369628, 27019.72980270172, 27178.0, 27253.0, 27819.582706259018, 42128.78935605425, 44572.0, 44583.10833783371, 44793.328100079176, 44820.0, 207665.0, 310771.0, 321168.0, 321775.0, 323933.0, 30072.097837064925, 30742.846285768428, 30773.23066923345, 30775.2306192347, 30800.53799192969, 41070.38394424146, 43197.0, 43198.0, 44241.0, 44273.77863110664, 36651.0, 37104.44343334798, 37734.0, 38135.80932095433, 38412.80793596126, 36298.49554651851, 37245.0, 37245.6275437253, 37398.626013739515, 37661.435078473296, 35586.82206588951, 36240.637593623724, 36885.0, 37064.0, 37157.071073223386, 31791.682083178872, 32836.179095522806, 32908.83545582257, 33318.333633326714, 33389.833050835565, 25252.621210681486, 25522.617160742233, 26075.348116297246, 26751.331216719736, 26919.461610767285], "unit": "ms", "name": "ext.html", "value": 18649.41488406329}, {"lowerIsBetter": false, "replicates": [344.2117550808648, 350.59856464348314, 351.9489673997272, 352.5733862026949, 357.19809028730504, 14077.155370677741, 14305.570832875004, 17020.489385318444, 17289.65420691587, 18912.43262702118, 15876.36494540217, 16683.416080437186, 16994.405195818148, 17191.140442977863, 17231.483055508354, 5385.272988146589, 5476.507114359707, 5497.0, 5498.092814685572, 5504.559635229192, 3974.0, 4099.0162361033435, 5454.072807622694, 5504.862378440531, 5947.0, 5960.463558279754, 5986.132010858445, 6010.038393856984, 6017.308009578889, 6025.9096113558335, 4742.051589682077, 4856.562909338177, 4861.440934292531, 4862.7568621569135, 5978.163057171978, 4178.809533314707, 4209.5579964103945, 4210.32634778434, 4212.157568486315, 4361.280388735887, 13456.327183640877, 13568.59294221175, 13789.862101379058, 13803.792943105762, 13888.375023123983, 2125.883076430796, 2159.9352019439443, 2175.1843058852774, 2182.7053347798, 2212.048819007826, 9998.250131240186, 10062.89937100627, 10086.798264034678, 10102.040306170902, 10282.280240383176, 1574.110627495473, 1666.2002238925263, 1678.0015890545105, 1715.4253325136094, 1724.3706047292774, 59193.40806591922, 61491.692541537006, 61713.0, 61714.074288885706, 61919.07121393183, 6900.930990690029, 6969.721211151598, 7016.2632923543315, 7102.147742270858, 7136.250693677193, 8573.74278771638, 8579.785505362292, 8584.699535516227, 8590.91409085901, 8591.871121933176, 5561.110222364483, 5597.804076857372, 5626.887462250814, 5682.460166284196, 5683.60214784961, 5638.97180514103, 5707.885842283131, 5711.0, 5735.369109397963, 5748.741306641211, 3301.7193538549013, 3310.0897253255066, 3315.1049216711353, 3336.5328853960464, 3344.2976974835556, 1114.6266000889793, 1121.85415895933, 1161.3786624156205, 1202.3387137074574, 1231.0766924806396, 469.89427378840173, 475.05701183151416, 475.9357486739315, 486.6325923927483, 492.6748346091562, 11375.374354410422, 11532.654020379403, 11752.58865939688, 11966.22219555726, 12551.497940082478, 473.1483330006044, 504.87882908102523, 505.3077284120778, 514.3288009148098, 530.0212804041236, 6538.869222615521, 6703.664816759143, 6857.074294970215, 6864.4165245954655, 6866.553674011173, 398126.0, 398337.0, 401007.0, 402069.0, 560753.0, 67822.0, 68401.65799170973, 71438.64280678668, 74247.25752742511, 78212.60893695494, 573.9770409183669, 585.9121131830345, 586.1647152807233, 586.560079940045, 588.4351023017865, 10659.360438373413, 10772.299800512941, 11037.392943388191, 11076.723081923017, 11395.658130256106, 33254.0, 33498.497522536694, 33710.32579348448, 34838.82580587081, 36908.44637330389, 44851.775741121084, 45895.31157032714, 46497.76751116223, 47804.7609761949, 50896.74551627218, 6681.69932353055, 6749.122614060338, 6776.356246156607, 6831.795046148623, 6847.383735463832, 12036.939815300868, 12156.149069565046, 12187.451564679433, 12253.509859605516, 12264.0, 10293.53679084458, 10454.947725261325, 10613.9469302653, 10627.415492148006, 10884.0, 10377.636782712569, 10608.734781630521, 10610.522526486173, 10655.733606659896, 10740.462976851282, 9194.49430281341, 9382.906170938477, 9667.226621870373, 11416.885831141582, 11565.826512602149, 6392.009238568029, 6882.174139103339, 6906.723731050702, 6956.2695916930015, 6979.755708550177, 11077.279976801483, 11137.55449782032, 11178.888211117785, 11299.661010169708, 11420.086393088366], "unit": "ms", "name": "jquery.html", "value": 7060.326475915763}, {"lowerIsBetter": false, "replicates": [1331.2811082015712, 1702.7360759082342, 1764.1532064608987, 1771.7519547263385, 1804.864635152363, 6693.330666933304, 7435.442341824364, 7578.090629124499, 7594.354479869204, 7594.582297973623, 7314.561126332411, 7550.282723141307, 7552.282533159355, 7556.131044929834, 7561.810954726135, 1986.0566231040284, 2012.1850650486504, 2160.4274867160216, 2284.132029828667, 2306.8039216666602, 2350.4123969007746, 2355.693759811231, 2356.0, 2357.1867705641525, 2357.7524359942217, 2262.954740905181, 2337.836351455399, 2337.9883100584557, 2341.1220792202926, 2343.7304709958316, 1954.3159894037044, 1967.5868067705799, 2250.336150835499, 2302.044651469638, 2304.2396009316885, 2298.5632729781287, 2313.34069790109, 2330.52224294021, 2333.6849525314205, 2337.672725818387, 7617.961910190469, 7683.116441609231, 7695.230476952316, 7701.922980770177, 7707.653155607955, 4573.679842411033, 4642.419697537808, 4657.580817726387, 4670.859874203746, 4682.180618391768, 2991.685872983327, 3044.58898048765, 3079.6766339534474, 3089.119600913729, 3106.223444138965, 991.5686676295834, 996.7059717383389, 999.0259496990449, 1030.443560477349, 1035.694470131313, 10531.210159238011, 10672.306300090548, 10696.572137114506, 10713.517891694892, 10713.946430267877, 4192.434021407071, 4218.240716671029, 4262.360645903077, 4363.38912552243, 4371.0820727646915, 8615.353848461391, 8618.525981070976, 8623.698170564126, 8627.6980305689, 8634.956825215959, 4663.440387153563, 4693.389859318267, 4696.38946936896, 4698.694584851974, 4700.271457923959, 4218.451601291812, 4249.830006799693, 4251.617354438115, 4265.829366825355, 4266.978665106654, 3467.2718729066673, 3504.7196224301993, 3518.806465644363, 3526.559180102487, 3548.7693299935936, 1088.357868857378, 1096.5230124895695, 1103.8730545987314, 1114.331401159298, 1115.5593540551438, 954.2413781044087, 1005.2812239248826, 1271.9046071544672, 1280.36621872172, 1283.9358032098357, 7253.709851605982, 7303.671334789948, 7412.555246685216, 7454.85090298191, 7473.0, 678.6878036103448, 680.6018479189729, 682.2461180395592, 706.8586282743369, 716.9354758071798, 5700.0, 5742.684152371659, 5748.45389687979, 5750.971245143831, 5754.338251101093, 9002.0, 9033.232175265044, 9266.258699304039, 9403.059694030679, 9405.294602904809, 9131.406458580172, 9169.35814492979, 9242.21441177494, 9248.028956959557, 9263.397879137834, 7062.364387205176, 7175.174854891754, 7176.354128128389, 7201.495895287279, 7230.276972302833, 6852.45180385558, 6853.862922741617, 6858.211305699909, 6869.725210991704, 6873.621950792754, 7994.800129996796, 8112.02655681322, 8339.166083391612, 8344.624491898001, 8359.707410240613, 8306.460080094774, 8521.744347669579, 8523.019852716769, 8533.53065581399, 8548.059713431394, 6492.902606460812, 6506.642134682638, 6581.243157036811, 6606.075149479173, 6623.3376662333385, 7189.460790440842, 7217.963910180625, 7239.457040721862, 7242.203357630762, 7242.637868106468, 6935.965320173367, 7065.823354415975, 7086.751963681247, 7202.279772022755, 7205.675744591611, 6932.306769323028, 6960.234374218933, 7025.613591252531, 7066.152061752623, 7093.6453177341955, 6304.495640348669, 6432.839179020375, 6740.393364597014, 6887.7244910203035, 6891.552049116792, 6117.908231376444, 6317.273513546001, 6343.492520598434, 6343.968280158754, 6348.269948955929, 6266.279377871603, 6428.710708018244, 6452.967735161482, 6453.064305675557, 6487.643179624977], "unit": "ms", "name": "mootools.html", "value": 4372.219280269119}, {"lowerIsBetter": false, "replicates": [322.9224986003359, 328.34331337325347, 334.26128256553017, 339.6790033418421, 340.86706184588, 6051.9697401512985, 6059.909101363478, 6078.817635470932, 6091.878162436748, 6102.725377358019, 5756.251687280658, 5833.82498525045, 5858.41415858414, 5960.701964901748, 5970.761169553223, 4613.746243956581, 4626.329182268569, 4638.0491999140095, 4638.907221855561, 4647.86056418308, 4390.714603550775, 4602.424696912886, 4636.86089417318, 4643.094596553673, 4643.117807616542, 4478.261086920655, 4478.305862591304, 4581.79381927814, 4582.518835522272, 4587.747673877935, 4537.137943790669, 4549.181147393468, 4560.8859778505475, 4576.656750743708, 4597.494275629678, 4025.657819085381, 4033.2135233629456, 4038.9192216155807, 4045.110075783323, 4059.3505039193883, 5501.697406642633, 5589.524890384322, 5631.0708733059, 5632.098864181711, 5634.098544232944, 5314.4951229633125, 5320.946790532123, 5321.281626980347, 5330.253764472977, 5338.759755810997, 6311.52663550231, 6314.494840412756, 6332.33510481402, 6336.366363363627, 6340.492760579143, 4456.910861782779, 4458.598726114633, 4459.777011149462, 4467.82128714851, 4486.8878278042985, 6476.287608363124, 6574.868502629968, 6582.440492558138, 6647.135872336614, 6681.966590167018, 4438.378626992224, 4468.151051300242, 4477.485089214782, 4479.328100784908, 4485.282354823213, 4521.61566266871, 4530.026044400403, 4533.274676051882, 4535.387722657465, 4548.658850586153, 5280.287161233261, 5283.550898173621, 5284.7886084556185, 5285.101532739443, 5287.995280896695, 6249.593776404519, 6397.136386587844, 6413.903791443132, 6425.485961123099, 6442.903356449657, 1586.294099125901, 1605.1011433597223, 1608.6702226043633, 1609.4769200010044, 1609.6700176463796, 1055.6938487838595, 1062.18211976779, 1064.4784055812595, 1066.8826429092794, 1077.0737166037202, 6197.81406557804, 6208.875822483525, 6210.254769427697, 6213.440790328892, 6217.0, 6610.140681711443, 6612.338766123446, 6612.404883560503, 6613.570117942319, 6618.900716489256, 6025.15647809307, 6129.417705317987, 6146.108814221912, 6269.843253918597, 6272.5922815016875, 3574.6425357464564, 3599.1182160370877, 3602.5496812898386, 3607.332643460968, 3607.3506768781344, 6891.138607674041, 6892.828219202747, 6904.896426553606, 6912.170539535288, 6914.965425172842, 6609.471242300604, 6720.462363010947, 6771.4582833373215, 6778.491613129035, 6785.287544807823, 6894.0, 6899.517033807585, 6904.689288982008, 6908.1364829396325, 6908.481863860231, 6626.469882409299, 6645.800625981228, 6648.268690443951, 6650.401463868275, 6658.43403310724, 6443.420092191725, 6599.340065993554, 6610.0, 6610.8347291318105, 6625.304343043911, 6894.965525172543, 6901.654917254017, 6909.619970901648, 6916.515843890879, 6917.0, 4526.366308716716, 4563.977180114078, 4578.221702310549, 4579.061292434976, 4581.679282450196, 6488.383603557654, 6538.869222615616, 6543.70553325092, 6591.868162636816, 6612.537122401578, 6454.128692626623, 6463.418292353711, 6465.353464653497, 6469.514786390945, 6480.189976252968, 6386.9680651596445, 6421.839454013687, 6446.323136070832, 6453.45145662624, 6459.547831651739, 6146.262448506208, 6308.306086330408, 6315.3053164152825, 6353.52348573868, 6355.078513615592, 6494.805155845143, 6497.902531462127, 6499.642519661464, 6501.934980650133, 6502.674866256573, 6177.536684748572, 6308.558400911892, 6309.1167236586, 6309.337519560564, 6322.589031712924], "unit": "ms", "name": "prototype.html", "value": 4820.237201927674}, {"lowerIsBetter": false, "replicates": [708.787363790863, 709.3934685843607, 791.9010123734533, 830.1739768929914, 860.2773670117102, 13065.804012939814, 13341.466341346359, 13423.798643020338, 13431.7313653727, 13457.865421345808, 13095.54165604204, 13151.408186631601, 13151.605451836436, 13167.144135631177, 13172.34138293084, 677.945764338853, 693.2235895796715, 822.0382152881114, 836.573347592726, 837.1544739812803, 832.3549249331755, 832.3923535818856, 837.2506606587101, 837.815680550278, 839.3159574946429, 870.1733353314345, 871.6208449324532, 871.7515508080198, 874.4884242718017, 876.023234093987, 705.428602831708, 715.7029832619456, 853.5390888920007, 865.2429124516049, 865.7143142762936, 634.9619022858597, 636.07133584966, 638.5370606310388, 638.9297177310492, 638.9680515974183, 13231.272280024596, 13517.391717372742, 13523.661908452268, 13568.932155339258, 13664.65838354039, 12438.378081096, 12754.872451275554, 12845.807312890314, 12894.67763305925, 13388.397522111529, 9972.800543989151, 10008.249381296431, 10009.099181073665, 10019.549120289605, 10115.898841011569, 3284.7584823998736, 3315.270640459095, 3373.1567108222944, 3387.6104248011547, 3418.743594230418, 43937.78031109856, 44196.11607767826, 44609.77695111504, 44865.32702009472, 44974.100517989784, 6833.384995350442, 6841.692123854438, 6948.965255173692, 7182.066331376992, 7242.311980361963, 12076.879231207751, 12541.56104536355, 12665.810012849815, 12710.0, 12714.491420343267, 6943.166819981635, 7011.439084873198, 7034.085568876116, 7139.785806425815, 7205.135383753878, 4046.838126474967, 4195.181939521825, 4210.894727631834, 4211.599898009684, 4213.536510983789, 2810.889698569054, 2843.5308174151446, 2844.033028770187, 2849.102532702192, 2851.871665775045, 437.6608128700283, 445.66797735687123, 451.19011374582703, 452.1567277028384, 459.7586267209742, 566.1705601294042, 625.4777260987036, 625.9874802504015, 628.0986783965025, 642.3063091860779, 7761.4566980311965, 8115.310198633064, 8198.467099638505, 8239.340852731768, 8407.369447291356, 522.5949888836107, 537.8735997040692, 538.1389776357875, 584.9122631605209, 609.5702529716539, 3592.3713350163616, 3690.557133143986, 3729.627037296303, 3876.7867767272505, 4196.81114349855, 56937.0, 57327.71336143293, 57796.0, 57856.71071644699, 58789.0, 53296.0, 54388.456115439134, 54826.72586637041, 54938.450615494134, 55281.72359138259, 47891.521084789405, 48507.272390914164, 48977.0, 49558.50441495611, 49920.00639948795, 8216.794580135544, 8282.697479828716, 8316.334693224648, 8460.280876125598, 8480.618372173143, 36122.63877361193, 36306.0, 36926.261474770894, 37072.0, 37093.6290637101, 42255.7887210562, 46264.30603540882, 46413.3038004437, 46805.531944680115, 46877.53122468868, 8043.316318113026, 8096.109427962801, 8485.575721214038, 8490.800968214253, 8587.720567326143, 12055.397230138282, 12085.274883507018, 12139.757204855678, 12266.080043996915, 12381.257124572554, 10197.388156710622, 10269.794604108025, 10273.383596984206, 10449.111825494918, 10555.52500137511, 11307.434628268718, 11555.711107222387, 11569.710757231136, 11946.641600751991, 12092.334921579397, 11245.156613253876, 11374.146938979775, 11612.535498579962, 11657.300561966309, 11691.590794322157, 9869.555869985725, 9898.653547125816, 10015.849762253427, 10163.796724065329, 10497.9475102624, 9899.1585715215, 9933.701988940344, 9953.701388958343, 9985.900140998498, 9988.350757200758], "unit": "ms", "name": "yui.html", "value": 6015.440821127069}], "name": "dromaeo_css", "value": 6694.946249251077}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 109.0, 110.0, 110.0, 117.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 139.0, 150.0, 163.0, 130.0, 145.0, 158.0, 125.0, 166.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 160.0, 160.0, 159.0, 160.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 94.0, 73.0, 72.0, 73.0, 94.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 138.0, 90.0, 91.0, 90.0, 141.0, 91.0, 92.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 111.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 145.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 66.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 84.0, 84.0, 93.0, 84.0, 85.0, 92.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 125.0, 120.0, 114.0, 123.0, 117.0, 127.0, 117.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [138.0, 152.0, 151.0, 148.0, 147.0, 138.0, 149.0, 151.0, 151.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 67.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1499.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.46953696181967], "unit": "score", "name": "Richards", "value": 217.28381000000007}, {"lowerIsBetter": false, "replicates": [194.5903872348706], "unit": "score", "name": "DeltaBlue", "value": 339.780402}, {"lowerIsBetter": false, "replicates": [287.0264064293915], "unit": "score", "name": "Encrypt", "value": 927.3746040000002}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [1943.6893203883494], "unit": "score", "name": "RayTrace", "value": 380.7136213786215}, {"lowerIsBetter": false, "replicates": [798.8826815642458], "unit": "score", "name": "Earley", "value": 834.2438951048953}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [634.1154090044388], "unit": "score", "name": "Splay", "value": 128.51130700000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19774.5512950327}]} 05:54:16 INFO - RETURN: dromaeo_css: 6694.95 05:54:16 INFO - RETURN: kraken: 1499.70 05:54:16 INFO - RETURN: v8_7: 19774.55 05:54:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19774.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6694.95"}}} 05:54:16 INFO - Return code: 0 05:54:16 INFO - # TBPL SUCCESS # 05:54:16 INFO - Running post-action listener: _resource_record_post_action 05:54:16 INFO - Running post-run listener: _resource_record_post_run 05:54:17 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501751808; Read time: 376; Write time: 699712 05:54:17 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 134115328; Read time: 0; Write time: 292556 05:54:17 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311275520; Read time: 376; Write time: 355008 05:54:17 INFO - Running post-run listener: _upload_blobber_files 05:54:17 INFO - Blob upload gear active. 05:54:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:54:17 INFO - Copying logs to upload dir... 05:54:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1300.634620 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2015-11-19 05:54:17.552408) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 05:54:17.555432) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010029 build_url: 'https://queue.taskcluster.net/v1/task/t4BCKR2TQICXWQQunOtFDQ/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-19 05:54:17.605948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:54:17.606277) ========= 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=c402a24d74c70935940d60dd000001de-1447939475.892384-2014822068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 05:54:17.655885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 05:54:17.656258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 05:54:17.656548) ========= ========= Total master_lag: 0.23 =========