builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1448883093.42 results: success (0) buildid: 20151130013011 builduid: d6daec82e0c54a36aeb996b5670fff1f revision: 36a37b7451a56bee00cce0c318a8c5a485fd370e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.424536) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.424927) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.425205) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006452 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.457725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.457995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.534080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.534369) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.587821) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.588082) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.588409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.588681) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-30 03:31:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-11-30 03:31:35 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180188 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.797119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.797458) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.848673) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:33.849105) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 36a37b7451a56bee00cce0c318a8c5a485fd370e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 36a37b7451a56bee00cce0c318a8c5a485fd370e --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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-30 03:31:35,452 truncating revision to first 12 chars 2015-11-30 03:31:35,452 Setting DEBUG logging. 2015-11-30 03:31:35,452 attempt 1/10 2015-11-30 03:31:35,452 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/36a37b7451a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-30 03:31:35,766 unpacking tar archive at: mozilla-inbound-36a37b7451a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935782 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:34.799366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:34.799683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:34.808164) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:34.808482) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-30 03:31:34.808931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-30 03:31:34.809216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:36 INFO - MultiFileLogger online at 20151130 03:31:36 in /builds/slave/test-pgo 03:31:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:31:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:31:36 INFO - {'append_to_log': False, 03:31:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:31:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:31:36 INFO - 'branch': 'Mozilla-Inbound', 03:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:36 INFO - 'config_files': ('talos/linux_config.py',), 03:31:36 INFO - 'default_actions': ('clobber', 03:31:36 INFO - 'read-buildbot-config', 03:31:36 INFO - 'download-and-extract', 03:31:36 INFO - 'populate-webroot', 03:31:36 INFO - 'create-virtualenv', 03:31:36 INFO - 'install', 03:31:36 INFO - 'run-tests'), 03:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:36 INFO - 'download_minidump_stackwalk': True, 03:31:36 INFO - 'download_symbols': 'ondemand', 03:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:36 INFO - 'installer_path': 'installer.exe', 03:31:36 INFO - 'log_level': 'info', 03:31:36 INFO - 'log_name': 'talos', 03:31:36 INFO - 'log_to_console': True, 03:31:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:36 INFO - 'opt_config_files': (), 03:31:36 INFO - 'pip_index': False, 03:31:36 INFO - 'sps_profile': False, 03:31:36 INFO - 'sps_profile_interval': 0, 03:31:36 INFO - 'suite': 'dromaeojs-e10s', 03:31:36 INFO - 'system_bits': '64', 03:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:36 INFO - 'title': 'talos-linux64-ix-044', 03:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:36 INFO - 'use_talos_json': True, 03:31:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:36 INFO - 'work_dir': 'build'} 03:31:36 INFO - ##### 03:31:36 INFO - ##### Running clobber step. 03:31:36 INFO - ##### 03:31:36 INFO - Running pre-action listener: _resource_record_pre_action 03:31:36 INFO - Running main action method: clobber 03:31:36 INFO - rmtree: /builds/slave/test-pgo/build 03:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - ##### 03:31:37 INFO - ##### Running read-buildbot-config step. 03:31:37 INFO - ##### 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: read_buildbot_config 03:31:37 INFO - Using buildbot properties: 03:31:37 INFO - { 03:31:37 INFO - "properties": { 03:31:37 INFO - "buildnumber": 193, 03:31:37 INFO - "product": "firefox", 03:31:37 INFO - "script_repo_revision": "production", 03:31:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 03:31:37 INFO - "repository": "", 03:31:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 03:31:37 INFO - "buildid": "20151130013011", 03:31:37 INFO - "slavename": "talos-linux64-ix-044", 03:31:37 INFO - "pgo_build": "True", 03:31:37 INFO - "basedir": "/builds/slave/test-pgo", 03:31:37 INFO - "project": "", 03:31:37 INFO - "platform": "ubuntu64_hw", 03:31:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:37 INFO - "slavebuilddir": "test", 03:31:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:31:37 INFO - "branch": "mozilla-inbound", 03:31:37 INFO - "repo_path": "integration/mozilla-inbound", 03:31:37 INFO - "stage_platform": "linux64-pgo", 03:31:37 INFO - "builduid": "d6daec82e0c54a36aeb996b5670fff1f", 03:31:37 INFO - "revision": "36a37b7451a56bee00cce0c318a8c5a485fd370e" 03:31:37 INFO - }, 03:31:37 INFO - "sourcestamp": { 03:31:37 INFO - "repository": "", 03:31:37 INFO - "hasPatch": false, 03:31:37 INFO - "project": "", 03:31:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:31:37 INFO - "changes": [ 03:31:37 INFO - { 03:31:37 INFO - "category": null, 03:31:37 INFO - "files": [ 03:31:37 INFO - { 03:31:37 INFO - "url": null, 03:31:37 INFO - "name": "https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:31:37 INFO - } 03:31:37 INFO - ], 03:31:37 INFO - "repository": "", 03:31:37 INFO - "rev": "36a37b7451a56bee00cce0c318a8c5a485fd370e", 03:31:37 INFO - "who": "sendchange", 03:31:37 INFO - "when": 1448883042, 03:31:37 INFO - "number": 6720637, 03:31:37 INFO - "comments": "", 03:31:37 INFO - "project": "", 03:31:37 INFO - "at": "Mon 30 Nov 2015 03:30:42", 03:31:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 03:31:37 INFO - "revlink": "", 03:31:37 INFO - "properties": [ 03:31:37 INFO - [ 03:31:37 INFO - "buildid", 03:31:37 INFO - "20151130013011", 03:31:37 INFO - "Change" 03:31:37 INFO - ], 03:31:37 INFO - [ 03:31:37 INFO - "builduid", 03:31:37 INFO - "d6daec82e0c54a36aeb996b5670fff1f", 03:31:37 INFO - "Change" 03:31:37 INFO - ], 03:31:37 INFO - [ 03:31:37 INFO - "pgo_build", 03:31:37 INFO - "True", 03:31:37 INFO - "Change" 03:31:37 INFO - ] 03:31:37 INFO - ], 03:31:37 INFO - "revision": "36a37b7451a56bee00cce0c318a8c5a485fd370e" 03:31:37 INFO - } 03:31:37 INFO - ], 03:31:37 INFO - "revision": "36a37b7451a56bee00cce0c318a8c5a485fd370e" 03:31:37 INFO - } 03:31:37 INFO - } 03:31:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:31:37 INFO - Running post-action listener: _resource_record_post_action 03:31:37 INFO - ##### 03:31:37 INFO - ##### Running download-and-extract step. 03:31:37 INFO - ##### 03:31:37 INFO - Running pre-action listener: _resource_record_pre_action 03:31:37 INFO - Running main action method: download_and_extract 03:31:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:31: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')]} 03:31:37 INFO - https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/test_packages.json 03:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/test_packages.json 03:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:31:39 INFO - Downloaded 1302 bytes. 03:31:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:31:39 INFO - Using the following test package requirements: 03:31:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'jsshell-linux-x86_64.zip'], 03:31:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:31:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:31:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:31:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:31:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:39 INFO - https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:41 INFO - Downloaded 22764694 bytes. 03:31:41 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 03:31:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:41 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 03:31:42 INFO - Return code: 0 03:31:42 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 03:31:42 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')]} 03:31:42 INFO - https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:44 INFO - Downloaded 22764694 bytes. 03:31:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:31:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:31:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:31:46 INFO - Return code: 0 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:47 INFO - Downloaded 11131970 bytes. 03:31:47 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 03:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:31:47 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 03:31:47 INFO - Return code: 0 03:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:47 INFO - https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0fOnldHcTGq3lAahUnCJEQ/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 03:31:50 INFO - Downloaded 58436633 bytes. 03:31:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:31:50 INFO - mkdir: /builds/slave/test-pgo/properties 03:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:31:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:31:50 INFO - Contents: 03:31:50 INFO - build_url:https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:31:50 INFO - Running post-action listener: _resource_record_post_action 03:31:50 INFO - Running post-action listener: set_extra_try_arguments 03:31:50 INFO - ##### 03:31:50 INFO - ##### Running populate-webroot step. 03:31:50 INFO - ##### 03:31:50 INFO - Running pre-action listener: _resource_record_pre_action 03:31:50 INFO - Running main action method: populate_webroot 03:31:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:31:50 INFO - '../fennec_ids.txt'], 03:31:50 INFO - 'tests': ['tcheck2']}, 03:31:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:50 INFO - '--tppagecycles', 03:31:50 INFO - '7'], 03:31:50 INFO - 'tests': ['tsvgm']}}, 03:31:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:31:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:31:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:31:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'tests': ['damp', 'tps']}, 03:31:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['damp', 'tps']}, 03:31:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:31:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:50 INFO - 'other': {'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'other_l64': {'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'other_nol64': {'tests': ['a11yr', 03:31:50 INFO - 'ts_paint', 03:31:50 INFO - 'tpaint', 03:31:50 INFO - 'sessionrestore', 03:31:50 INFO - 'sessionrestore_no_auto_restore']}, 03:31:50 INFO - 'svgr': {'tests': ['tsvgx', 03:31:50 INFO - 'tsvgr_opacity', 03:31:50 INFO - 'tart', 03:31:50 INFO - 'tscrollx', 03:31:50 INFO - 'cart']}, 03:31:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['tsvgx', 03:31:50 INFO - 'tsvgr_opacity', 03:31:50 INFO - 'tart', 03:31:50 INFO - 'tscrollx', 03:31:50 INFO - 'cart']}, 03:31:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'tests': ['tp5o']}, 03:31:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'talos_options': ['--e10s'], 03:31:50 INFO - 'tests': ['tp5o']}, 03:31:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'talos_options': ['--xperf_path', 03:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:50 INFO - 'tests': ['tp5n']}, 03:31:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:50 INFO - 'talos_options': ['--e10s', 03:31:50 INFO - '--xperf_path', 03:31:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:50 INFO - 'tests': ['tp5n']}}, 03:31:50 INFO - 'talos.zip': {'path': '', 03:31:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:50 INFO - Running post-action listener: _resource_record_post_action 03:31:50 INFO - ##### 03:31:50 INFO - ##### Running create-virtualenv step. 03:31:50 INFO - ##### 03:31:50 INFO - Running pre-action listener: _resource_record_pre_action 03:31:50 INFO - Running main action method: create_virtualenv 03:31:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:31:50 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 03:31:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:31:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:50 INFO - Using real prefix '/usr' 03:31:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:53 INFO - Installing pip.................done. 03:31:53 INFO - Return code: 0 03:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:31:53 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')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:31:53 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 03:31:53 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 03:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 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 03:31:53 INFO - Cleaning up... 03:31:53 INFO - Return code: 0 03:31:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:31:53 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')]} 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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')]} 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:53 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 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:31:53 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 03:31:53 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 03:31:53 INFO - Using env: {'DISPLAY': ':0', 03:31:53 INFO - 'HOME': '/home/cltbld', 03:31:53 INFO - 'LANG': 'en_US.UTF-8', 03:31:53 INFO - 'LANGUAGE': 'en_US:en', 03:31:53 INFO - 'LOGNAME': 'cltbld', 03:31:53 INFO - 'MAIL': '/var/mail/cltbld', 03:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:53 INFO - 'MOZ_NO_REMOTE': '1', 03:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:53 INFO - 'NO_EM_RESTART': '1', 03:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:31:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:31:53 INFO - 'SHELL': '/bin/bash', 03:31:53 INFO - 'SHLVL': '1', 03:31:53 INFO - 'TERM': 'linux', 03:31:53 INFO - 'TMOUT': '86400', 03:31:53 INFO - 'USER': 'cltbld', 03:31:53 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:53 INFO - '_': '/tools/buildbot/bin/python'} 03:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:53 INFO - Downloading/unpacking psutil>=0.7.1 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:53 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 03:31:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:31:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:55 INFO - Installing collected packages: psutil 03:31:55 INFO - Running setup.py install for psutil 03:31:55 INFO - building 'psutil._psutil_linux' extension 03:31:55 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 03:31:55 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 03:31:55 INFO - building 'psutil._psutil_posix' extension 03:31:55 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 03:31:55 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 03:31:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:55 INFO - Successfully installed psutil 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:31:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:31:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:31:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:31:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:31:58 INFO - Installing collected packages: mozsystemmonitor 03:31:58 INFO - Running setup.py install for mozsystemmonitor 03:31:59 INFO - Successfully installed mozsystemmonitor 03:31:59 INFO - Cleaning up... 03:31:59 INFO - Return code: 0 03:31:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:31:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:31:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:59 INFO - Using env: {'DISPLAY': ':0', 03:31:59 INFO - 'HOME': '/home/cltbld', 03:31:59 INFO - 'LANG': 'en_US.UTF-8', 03:31:59 INFO - 'LANGUAGE': 'en_US:en', 03:31:59 INFO - 'LOGNAME': 'cltbld', 03:31:59 INFO - 'MAIL': '/var/mail/cltbld', 03:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:59 INFO - 'MOZ_NO_REMOTE': '1', 03:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:59 INFO - 'NO_EM_RESTART': '1', 03:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:31:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:31:59 INFO - 'SHELL': '/bin/bash', 03:31:59 INFO - 'SHLVL': '1', 03:31:59 INFO - 'TERM': 'linux', 03:31:59 INFO - 'TMOUT': '86400', 03:31:59 INFO - 'USER': 'cltbld', 03:31:59 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:59 INFO - '_': '/tools/buildbot/bin/python'} 03:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:32:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:32:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:01 INFO - Downloading docopt-0.6.1.tar.gz 03:32:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:32:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:01 INFO - Running setup.py install for blobuploader 03:32:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:32:01 INFO - Running setup.py install for requests 03:32:02 INFO - Running setup.py install for docopt 03:32:02 INFO - Successfully installed blobuploader requests docopt 03:32:02 INFO - Cleaning up... 03:32:02 INFO - Return code: 0 03:32:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:32:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:32:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:02 INFO - Using env: {'DISPLAY': ':0', 03:32:02 INFO - 'HOME': '/home/cltbld', 03:32:02 INFO - 'LANG': 'en_US.UTF-8', 03:32:02 INFO - 'LANGUAGE': 'en_US:en', 03:32:02 INFO - 'LOGNAME': 'cltbld', 03:32:02 INFO - 'MAIL': '/var/mail/cltbld', 03:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:02 INFO - 'MOZ_NO_REMOTE': '1', 03:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:02 INFO - 'NO_EM_RESTART': '1', 03:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:02 INFO - 'SHELL': '/bin/bash', 03:32:02 INFO - 'SHLVL': '1', 03:32:02 INFO - 'TERM': 'linux', 03:32:02 INFO - 'TMOUT': '86400', 03:32:02 INFO - 'USER': 'cltbld', 03:32:02 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:02 INFO - '_': '/tools/buildbot/bin/python'} 03:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:32:02 INFO - Running setup.py (path:/tmp/pip-wnu5MW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:32:02 INFO - Running setup.py (path:/tmp/pip-6JDYqI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:32:02 INFO - Running setup.py (path:/tmp/pip-PRfopX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:32:02 INFO - Running setup.py (path:/tmp/pip-MjKsw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:32:02 INFO - Running setup.py (path:/tmp/pip-xRckX1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:32:02 INFO - Running setup.py (path:/tmp/pip-f2z9Kz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:32:02 INFO - Running setup.py (path:/tmp/pip-mhiN8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:32:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:32:02 INFO - Running setup.py (path:/tmp/pip-y2b2b9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:32:03 INFO - Running setup.py (path:/tmp/pip-VNNaIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:32:03 INFO - Running setup.py (path:/tmp/pip-AJ7kmk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:32:03 INFO - Running setup.py (path:/tmp/pip-Zppv16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:32:03 INFO - Running setup.py (path:/tmp/pip-434JXD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:32:03 INFO - Running setup.py (path:/tmp/pip-qloA8p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:32:03 INFO - Running setup.py (path:/tmp/pip-aeyfnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:32:03 INFO - Running setup.py (path:/tmp/pip-JsmmVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:32:03 INFO - Running setup.py (path:/tmp/pip-9TxgfI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:32:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:32:03 INFO - Running setup.py (path:/tmp/pip-0q6Gz9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:03 INFO - Running setup.py install for manifestparser 03:32:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:32:03 INFO - Running setup.py install for mozcrash 03:32:03 INFO - Running setup.py install for mozdebug 03:32:03 INFO - Running setup.py install for mozdevice 03:32:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for mozfile 03:32:04 INFO - Running setup.py install for mozhttpd 03:32:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for mozinfo 03:32:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for mozInstall 03:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for mozleak 03:32:04 INFO - Running setup.py install for mozlog 03:32:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for moznetwork 03:32:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:32:04 INFO - Running setup.py install for mozprocess 03:32:04 INFO - Running setup.py install for mozprofile 03:32:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:32:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:32:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:32:05 INFO - Running setup.py install for mozrunner 03:32:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:32:05 INFO - Running setup.py install for mozscreenshot 03:32:05 INFO - Running setup.py install for moztest 03:32:05 INFO - Running setup.py install for mozversion 03:32:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:32:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:05 INFO - Cleaning up... 03:32:05 INFO - Return code: 0 03:32:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:32:05 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 03:32:05 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 03:32:05 INFO - Using env: {'DISPLAY': ':0', 03:32:05 INFO - 'HOME': '/home/cltbld', 03:32:05 INFO - 'LANG': 'en_US.UTF-8', 03:32:05 INFO - 'LANGUAGE': 'en_US:en', 03:32:05 INFO - 'LOGNAME': 'cltbld', 03:32:05 INFO - 'MAIL': '/var/mail/cltbld', 03:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:05 INFO - 'MOZ_NO_REMOTE': '1', 03:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:05 INFO - 'NO_EM_RESTART': '1', 03:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:05 INFO - 'SHELL': '/bin/bash', 03:32:05 INFO - 'SHLVL': '1', 03:32:05 INFO - 'TERM': 'linux', 03:32:05 INFO - 'TMOUT': '86400', 03:32:05 INFO - 'USER': 'cltbld', 03:32:05 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:05 INFO - '_': '/tools/buildbot/bin/python'} 03:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:32:05 INFO - Running setup.py (path:/tmp/pip-IwzZ0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:32:05 INFO - Running setup.py (path:/tmp/pip-uWk9wV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:32:05 INFO - Running setup.py (path:/tmp/pip-c72YpB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:32:05 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)) 03:32:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:32:05 INFO - Running setup.py (path:/tmp/pip-WvkRUn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:32:06 INFO - Running setup.py (path:/tmp/pip-y0BJc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:32:06 INFO - Running setup.py (path:/tmp/pip-q8BQpO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:32:06 INFO - Running setup.py (path:/tmp/pip-N8qpoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:32:06 INFO - Running setup.py (path:/tmp/pip-NfVISZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:32:06 INFO - Running setup.py (path:/tmp/pip-R_zevy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:32:06 INFO - Running setup.py (path:/tmp/pip-a8oUH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:32:06 INFO - Running setup.py (path:/tmp/pip-t4tyWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:32:06 INFO - Running setup.py (path:/tmp/pip-B2QfkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:32:06 INFO - Running setup.py (path:/tmp/pip-gAr3T8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:32:06 INFO - Running setup.py (path:/tmp/pip-2vfL3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:32:06 INFO - Running setup.py (path:/tmp/pip-iIk2t4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:32:06 INFO - Running setup.py (path:/tmp/pip-wh5i3M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:32:06 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)) 03:32:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:32:06 INFO - Running setup.py (path:/tmp/pip-DraxvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:32:06 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)) 03:32:06 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)) 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:32:06 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)) 03:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:32:06 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)) 03:32:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:06 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 03:32:06 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 03:32:06 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 03:32:06 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 03:32:06 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 03:32:06 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 03:32:08 INFO - Downloading blessings-1.5.1.tar.gz 03:32:08 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 03:32:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:08 INFO - Installing collected packages: blessings 03:32:08 INFO - Running setup.py install for blessings 03:32:08 INFO - Successfully installed blessings 03:32:08 INFO - Cleaning up... 03:32:08 INFO - Return code: 0 03:32:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:32:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:32:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:32:09 INFO - Reading from file tmpfile_stdout 03:32:09 INFO - Current package versions: 03:32:09 INFO - argparse == 1.2.1 03:32:09 INFO - blessings == 1.5.1 03:32:09 INFO - blobuploader == 1.2.4 03:32:09 INFO - docopt == 0.6.1 03:32:09 INFO - manifestparser == 1.1 03:32:09 INFO - mozInstall == 1.12 03:32:09 INFO - mozcrash == 0.16 03:32:09 INFO - mozdebug == 0.1 03:32:09 INFO - mozdevice == 0.47 03:32:09 INFO - mozfile == 1.2 03:32:09 INFO - mozhttpd == 0.7 03:32:09 INFO - mozinfo == 0.9 03:32:09 INFO - mozleak == 0.1 03:32:09 INFO - mozlog == 3.1 03:32:09 INFO - moznetwork == 0.27 03:32:09 INFO - mozprocess == 0.22 03:32:09 INFO - mozprofile == 0.27 03:32:09 INFO - mozrunner == 6.11 03:32:09 INFO - mozscreenshot == 0.1 03:32:09 INFO - mozsystemmonitor == 0.0 03:32:09 INFO - moztest == 0.7 03:32:09 INFO - mozversion == 1.4 03:32:09 INFO - psutil == 3.1.1 03:32:09 INFO - requests == 1.2.3 03:32:09 INFO - wsgiref == 0.1.2 03:32:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:32:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:32:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:32:09 INFO - Using env: {'DISPLAY': ':0', 03:32:09 INFO - 'HOME': '/home/cltbld', 03:32:09 INFO - 'LANG': 'en_US.UTF-8', 03:32:09 INFO - 'LANGUAGE': 'en_US:en', 03:32:09 INFO - 'LOGNAME': 'cltbld', 03:32:09 INFO - 'MAIL': '/var/mail/cltbld', 03:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:09 INFO - 'MOZ_NO_REMOTE': '1', 03:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:09 INFO - 'NO_EM_RESTART': '1', 03:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:09 INFO - 'SHELL': '/bin/bash', 03:32:09 INFO - 'SHLVL': '1', 03:32:09 INFO - 'TERM': 'linux', 03:32:09 INFO - 'TMOUT': '86400', 03:32:09 INFO - 'USER': 'cltbld', 03:32:09 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:09 INFO - '_': '/tools/buildbot/bin/python'} 03:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:32:09 INFO - Cleaning up... 03:32:09 INFO - Return code: 0 03:32:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:32:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:32:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:09 INFO - Using env: {'DISPLAY': ':0', 03:32:09 INFO - 'HOME': '/home/cltbld', 03:32:09 INFO - 'LANG': 'en_US.UTF-8', 03:32:09 INFO - 'LANGUAGE': 'en_US:en', 03:32:09 INFO - 'LOGNAME': 'cltbld', 03:32:09 INFO - 'MAIL': '/var/mail/cltbld', 03:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:09 INFO - 'MOZ_NO_REMOTE': '1', 03:32:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:09 INFO - 'NO_EM_RESTART': '1', 03:32:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:09 INFO - 'SHELL': '/bin/bash', 03:32:09 INFO - 'SHLVL': '1', 03:32:09 INFO - 'TERM': 'linux', 03:32:09 INFO - 'TMOUT': '86400', 03:32:09 INFO - 'USER': 'cltbld', 03:32:09 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:09 INFO - '_': '/tools/buildbot/bin/python'} 03:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:09 INFO - Downloading/unpacking jsonschema 03:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:32:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:32:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:11 INFO - warning: no files found matching '*.txt' 03:32:11 INFO - no previously-included directories found matching 'build' 03:32:11 INFO - no previously-included directories found matching 'dist' 03:32:11 INFO - no previously-included directories found matching '.git*' 03:32:11 INFO - Installing collected packages: jsonschema, functools32 03:32:11 INFO - Running setup.py install for functools32 03:32:11 INFO - warning: no files found matching '*.txt' 03:32:11 INFO - no previously-included directories found matching 'build' 03:32:11 INFO - no previously-included directories found matching 'dist' 03:32:11 INFO - no previously-included directories found matching '.git*' 03:32:11 INFO - Successfully installed jsonschema functools32 03:32:11 INFO - Cleaning up... 03:32:11 INFO - Return code: 0 03:32:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:32:11 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')]} 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:11 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')]} 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:11 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8b9cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, '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': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', '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 03:32:11 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', 'flake8'] in /builds/slave/test-pgo/build 03:32:11 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 flake8 03:32:11 INFO - Using env: {'DISPLAY': ':0', 03:32:11 INFO - 'HOME': '/home/cltbld', 03:32:11 INFO - 'LANG': 'en_US.UTF-8', 03:32:11 INFO - 'LANGUAGE': 'en_US:en', 03:32:11 INFO - 'LOGNAME': 'cltbld', 03:32:11 INFO - 'MAIL': '/var/mail/cltbld', 03:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:11 INFO - 'MOZ_NO_REMOTE': '1', 03:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:11 INFO - 'NO_EM_RESTART': '1', 03:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:11 INFO - 'SHELL': '/bin/bash', 03:32:11 INFO - 'SHLVL': '1', 03:32:11 INFO - 'TERM': 'linux', 03:32:11 INFO - 'TMOUT': '86400', 03:32:11 INFO - 'USER': 'cltbld', 03:32:11 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:11 INFO - '_': '/tools/buildbot/bin/python'} 03:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:11 INFO - Downloading/unpacking flake8 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:32:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:32:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:32:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:32:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:32:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:13 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 03:32:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:32:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:32:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:14 INFO - no previously-included directories found matching 'docs/_build' 03:32:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:32:14 INFO - Running setup.py install for pep8 03:32:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:32:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:32:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:32:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:32:14 INFO - no previously-included directories found matching 'docs/_build' 03:32:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:32:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:32:14 INFO - Cleaning up... 03:32:14 INFO - Return code: 0 03:32:14 INFO - Running post-action listener: _resource_record_post_action 03:32:14 INFO - Running post-action listener: _start_resource_monitoring 03:32:14 INFO - Starting resource monitoring. 03:32:14 INFO - ##### 03:32:14 INFO - ##### Running install step. 03:32:14 INFO - ##### 03:32:14 INFO - Running pre-action listener: _resource_record_pre_action 03:32:14 INFO - Running main action method: install 03:32:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:32:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:32:14 INFO - Reading from file tmpfile_stdout 03:32:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:32:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:32:14 INFO - Reading from file tmpfile_stdout 03:32:14 INFO - Output received: 03:32:14 INFO - Usage: mozinstall [options] installer 03:32:14 INFO - Options: 03:32:14 INFO - -h, --help show this help message and exit 03:32:14 INFO - -d DEST, --destination=DEST 03:32:14 INFO - Directory to install application into. [default: 03:32:14 INFO - "/builds/slave/test-pgo"] 03:32:14 INFO - --app=APP Application being installed. [default: firefox] 03:32:14 INFO - mkdir: /builds/slave/test-pgo/build/application 03:32:14 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'] 03:32:14 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 03:32:29 INFO - Reading from file tmpfile_stdout 03:32:29 INFO - Output received: 03:32:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:32:29 INFO - Running post-action listener: _resource_record_post_action 03:32:29 INFO - ##### 03:32:29 INFO - ##### Running run-tests step. 03:32:29 INFO - ##### 03:32:29 INFO - Running pre-action listener: _resource_record_pre_action 03:32:29 INFO - Running main action method: run_tests 03:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:32:29 INFO - Python 2.7.3 03:32:29 INFO - Return code: 0 03:32:29 INFO - grabbing minidump binary from tooltool 03:32: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')]} 03:32:29 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 0x111aa50>, '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 0x1086550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10869e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:32:29 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 03:32:29 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 03:32:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:29 INFO - Return code: 0 03:32:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:32:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:32:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:32:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:32:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:32:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:32:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:32:30 INFO - Return code: 0 03:32:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:32:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost 03:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test-pgo', 03:32:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost'] with output_timeout 3600 03:32:30 INFO - mozversion INFO | application_buildid: 20151130013011 03:32:30 INFO - mozversion INFO | application_changeset: 36a37b7451a56bee00cce0c318a8c5a485fd370e 03:32:30 INFO - mozversion INFO | application_display_name: Nightly 03:32:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:30 INFO - mozversion INFO | application_name: Firefox 03:32:30 INFO - mozversion INFO | application_remotingname: firefox 03:32:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:32:30 INFO - mozversion INFO | application_vendor: Mozilla 03:32:30 INFO - mozversion INFO | application_version: 45.0a1 03:32:30 INFO - mozversion INFO | platform_buildid: 20151130013011 03:32:30 INFO - mozversion INFO | platform_changeset: 36a37b7451a56bee00cce0c318a8c5a485fd370e 03:32:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:32:30 INFO - mozversion INFO | platform_version: 45.0a1 03:32:30 INFO - 2015-11-30 03:32:30,505 DEBUG : using testdate: 1448883150 03:32:30 INFO - 2015-11-30 03:32:30,505 DEBUG : actual date: 1448883150 03:32:30 INFO - 2015-11-30 03:32:30,553 INFO : starting webserver on 'localhost:35997' 03:32:30 INFO - 2015-11-30 03:32:30,554 INFO : Starting test suite talos-linux64-ix-044.e 03:32:30 INFO - 2015-11-30 03:32:30,554 INFO : Starting test dromaeo_css 03:32:30 INFO - 2015-11-30 03:32:30,555 DEBUG : operating with platform_type : linux_ 03:32:30 INFO - 2015-11-30 03:32:30,555 INFO : Initialising browser for dromaeo_css test... 03:32:30 INFO - 2015-11-30 03:32:30,571 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpun1ZCh/profile http://localhost:35997/getInfo.html 03:32:35 INFO - 2015-11-30 03:32:35,647 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:32:35 INFO - 2015-11-30 03:32:35,647 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:32:35 INFO - 2015-11-30 03:32:35,647 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:32:35 INFO - 2015-11-30 03:32:35,647 DEBUG : BROWSER_OUTPUT: __metrics 03:32:36 INFO - 2015-11-30 03:32:36,731 INFO : Browser initialized. 03:32:36 INFO - 2015-11-30 03:32:36,731 INFO : Running cycle 1/1 for dromaeo_css test... 03:32:36 INFO - 2015-11-30 03:32:36,732 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpun1ZCh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:32:48 INFO - 2015-11-30 03:32:48,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 140693504 03:32:48 INFO - 2015-11-30 03:32:48,511 DEBUG : BROWSER_OUTPUT: 03:33:38 INFO - 2015-11-30 03:33:38,116 DEBUG : BROWSER_OUTPUT: 1448883218114 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] 03:35:47 INFO - 2015-11-30 03:35:47,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35997/tests/dromaeo/cssquery-ext.html) 03:35:48 INFO - 2015-11-30 03:35:48,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 149606400 03:35:48 INFO - 2015-11-30 03:35:48,718 DEBUG : BROWSER_OUTPUT: 03:38:50 INFO - 2015-11-30 03:38:50,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-ext.html (next: http://localhost:35997/tests/dromaeo/cssquery-jquery.html) 03:38:51 INFO - 2015-11-30 03:38:51,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 142368768 03:38:51 INFO - 2015-11-30 03:38:51,151 DEBUG : BROWSER_OUTPUT: 03:41:52 INFO - 2015-11-30 03:41:52,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35997/tests/dromaeo/cssquery-mootools.html) 03:41:53 INFO - 2015-11-30 03:41:53,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 143261696 03:41:53 INFO - 2015-11-30 03:41:53,329 DEBUG : BROWSER_OUTPUT: 03:44:54 INFO - 2015-11-30 03:44:54,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35997/tests/dromaeo/cssquery-prototype.html) 03:44:55 INFO - 2015-11-30 03:44:55,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 142127104 03:44:55 INFO - 2015-11-30 03:44:55,572 DEBUG : BROWSER_OUTPUT: 03:47:57 INFO - 2015-11-30 03:47:57,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35997/tests/dromaeo/cssquery-yui.html) 03:47:58 INFO - 2015-11-30 03:47:58,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 143175680 03:47:58 INFO - 2015-11-30 03:47:58,410 DEBUG : BROWSER_OUTPUT: 03:51:00 INFO - 2015-11-30 03:51:00,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/dromaeo/cssquery-yui.html (next: http://localhost:35997/tests/dromaeo/cssquery-dojo.html) 03:51:01 INFO - 2015-11-30 03:51:01,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 145477632 03:51:01 INFO - 2015-11-30 03:51:01,128 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,129 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:51:01 INFO - 2015-11-30 03:51:01,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:51:01 INFO - 2015-11-30 03:51:01,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:51:01 INFO - 2015-11-30 03:51:01,130 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:51:01 INFO - 2015-11-30 03:51:01,131 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3209.935801283974;3234.401635697396;3278.803271803691;3283.326917981814;3318.2202182487094;5358.544523715479;5524.530414914732;5525.392206857243;5540.085885828838;5559.11054231323;5393.325834270716;5545.861353466155;5555.3611334696425;5609.382967873541;5649.548036157108;5051.444341122483;5150.896982060356;5203.2975548301065;5216.139337009407;5227.686338819664;5052.141136006888;5056.14045612245;5164.251183578379;5183.196604526304;5193.766280517386;4844.297576851354;5004.649674522785;5027.648064635477;5040.798368065273;5108.948910510884;5140.7172605506685;5142.434332223453;5145.073886700392;5147.6654017488745;5148.330717006766;5044.142495775727;5048.974755126201;5068.062408454448;5070.822521211777;5102.056119617845;5247.501487358695;5288.603354748371;5339.092354299778;5378.650387724785;5389.137737961907;6037.516998640142;6051.939480605181;6052;6052.485538729214;6088.634681919099;5702.6293290935955;6100.755969761204;6102.755889764404;6116.938830611682;6131.9386806131815;5436.891262174774;5515.255440515519;5596;5606.24315717377;5638.661680299154;6034.275886893601;6091.2081429414775;6122.142899994004;6136.20229370179;6145.5698101133385;5770.076787713946;5941.346451890288;5950.494207992283;5956.612820166675;5974.790882319185;5836.824895253149;5874.618149820333;5926.140709597084;5933.02105152645;5943.31651860033;5923.555733320019;5955.612885162451;5956.970215148896;5958.136070269787;5974;5938.287405511366;5947.613405128653;5955.225820643375;6020.849478763066;6070.817875463743;4605.65457590682;4632.953670463252;4658.930116048262;4672.766361681903;4681.227597446451;4116.670666346685;4124.711270211116;4125.23683118624;4132.33882578786;4147.315692910636;5593.916091258634;5651.745671444794;5720.971395142998;5763.423657634203;5829.795957141479;6085.391460853968;6100.328963813977;6135.386461353918;6136.846578835475;6157.476614487819;5522.66863988162;5810.31500864753;5811.3316968548315;5814.738336774855;5838.357780644125;5226.608004399685;5227.059129356752;5231.921521177185;5241.449647786927;5244.501772331622;6109.435031337442;6237.095621135;6243.562950593415;6245.437910587978;6274.717637706314;6013.338532761481;6037.275526936795;6055.485283750754;6077.756889724362;6108.144859719554;6064;6098.969505152446;6138.183846674873;6164.229471316085;6166.876662466636;5800.564957628279;5897.144913987534;5907.793227237026;5912.526997840248;6022.789202377896;5984.102384642339;5991.221141251609;5992.970035149797;6045.939540604713;6077.179580756718;5793.102069179284;5842.970785146047;5851.414858514115;5856;5986.161937328865;5951.404859514014;5959.314678811992;5993;6001.979663457136;6013.368596297326;5864.765409383577;5871.442212989759;5879.617824841372;5880.8235752927485;5886;5844.444777746107;5957.404259574181;5959.67221802805;6035.39646035393;6094.329623741296;5856.267966504187;5867.647941123546;5884.58807883444;5894;5898.203742494708 03:51:01 INFO - 2015-11-30 03:51:01,131 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.1901374896232;590.509876802254;601.2664549249915;605.8818530386576;611.1901730207476;39033;39423.80288098559;39550.20899582007;39840.60159398405;39996;42485.362719559234;42961.78519107408;43059.56940430595;43099.3535096973;43341.34987975175;8603.870941935877;8732;8737.7815554611;8765.956170219171;8795.296376289882;8508.106648801879;8663.610137543825;8679.609417576192;8681.522516261603;8698.913010869905;8691.826163476726;8786.384953053288;8794.6921857735;8795.472271663688;8797.912020879805;8677.522736249504;8722.38943273971;8723.38936274461;8724.214820666139;8745.212930836224;8518.74443766688;8676.956615216946;8681.2186903179;8684;8686.391952563323;40345;40553;40576.79711601423;40696;40821;3132.577102091234;3228.402745492068;3312.9171770705684;3458.723302135823;3995.440638310639;29274.414511709645;29618.70381296181;29888.402231955457;30113.849430752707;30736.692633073606;3742.348704820624;3820.503334566489;3862.2661694278;3901.7854018028997;3903.6877049835944;258515.9999999981;259956;260137;261129;261136;41469;41737.58262417337;42150;57375.71312143413;57641.42358576361;41600.37599436011;41753.1649367011;41856.58143418527;42075.78962105231;42157.78921105436;14055.929720351538;14163.575092747235;14230.928845355707;14235.572932812032;14281.14313141215;11301.15241356885;11440.656780296604;11536.826947595793;11570.42147892602;11594.536218551331;14445.277736113152;14445.566633001026;14447.85552144486;14473.348699308346;14494.202818845064;5753.913691294634;5754.115971719157;5897.410258974154;5914.491804589802;5926.525877929756;925.6390007896925;953.4517652349926;1029.2897900448816;1062.5909025025421;1079.8056349857102;25366;25388.492230155294;25452.363690907874;25600.48799024009;25681.22956311314;1069.727219559023;1075.4837677914645;1093.3986307530827;1118.681175864891;1124.7694222684331;13767.862321376859;13862;14073.155610663393;14094.718105638034;14160.787588186186;318542;323131;323644;326470;327661;49696.751516242184;50009.749951250014;50236.748816255684;50275.497245027815;50312.24531632029;1317.3808310094241;1321.9206847588982;1328.3955800110925;1332.946682132704;1341.1349679456696;24232.636510452005;24995.87502062478;25362.112326068498;25424;25466;43940.78029609832;44268.01587857108;44365;44462.11075778531;44492;295956;297735;298560;299348;300383;31898.6810131905;46102;46193.76903115597;46580.53419465762;46703.766481167375;43391.34912976371;43681;43808.34287485754;44053.33919991267;44368.11263774771;37020.88865987541;37410.8129459351;37701.62298377091;38206.61793382142;38538.421923671725;36970.336334864456;37038.62961370352;37518.812405937795;37706.43440348342;37896.43155352617;31916.68083319137;31969.200769980936;31990.040298791075;32008.6799132015;32068.35863282768;32144.19639509031;33165;34006;34075.65924340725;37179.442308365935;24469.75530244746;24523.38691532726;24785.50428991446;24963.251102466955;25116.49767004686 03:51:01 INFO - 2015-11-30 03:51:01,132 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.48414025872876;360.66998696192985;366.4649611567111;366.6113919245598;367.05849496042663;16517.770101036356;17130.91434542827;17674.734878976826;17782.377616783433;18280.908595457004;11308.547658093667;12439;16206.35174593015;16219.945703529262;16233.91883040586;5037.62217833663;5459.535939445152;5461.5357694595805;5470.097433923398;5475.890482190353;5405.972970135143;5444.700541470237;5462.371827239878;5465.180222966547;5475.972620136894;4450.577195166454;5144.151215049513;5310.840674779763;5588.189712491686;5591.6365436246715;4328.329108988112;5296.470352964711;5299;5320;5326.6537675050995;5192.273081768555;5358.169483729989;5369.62412631116;5374.543163831079;5385.730713464351;12728.936355318257;12934.48262069516;17196.57008574783;20637;20926;2037.768906851963;2048.6107639548586;2105.5999360121527;2150.537634408594;2201.438633148537;9568.712938611852;9861.950690246575;12248.203866748721;12716.919061879751;13386.397612107381;1770.1326350088364;1795.425463851568;1798.082977681379;1821.289697018164;1851.0374605205218;58580;59784;61232.693836530976;61978;63293.36706632921;9984.750381240527;10297.17622590191;10370.688879333633;10375.688729338131;10393.53229104692;13138;13221.669458263621;13241.337933103307;13292.667683307995;13407.128536645087;7353.4484913631695;7557.130929943017;7562.205968373351;7636.160022397532;7816.921830781733;7339.559626422431;7361.079865016873;7382.815429614196;7686.231376862381;7749.883751743729;4426.313921342197;4434.379186913835;4449.065696203768;4454.465464144323;4477.574630410106;1823.079344930828;1873.7938826729048;1881.2192939929776;1883.50087226885;1899.9620007599772;430.85781692041553;439.0669826618436;450.2975358440843;459.8459516062157;465.1302065138146;10270.897291027144;10975.890241097486;11076.390798505998;11123.499442525106;11133.332000080021;448.8272015274143;456.63925498856196;946.5314669238771;952.9332946693664;953.6900507335143;8930.419522731001;9389.859152112724;9433.76415589602;10009.499525023719;10081.949590252001;519130;526049;529475;537534;539323;76902.61548692333;77208;78472;78680.21319786728;79142;1161.9419029048513;1168.7311918258847;1170.9355985420714;1185.6502331812137;1188.6909403555137;14905.180215087841;15072.397104116151;15084.849151508344;15111.848881511483;15443.84556154424;34357.48463773095;34473.48289775706;34612.82693586516;35219.295614088085;35417.82291088528;46719.29921051255;48543.271850921556;49135.50864491309;49256;49689.503104968484;9318.860217096613;9658.227341812779;9697.22422206236;9720.125188733047;9799.51002449889;11335.489902954221;15035.54893353201;17242.396516121877;17278;17331.826681733524;14429.134251944917;14633;14654.267286635839;14686.926565367105;14855.777163342775;14435.278236088363;14641;14797.964142509922;14942.103473791607;15111.848881511045;14683.92658036703;14687.70624587481;14694;14722.337494812546;14864.75743784412;9745.610175592898;9817.116459518678;9845.60617575289;9871.259655526008;9912.900870991198;11599.478023488795;14227.146371217346;14374.568762937128;14475.27623618836;14537.636559086108 03:51:01 INFO - 2015-11-30 03:51:01,134 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1561.5315405378399;1696.2706036404347;1758.2527425844014;1772.3087995681688;1795.8922464652114;7610.467267291285;7922.762317130495;8071.51570905746;8079.192080791932;8097.676092956282;8019.358451323895;8046.798830029237;8110.959445202766;8136.023677158749;8137.593120343989;2285.382946604416;2316.9536609267802;2336.707911511061;2346.425125844162;2347.424880904181;2322.7328857181387;2356.375560476475;2371.833971621987;2371.95256094878;2376.5009348036933;2285.0745448093467;2325.7092863392077;2337.322176568793;2341.6019276723;2346.4251258441705;2264.3772962435296;2316.4787922717423;2324.8837558122195;2343.215022967308;2349.647552867075;2340.6840076589615;2362.4802543440587;2368.834181607288;2372.0867466025534;2377.5720370333333;7909.644066017043;7948.602569871541;7951.522908625443;7952.483088599222;7969.561674107922;4761.095391875532;4806.927896081562;4840.564349208553;4853.733044682576;4868.488808675109;3241;3282.048206020251;3348.7488438366977;3349.1961929137074;3359.160209947513;1077.1167642533126;1082.10726150925;1111.4053981120062;1113.4766659670024;1123.3821398230941;10837.970392812671;10957.83563246544;10998.12015038795;11009.779804403866;11030.117590592734;4226.535081141072;4258.850940217078;4308;4402.911941761211;4435.933460998088;8758.605862736193;8799.25206357454;8836.469811811312;8841.381103322705;8845.955770221108;4799.3760811094335;4803.879903002383;4819.903601927942;4842.104210721028;4847.491013443538;4398.714083584557;4426.15902978433;4444.799984000728;4452.554744525586;4466.553344665573;3482.982585087109;3519.4720791881423;3580.838862251205;3584.121890136933;3595.3168897909313;1069.7860427914447;1083.967480975572;1086.2613422872364;1092.2736380307008;1194.7849387110405;1055.984160237597;1093.0654290581597;1096.6819622309602;1213.83006379107;1305.9542915997895;7502.624868756649;7549;7584.051993500812;7601.923980760122;7625.923740762521;1052.315994603514;1086.6522712732008;1160.709822544364;1164.4643464006483;1175.647305808254;5879.2944846618675;5882.176495290662;5933.910991335047;5954.434328738763;5958.106284057426;9296.628134874529;9393.859092113624;9399;9593.232541396672;9607.375520591138;9386.953065234768;9390.060993900555;9406.90593094074;9466.432014079177;9512.904870951203;7092.680829362691;7218.314260145278;7222.422206223489;7289.781306560812;7455.813604659818;7286.927130728837;7378.262173782578;7396.630168491662;7440.888386674313;7451.105867295959;8456.788580285296;8515.233628973423;8535.573221339033;8594.226519613265;8669;8534.146585341416;8609.48343099416;8613.82772344537;8666.956665216634;8732.476051436934;7092.361687448154;7094.503384763224;7149.964250178716;7175.390091842252;7177.031100801325;7469.477136600386;7504.8499030018;7525.134609519975;7609.162992070978;7610.315071643357;7124.679389427384;7180.856382872209;7189.532680375759;7203.063601731741;7233.457490688114;7078.433725302067;7136.821579460555;7148.571085734872;7201.459890508338;7248.492605517563;7246.311600397954;7281.1262648482525;7288.562686238843;7291.41668666516;7299.598522081336;6600.339966003361;6666.633335166418;6676.532642714963;6682.398584127452;6689.264180939996;6390.64851433157;6445.8388540285;6453.51598630114;6470.935290647033;6478.902816457663 03:51:01 INFO - 2015-11-30 03:51:01,134 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.40527051307646;339.9201187720886;340.0326072324237;340.5776836722465;345.84782695613944;6263.937360626393;6321;6327.841803954898;6341.143945567353;6363.936360636392;6086.7869624563145;6217.906731399022;6237.844053898655;6238.532110091739;6280.5289603279825;4737.478877323491;4745.145873742725;4753.287006948968;4754.714717116975;4761.857144285677;4754.6434017448655;4761.357216775743;4773.045390921812;4775.068861571995;4777.116233496814;4622.491525932145;4736.71579705217;4740.620750339965;4745.6915300505525;4759.167145749498;4711.269753188261;4717.646176536757;4733.408323959505;4733.4793172751315;4745.976270118645;4108.219438306712;4121.216968775923;4124.1957818225455;4132.504099508048;4134.276501612206;5863.032599621058;5907.232059832238;5925.081612350093;5926.051831706906;5932.673702946337;5412.56699464042;5490.313710786152;5534.75093620784;5549.445055494459;5553.0837411827;6658.434033107192;6659;6660;6663.866722665568;6669.666516674147;4571.9085618287445;4572.245579479382;4573.382593349888;4575.885602859922;4584.4957054723955;6745.797626071226;6906.136732908387;6917.827054323632;6929.203141638725;6933.653317334113;4662.673612847068;4671.813127474863;4700.7179569225955;4709.034647897173;4718.976405117953;4761.047790441926;4765.26138448541;4770.904581908342;4781.784819683123;4783.354247176656;5525.309336332958;5540.861478463071;5542.473465020817;5543.584231182677;5561.416051314553;6598.802035938834;6670.199576050905;6677.9666101670155;6683.198016238082;6703.832404189837;1623.6037008172962;1658.5687721192576;1661.509854592898;1661.9750703739453;1687.0130973380465;1085.1318944844093;1087.6247694545368;1098.5990113608475;1099.6755956992706;1106.8727096384018;6405.423511883952;6419.6197817469465;6434.517411194179;6440.098386225932;6454.19322584677;6837.897431538531;6849.452043836481;6851.794446166623;6865.656717164122;6875.106236189264;6393.104965304861;6406.519511036691;6425.742970281136;6436.356364363526;6441.484681225491;3801.82891769871;3826.9234615308096;3827.3302172119766;3830.5977872323006;3832.405977073558;7114.608696521637;7139.82150446243;7156.534825236343;7175.103112110986;7230.313120253568;7003.789886303419;7118.216996130422;7156.284371562906;7160.248173941765;7168.677409516585;7223.494355395177;7223.638818059076;7224.819379515554;7232.92767072333;7250.129984401906;6941.409980151744;6950.65246737651;6953.478489113236;6955.339242771928;6976.895346569704;6741.696623652046;6873.931260687529;6888.311168883071;6903.378695917391;6922.653867306715;7160.606166660884;7191.532550384418;7197.604131772803;7198.064251647462;7212.062431883822;4616.49218585962;4658.487566367765;4658.8136474542;4661.953380466152;4662.743549104832;6880.311968803079;6993.055937448379;6993.860122797414;6999.580025198505;7004.789856304319;6774.356436138559;6788.25329213796;6791;6792.320767923366;6806.523543351917;6776.695048722918;6783.457323414016;6789.049533065276;6798.592084474947;6801.829954251183;6552.148220731275;6646.105859830119;6649.368310010541;6654.767083152066;6664.133662623828;6779.15260592426;6784.3554862288;6786.049953006682;6801.795946121624;6811.114555107804;6557.2131344239;6593.80218593443;6614;6620.271770105188;6640.83397915056 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.5724650716556;781.6638845296527;848.7156802471172;868.439856292691;890.7550423633502;13770.862291377083;14039.649008774786;14053.789193162098;14083.929580352109;14181.290935453224;12100.576479823187;12105.818412723816;12120.454579543919;12137;12514.12401131921;820.9055958564767;829.929455996241;835.2858306148247;847.0766864118141;855.1320409784043;842.3513894301384;850.2985037344216;855.324293807891;855.9400841941067;858.6779957515931;886.450400751535;890.0520945193381;891.5631340643071;892.4199270474211;894.1058941058941;881.1012766977678;881.5239770523909;882.0297672560229;883.5361435246483;884.3897710579679;648.1120864415733;651.7718798420563;652.0317328766778;653.137858027404;653.3923451190391;13531.526396576171;13621.659458513517;13634;13635.181889086687;13645.38595763193;11540.769184616345;11640.534378624845;11657.067434605211;11692;11874.0500759939;9462.479563623998;9533.332666713333;9584.377015494041;9632.759181020461;10140.478928160761;3509.982450087733;3587.1749497615433;3611.6749492545796;3667.064898450905;3692.612275711065;44221.77889110566;44816.77591612021;49282.26076608854;49848.75075624599;49962.7501862492;9101.908980910239;9136.08639136081;9160.725178244664;9166.72499824993;9170.082991700776;16986.06576638272;17085.829141708426;17118.828811711974;17128.74306885398;17155.485335439957;7385.3722433592675;7577.659005344663;7579.1662917079075;7690.884636730453;7744.845103097907;4098.507641116584;4145.523264824524;4169.353750168729;4225.070484493406;4298.118885628439;3282.097423208637;3296.307775367152;3303.487959366302;3316.8673253070087;3319.850606722703;588.3675049321996;605.9303180134253;606.6996836565839;613.2303958532013;618.9969050154721;597.9133025711247;600.1148306248336;615.6983078291605;622.4988883948374;648.6951132967498;7187.532810367309;7457.067866516685;7531.397488200931;7546.622668866535;7797.103333116765;546.2107255016542;551.4265164229157;614.4316507230793;632.4466092169351;654.5385503220218;3482.5820901491984;3607.494950706903;3860.729748917605;3996.5803590623145;4087.1008378156757;53473;54455;54482.72758636181;54760.17859732107;54943.725281373336;50727;50855.74572127116;50940.490595094314;51080.48919510832;51729.48270517322;44314.11371772611;46720.299195512096;47491.762541187076;47567.76216118897;48481.272780908315;7755.573443460438;7835.158737696523;7974.960125199337;8241.50550966944;8284.958575207085;34766.65233347634;34962.47556286607;35542.46686299759;35601.28797424089;35661;43773.78113109414;43814.78092609644;43815.78092109646;44495.332570010825;44579.77710111429;10699.197560182862;10699.5185216667;10822.67531974042;10908.61819836302;11052.613158539412;11809.881901180877;11945.761084778429;11988.880111198776;11990.340531270864;12079.094067945114;10397.064264215955;10447.68656940293;10526.157907367546;10787.352758834495;11465.426728663366;10601.363918164934;11286.379249141048;11294.548218071513;11625.88374116248;11732.94133529327;10747.623833165802;10814.513346899252;11295.830562541732;11311.208215425171;11389.772204556028;9883.30816842814;9976.256489643796;10250.794984100425;10419.583216671248;10438.37369757817;8354.832903342021;9186.448813071238;9223.63569137293;9347.672831450867;9650.276229282972 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:51:01 INFO - 2015-11-30 03:51:01,135 DEBUG : BROWSER_OUTPUT: __startTimestamp1448884261128__endTimestamp 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5581.90 Median:5851.41 stddev:634.23 (10.8%) stddev-sans-first:608.27 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: Values: 3209.9 3234.4 3278.8 3283.3 3318.2 5358.5 5524.5 5525.4 5540.1 5559.1 5393.3 5545.9 5555.4 5609.4 5649.5 5051.4 5150.9 5203.3 5216.1 5227.7 5052.1 5056.1 5164.3 5183.2 5193.8 4844.3 5004.6 5027.6 5040.8 5108.9 5140.7 5142.4 5145.1 5147.7 5148.3 5044.1 5049.0 5068.1 5070.8 5102.1 5247.5 5288.6 5339.1 5378.7 5389.1 6037.5 6051.9 6052.0 6052.5 6088.6 5702.6 6100.8 6102.8 6116.9 6131.9 5436.9 5515.3 5596.0 5606.2 5638.7 6034.3 6091.2 6122.1 6136.2 6145.6 5770.1 5941.3 5950.5 5956.6 5974.8 5836.8 5874.6 5926.1 5933.0 5943.3 5923.6 5955.6 5957.0 5958.1 5974.0 5938.3 5947.6 5955.2 6020.8 6070.8 4605.7 4633.0 4658.9 4672.8 4681.2 4116.7 4124.7 4125.2 4132.3 4147.3 5593.9 5651.7 5721.0 5763.4 5829.8 6085.4 6100.3 6135.4 6136.8 6157.5 5522.7 5810.3 5811.3 5814.7 5838.4 5226.6 5227.1 5231.9 5241.4 5244.5 6109.4 6237.1 6243.6 6245.4 6274.7 6013.3 6037.3 6055.5 6077.8 6108.1 6064.0 6099.0 6138.2 6164.2 6166.9 5800.6 5897.1 5907.8 5912.5 6022.8 5984.1 5991.2 5993.0 6045.9 6077.2 5793.1 5843.0 5851.4 5856.0 5986.2 5951.4 5959.3 5993.0 6002.0 6013.4 5864.8 5871.4 5879.6 5880.8 5886.0 5844.4 5957.4 5959.7 6035.4 6094.3 5856.3 5867.6 5884.6 5894.0 5898.2 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,136 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45520.67 Median:37801.43 stddev:77234.50 (204.3%) stddev-sans-first:77377.35 03:51:01 INFO - 2015-11-30 03:51:01,137 DEBUG : BROWSER_OUTPUT: Values: 548.2 590.5 601.3 605.9 611.2 39033.0 39423.8 39550.2 39840.6 39996.0 42485.4 42961.8 43059.6 43099.4 43341.3 8603.9 8732.0 8737.8 8766.0 8795.3 8508.1 8663.6 8679.6 8681.5 8698.9 8691.8 8786.4 8794.7 8795.5 8797.9 8677.5 8722.4 8723.4 8724.2 8745.2 8518.7 8677.0 8681.2 8684.0 8686.4 40345.0 40553.0 40576.8 40696.0 40821.0 3132.6 3228.4 3312.9 3458.7 3995.4 29274.4 29618.7 29888.4 30113.8 30736.7 3742.3 3820.5 3862.3 3901.8 3903.7 258516.0 259956.0 260137.0 261129.0 261136.0 41469.0 41737.6 42150.0 57375.7 57641.4 41600.4 41753.2 41856.6 42075.8 42157.8 14055.9 14163.6 14230.9 14235.6 14281.1 11301.2 11440.7 11536.8 11570.4 11594.5 14445.3 14445.6 14447.9 14473.3 14494.2 5753.9 5754.1 5897.4 5914.5 5926.5 925.6 953.5 1029.3 1062.6 1079.8 25366.0 25388.5 25452.4 25600.5 25681.2 1069.7 1075.5 1093.4 1118.7 1124.8 13767.9 13862.0 14073.2 14094.7 14160.8 318542.0 323131.0 323644.0 326470.0 327661.0 49696.8 50009.7 50236.7 50275.5 50312.2 1317.4 1321.9 1328.4 1332.9 1341.1 24232.6 24995.9 25362.1 25424.0 25466.0 43940.8 44268.0 44365.0 44462.1 44492.0 295956.0 297735.0 298560.0 299348.0 300383.0 31898.7 46102.0 46193.8 46580.5 46703.8 43391.3 43681.0 43808.3 44053.3 44368.1 37020.9 37410.8 37701.6 38206.6 38538.4 36970.3 37038.6 37518.8 37706.4 37896.4 31916.7 31969.2 31990.0 32008.7 32068.4 32144.2 33165.0 34006.0 34075.7 37179.4 24469.8 24523.4 24785.5 24963.3 25116.5 03:51:01 INFO - 2015-11-30 03:51:01,137 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,138 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28335.90 Median:363.57 stddev:86685.91 (23843.1%) stddev-sans-first:86903.63 03:51:01 INFO - 2015-11-30 03:51:01,138 DEBUG : BROWSER_OUTPUT: Values: 359.5 360.7 366.5 366.6 367.1 16517.8 17130.9 17674.7 17782.4 18280.9 11308.5 12439.0 16206.4 16219.9 16233.9 5037.6 5459.5 5461.5 5470.1 5475.9 5406.0 5444.7 5462.4 5465.2 5476.0 4450.6 5144.2 5310.8 5588.2 5591.6 4328.3 5296.5 5299.0 5320.0 5326.7 5192.3 5358.2 5369.6 5374.5 5385.7 12728.9 12934.5 17196.6 20637.0 20926.0 2037.8 2048.6 2105.6 2150.5 2201.4 9568.7 9862.0 12248.2 12716.9 13386.4 1770.1 1795.4 1798.1 1821.3 1851.0 58580.0 59784.0 61232.7 61978.0 63293.4 9984.8 10297.2 10370.7 10375.7 10393.5 13138.0 13221.7 13241.3 13292.7 13407.1 7353.4 7557.1 7562.2 7636.2 7816.9 7339.6 7361.1 7382.8 7686.2 7749.9 4426.3 4434.4 4449.1 4454.5 4477.6 1823.1 1873.8 1881.2 1883.5 1900.0 430.9 439.1 450.3 459.8 465.1 10270.9 10975.9 11076.4 11123.5 11133.3 448.8 456.6 946.5 952.9 953.7 8930.4 9389.9 9433.8 10009.5 10081.9 519130.0 526049.0 529475.0 537534.0 539323.0 76902.6 77208.0 78472.0 78680.2 79142.0 1161.9 1168.7 1170.9 1185.7 1188.7 14905.2 15072.4 15084.8 15111.8 15443.8 34357.5 34473.5 34612.8 35219.3 35417.8 46719.3 48543.3 49135.5 49256.0 49689.5 9318.9 9658.2 9697.2 9720.1 9799.5 11335.5 15035.5 17242.4 17278.0 17331.8 14429.1 14633.0 14654.3 14686.9 14855.8 14435.3 14641.0 14798.0 14942.1 15111.8 14683.9 14687.7 14694.0 14722.3 14864.8 9745.6 9817.1 9845.6 9871.3 9912.9 11599.5 14227.1 14374.6 14475.3 14537.6 03:51:01 INFO - 2015-11-30 03:51:01,138 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,138 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5572.23 Median:6418.24 stddev:2854.75 (44.5%) stddev-sans-first:2846.85 03:51:01 INFO - 2015-11-30 03:51:01,139 DEBUG : BROWSER_OUTPUT: Values: 1561.5 1696.3 1758.3 1772.3 1795.9 7610.5 7922.8 8071.5 8079.2 8097.7 8019.4 8046.8 8111.0 8136.0 8137.6 2285.4 2317.0 2336.7 2346.4 2347.4 2322.7 2356.4 2371.8 2372.0 2376.5 2285.1 2325.7 2337.3 2341.6 2346.4 2264.4 2316.5 2324.9 2343.2 2349.6 2340.7 2362.5 2368.8 2372.1 2377.6 7909.6 7948.6 7951.5 7952.5 7969.6 4761.1 4806.9 4840.6 4853.7 4868.5 3241.0 3282.0 3348.7 3349.2 3359.2 1077.1 1082.1 1111.4 1113.5 1123.4 10838.0 10957.8 10998.1 11009.8 11030.1 4226.5 4258.9 4308.0 4402.9 4435.9 8758.6 8799.3 8836.5 8841.4 8846.0 4799.4 4803.9 4819.9 4842.1 4847.5 4398.7 4426.2 4444.8 4452.6 4466.6 3483.0 3519.5 3580.8 3584.1 3595.3 1069.8 1084.0 1086.3 1092.3 1194.8 1056.0 1093.1 1096.7 1213.8 1306.0 7502.6 7549.0 7584.1 7601.9 7625.9 1052.3 1086.7 1160.7 1164.5 1175.6 5879.3 5882.2 5933.9 5954.4 5958.1 9296.6 9393.9 9399.0 9593.2 9607.4 9387.0 9390.1 9406.9 9466.4 9512.9 7092.7 7218.3 7222.4 7289.8 7455.8 7286.9 7378.3 7396.6 7440.9 7451.1 8456.8 8515.2 8535.6 8594.2 8669.0 8534.1 8609.5 8613.8 8667.0 8732.5 7092.4 7094.5 7150.0 7175.4 7177.0 7469.5 7504.8 7525.1 7609.2 7610.3 7124.7 7180.9 7189.5 7203.1 7233.5 7078.4 7136.8 7148.6 7201.5 7248.5 7246.3 7281.1 7288.6 7291.4 7299.6 6600.3 6666.6 6676.5 6682.4 6689.3 6390.6 6445.8 6453.5 6470.9 6478.9 03:51:01 INFO - 2015-11-30 03:51:01,139 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,140 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5589.92 Median:6399.26 stddev:1710.57 (26.7%) stddev-sans-first:1669.19 03:51:01 INFO - 2015-11-30 03:51:01,140 DEBUG : BROWSER_OUTPUT: Values: 330.4 339.9 340.0 340.6 345.8 6263.9 6321.0 6327.8 6341.1 6363.9 6086.8 6217.9 6237.8 6238.5 6280.5 4737.5 4745.1 4753.3 4754.7 4761.9 4754.6 4761.4 4773.0 4775.1 4777.1 4622.5 4736.7 4740.6 4745.7 4759.2 4711.3 4717.6 4733.4 4733.5 4746.0 4108.2 4121.2 4124.2 4132.5 4134.3 5863.0 5907.2 5925.1 5926.1 5932.7 5412.6 5490.3 5534.8 5549.4 5553.1 6658.4 6659.0 6660.0 6663.9 6669.7 4571.9 4572.2 4573.4 4575.9 4584.5 6745.8 6906.1 6917.8 6929.2 6933.7 4662.7 4671.8 4700.7 4709.0 4719.0 4761.0 4765.3 4770.9 4781.8 4783.4 5525.3 5540.9 5542.5 5543.6 5561.4 6598.8 6670.2 6678.0 6683.2 6703.8 1623.6 1658.6 1661.5 1662.0 1687.0 1085.1 1087.6 1098.6 1099.7 1106.9 6405.4 6419.6 6434.5 6440.1 6454.2 6837.9 6849.5 6851.8 6865.7 6875.1 6393.1 6406.5 6425.7 6436.4 6441.5 3801.8 3826.9 3827.3 3830.6 3832.4 7114.6 7139.8 7156.5 7175.1 7230.3 7003.8 7118.2 7156.3 7160.2 7168.7 7223.5 7223.6 7224.8 7232.9 7250.1 6941.4 6950.7 6953.5 6955.3 6976.9 6741.7 6873.9 6888.3 6903.4 6922.7 7160.6 7191.5 7197.6 7198.1 7212.1 4616.5 4658.5 4658.8 4662.0 4662.7 6880.3 6993.1 6993.9 6999.6 7004.8 6774.4 6788.3 6791.0 6792.3 6806.5 6776.7 6783.5 6789.0 6798.6 6801.8 6552.1 6646.1 6649.4 6654.8 6664.1 6779.2 6784.4 6786.0 6801.8 6811.1 6557.2 6593.8 6614.0 6620.3 6640.8 03:51:01 INFO - 2015-11-30 03:51:01,140 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,140 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13526.03 Median:48881.77 stddev:15717.93 (32.2%) stddev-sans-first:15732.46 03:51:01 INFO - 2015-11-30 03:51:01,141 DEBUG : BROWSER_OUTPUT: Values: 689.6 781.7 848.7 868.4 890.8 13770.9 14039.6 14053.8 14083.9 14181.3 12100.6 12105.8 12120.5 12137.0 12514.1 820.9 829.9 835.3 847.1 855.1 842.4 850.3 855.3 855.9 858.7 886.5 890.1 891.6 892.4 894.1 881.1 881.5 882.0 883.5 884.4 648.1 651.8 652.0 653.1 653.4 13531.5 13621.7 13634.0 13635.2 13645.4 11540.8 11640.5 11657.1 11692.0 11874.1 9462.5 9533.3 9584.4 9632.8 10140.5 3510.0 3587.2 3611.7 3667.1 3692.6 44221.8 44816.8 49282.3 49848.8 49962.8 9101.9 9136.1 9160.7 9166.7 9170.1 16986.1 17085.8 17118.8 17128.7 17155.5 7385.4 7577.7 7579.2 7690.9 7744.8 4098.5 4145.5 4169.4 4225.1 4298.1 3282.1 3296.3 3303.5 3316.9 3319.9 588.4 605.9 606.7 613.2 619.0 597.9 600.1 615.7 622.5 648.7 7187.5 7457.1 7531.4 7546.6 7797.1 546.2 551.4 614.4 632.4 654.5 3482.6 3607.5 3860.7 3996.6 4087.1 53473.0 54455.0 54482.7 54760.2 54943.7 50727.0 50855.7 50940.5 51080.5 51729.5 44314.1 46720.3 47491.8 47567.8 48481.3 7755.6 7835.2 7975.0 8241.5 8285.0 34766.7 34962.5 35542.5 35601.3 35661.0 43773.8 43814.8 43815.8 44495.3 44579.8 10699.2 10699.5 10822.7 10908.6 11052.6 11809.9 11945.8 11988.9 11990.3 12079.1 10397.1 10447.7 10526.2 10787.4 11465.4 10601.4 11286.4 11294.5 11625.9 11732.9 10747.6 10814.5 11295.8 11311.2 11389.8 9883.3 9976.3 10250.8 10419.6 10438.4 8354.8 9186.4 9223.6 9347.7 9650.3 03:51:01 INFO - 2015-11-30 03:51:01,142 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:51:01 INFO - 2015-11-30 03:51:01,142 DEBUG : BROWSER_OUTPUT: 03:51:01 INFO - 2015-11-30 03:51:01,803 INFO : Browser exited with error code: 0 03:51:01 INFO - 2015-11-30 03:51:01,827 INFO : Completed test dromaeo_css (00:18:31) 03:51:01 INFO - 2015-11-30 03:51:01,827 INFO : Starting test kraken 03:51:01 INFO - 2015-11-30 03:51:01,827 DEBUG : operating with platform_type : linux_ 03:51:01 INFO - 2015-11-30 03:51:01,827 INFO : Initialising browser for kraken test... 03:51:01 INFO - 2015-11-30 03:51:01,833 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FAFxo/profile http://localhost:35997/getInfo.html 03:51:06 INFO - 2015-11-30 03:51:06,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:51:06 INFO - 2015-11-30 03:51:06,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:51:06 INFO - 2015-11-30 03:51:06,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:51:06 INFO - 2015-11-30 03:51:06,846 DEBUG : BROWSER_OUTPUT: __metrics 03:51:07 INFO - 2015-11-30 03:51:07,895 INFO : Browser initialized. 03:51:07 INFO - 2015-11-30 03:51:07,895 INFO : Running cycle 1/1 for kraken test... 03:51:07 INFO - 2015-11-30 03:51:07,896 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FAFxo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:51:19 INFO - 2015-11-30 03:51:19,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 139030528 03:51:19 INFO - 2015-11-30 03:51:19,669 DEBUG : BROWSER_OUTPUT: 03:51:22 INFO - 2015-11-30 03:51:22,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:22 INFO - 2015-11-30 03:51:22,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 140460032 03:51:22 INFO - 2015-11-30 03:51:22,772 DEBUG : BROWSER_OUTPUT: 03:51:25 INFO - 2015-11-30 03:51:25,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-dft) 03:51:25 INFO - 2015-11-30 03:51:25,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 140783616 03:51:25 INFO - 2015-11-30 03:51:25,995 DEBUG : BROWSER_OUTPUT: 03:51:28 INFO - 2015-11-30 03:51:28,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-fft) 03:51:29 INFO - 2015-11-30 03:51:29,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 135340032 03:51:29 INFO - 2015-11-30 03:51:29,435 DEBUG : BROWSER_OUTPUT: 03:51:31 INFO - 2015-11-30 03:51:31,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35997/tests/kraken/driver.html?testName=audio-oscillator) 03:51:31 INFO - 2015-11-30 03:51:31,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 03:51:31 INFO - 2015-11-30 03:51:31,973 DEBUG : BROWSER_OUTPUT: 03:51:34 INFO - 2015-11-30 03:51:34,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:34 INFO - 2015-11-30 03:51:34,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 03:51:34 INFO - 2015-11-30 03:51:34,773 DEBUG : BROWSER_OUTPUT: 03:51:37 INFO - 2015-11-30 03:51:37,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:38 INFO - 2015-11-30 03:51:38,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 137928704 03:51:38 INFO - 2015-11-30 03:51:38,375 DEBUG : BROWSER_OUTPUT: 03:51:41 INFO - 2015-11-30 03:51:41,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35997/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:42 INFO - 2015-11-30 03:51:42,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 138338304 03:51:42 INFO - 2015-11-30 03:51:42,351 DEBUG : BROWSER_OUTPUT: 03:51:45 INFO - 2015-11-30 03:51:45,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35997/tests/kraken/driver.html?testName=json-parse-financial) 03:51:45 INFO - 2015-11-30 03:51:45,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 138031104 03:51:45 INFO - 2015-11-30 03:51:45,815 DEBUG : BROWSER_OUTPUT: 03:51:47 INFO - 2015-11-30 03:51:47,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:47 INFO - 2015-11-30 03:51:47,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 139051008 03:51:47 INFO - 2015-11-30 03:51:47,982 DEBUG : BROWSER_OUTPUT: 03:51:49 INFO - 2015-11-30 03:51:49,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:50 INFO - 2015-11-30 03:51:50,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 03:51:50 INFO - 2015-11-30 03:51:50,438 DEBUG : BROWSER_OUTPUT: 03:51:52 INFO - 2015-11-30 03:51:52,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:53 INFO - 2015-11-30 03:51:53,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 139149312 03:51:53 INFO - 2015-11-30 03:51:53,089 DEBUG : BROWSER_OUTPUT: 03:51:55 INFO - 2015-11-30 03:51:55,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:56 INFO - 2015-11-30 03:51:56,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 03:51:56 INFO - 2015-11-30 03:51:56,131 DEBUG : BROWSER_OUTPUT: 03:51:58 INFO - 2015-11-30 03:51:58,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:59 INFO - 2015-11-30 03:51:59,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 139456512 03:51:59 INFO - 2015-11-30 03:51:59,287 DEBUG : BROWSER_OUTPUT: 03:52:00 INFO - 2015-11-30 03:52:00,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35997/tests/kraken/driver.html?testName=ai-astar) 03:52:01 INFO - 2015-11-30 03:52:01,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 139161600 03:52:01 INFO - 2015-11-30 03:52:01,208 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,212 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:52:01 INFO - 2015-11-30 03:52:01,212 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:52:01 INFO - 2015-11-30 03:52:01,212 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:52:01 INFO - 2015-11-30 03:52:01,212 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:52:01 INFO - 2015-11-30 03:52:01,212 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;108;110;110;111;124;109;111;111;111 03:52:01 INFO - 2015-11-30 03:52:01,213 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;125;147;170;133;149;152;128;168;124 03:52:01 INFO - 2015-11-30 03:52:01,213 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;164;162;163;163;164;165;170;161 03:52:01 INFO - 2015-11-30 03:52:01,213 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;75;71;137;72;78;73;73 03:52:01 INFO - 2015-11-30 03:52:01,213 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;141;92;93;93;145;93;94;133 03:52:01 INFO - 2015-11-30 03:52:01,214 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;113;111;110;111;110;109;110;110 03:52:01 INFO - 2015-11-30 03:52:01,214 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;145;146;151;145;147;146;148;146 03:52:01 INFO - 2015-11-30 03:52:01,214 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;98;96;97;95;96 03:52:01 INFO - 2015-11-30 03:52:01,214 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;61;59;61;62;63;62;58;58 03:52:01 INFO - 2015-11-30 03:52:01,214 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;69;71;71;71;70;71;70;70 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;93;84;87;88;86;87;85;86;86 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;121;129;125;122;124;120;119;116;122 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;161;143;149;152;148;149;152;151;140 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;66;68;68;65;66;66;68;70 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,698 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:52:01 INFO - 2015-11-30 03:52:01,215 DEBUG : BROWSER_OUTPUT: __startTimestamp1448884321210__endTimestamp 03:52:01 INFO - 2015-11-30 03:52:01,216 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,219 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:52:01 INFO - 2015-11-30 03:52:01,219 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:52:01 INFO - 2015-11-30 03:52:01,219 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:4.74 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 110.0 110.0 111.0 124.0 109.0 111.0 111.0 111.0 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.50 stddev:16.87 (11.2%) stddev-sans-first:17.64 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: Values: 153.0 125.0 147.0 170.0 133.0 149.0 152.0 128.0 168.0 124.0 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,220 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.50 (1.5%) stddev-sans-first:2.64 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 164.0 162.0 163.0 163.0 164.0 165.0 170.0 161.0 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.50 stddev:20.30 (28.0%) stddev-sans-first:21.35 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 75.0 71.0 137.0 72.0 78.0 73.0 73.0 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:22.73 (24.4%) stddev-sans-first:23.54 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 141.0 92.0 93.0 93.0 145.0 93.0 94.0 133.0 03:52:01 INFO - 2015-11-30 03:52:01,221 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:1.07 (1.0%) stddev-sans-first:1.13 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 113.0 111.0 110.0 111.0 110.0 109.0 110.0 110.0 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.81 (1.2%) stddev-sans-first:1.87 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 145.0 146.0 151.0 145.0 147.0 146.0 148.0 146.0 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:52:01 INFO - 2015-11-30 03:52:01,222 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 98.0 96.0 97.0 95.0 96.0 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:61.00 stddev:1.77 (2.9%) stddev-sans-first:1.87 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 61.0 59.0 61.0 62.0 63.0 62.0 58.0 58.0 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 03:52:01 INFO - 2015-11-30 03:52:01,223 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 71.0 71.0 71.0 70.0 71.0 70.0 70.0 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:86.50 stddev:2.50 (2.9%) stddev-sans-first:2.57 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: Values: 85.0 93.0 84.0 87.0 88.0 86.0 87.0 85.0 86.0 86.0 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:123.00 stddev:4.34 (3.5%) stddev-sans-first:3.74 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: Values: 130.0 121.0 129.0 125.0 122.0 124.0 120.0 119.0 116.0 122.0 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,224 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:151.50 stddev:6.52 (4.3%) stddev-sans-first:5.94 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 143.0 149.0 152.0 148.0 149.0 152.0 151.0 140.0 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.90 (2.8%) stddev-sans-first:1.56 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 66.0 68.0 68.0 65.0 66.0 66.0 68.0 70.0 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:52:01 INFO - 2015-11-30 03:52:01,225 DEBUG : BROWSER_OUTPUT: 03:52:02 INFO - 2015-11-30 03:52:02,095 INFO : Browser exited with error code: 0 03:52:02 INFO - 2015-11-30 03:52:02,144 INFO : Completed test kraken (00:01:00) 03:52:02 INFO - 2015-11-30 03:52:02,144 INFO : Starting test v8_7 03:52:02 INFO - 2015-11-30 03:52:02,144 DEBUG : operating with platform_type : linux_ 03:52:02 INFO - 2015-11-30 03:52:02,144 INFO : Initialising browser for v8_7 test... 03:52:02 INFO - 2015-11-30 03:52:02,150 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTZE8WW/profile http://localhost:35997/getInfo.html 03:52:06 INFO - 2015-11-30 03:52:06,951 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:52:06 INFO - 2015-11-30 03:52:06,952 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:52:06 INFO - 2015-11-30 03:52:06,952 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:52:06 INFO - 2015-11-30 03:52:06,952 DEBUG : BROWSER_OUTPUT: __metrics 03:52:08 INFO - 2015-11-30 03:52:08,071 INFO : Browser initialized. 03:52:08 INFO - 2015-11-30 03:52:08,071 INFO : Running cycle 1/1 for v8_7 test... 03:52:08 INFO - 2015-11-30 03:52:08,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTZE8WW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:52:19 INFO - 2015-11-30 03:52:19,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 03:52:19 INFO - 2015-11-30 03:52:19,789 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35997/tests/v8_7/run.html (next: http://localhost:35997/tests/v8_7/run.html) 03:52:41 INFO - 2015-11-30 03:52:41,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 137814016 03:52:41 INFO - 2015-11-30 03:52:41,426 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,427 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:52:41 INFO - 2015-11-30 03:52:41,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:52:41 INFO - 2015-11-30 03:52:41,428 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:52:41 INFO - 2015-11-30 03:52:41,428 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:52:41 INFO - 2015-11-30 03:52:41,428 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7000828500414 03:52:41 INFO - 2015-11-30 03:52:41,428 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.2308556450103 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |5;Earley;738.5524372230428 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 03:52:41 INFO - 2015-11-30 03:52:41,429 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 03:52:41 INFO - 2015-11-30 03:52:41,430 DEBUG : BROWSER_OUTPUT: |8;Splay;679.3478260869565 03:52:41 INFO - 2015-11-30 03:52:41,430 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 03:52:41 INFO - 2015-11-30 03:52:41,430 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:52:41 INFO - 2015-11-30 03:52:41,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1448884361426__endTimestamp 03:52:41 INFO - 2015-11-30 03:52:41,430 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,431 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:52:41 INFO - 2015-11-30 03:52:41,431 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:52:41 INFO - 2015-11-30 03:52:41,431 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,431 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.70 Median:165.70 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,432 DEBUG : BROWSER_OUTPUT: Values: 165.7 03:52:41 INFO - 2015-11-30 03:52:41,432 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,432 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.23 Median:187.23 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,433 DEBUG : BROWSER_OUTPUT: Values: 187.2 03:52:41 INFO - 2015-11-30 03:52:41,433 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,433 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,433 DEBUG : BROWSER_OUTPUT: Values: 279.6 03:52:41 INFO - 2015-11-30 03:52:41,434 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,434 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,434 DEBUG : BROWSER_OUTPUT: Values: 5218.8 03:52:41 INFO - 2015-11-30 03:52:41,434 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,434 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,435 DEBUG : BROWSER_OUTPUT: Values: 1068.4 03:52:41 INFO - 2015-11-30 03:52:41,435 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,435 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.55 Median:738.55 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,435 DEBUG : BROWSER_OUTPUT: Values: 738.6 03:52:41 INFO - 2015-11-30 03:52:41,435 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: Values: 12168.7 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: Values: 25871.8 03:52:41 INFO - 2015-11-30 03:52:41,436 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:679.35 Median:679.35 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: Values: 679.3 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: Values: 4850.2 03:52:41 INFO - 2015-11-30 03:52:41,437 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:52:41 INFO - 2015-11-30 03:52:41,438 DEBUG : BROWSER_OUTPUT: 03:52:42 INFO - 2015-11-30 03:52:42,243 INFO : Browser exited with error code: 0 03:52:42 INFO - 2015-11-30 03:52:42,257 INFO : Completed test v8_7 (00:00:40) 03:52:42 INFO - 2015-11-30 03:52:42,435 INFO : Completed test suite (00:20:11) 03:52:42 INFO - 2015-11-30 03:52:42,435 DEBUG : Working with test: dromaeo_css 03:52:42 INFO - 2015-11-30 03:52:42,435 DEBUG : Generating results file: dromaeo_css 03:52:42 INFO - 2015-11-30 03:52:42,436 DEBUG : Working with test: kraken 03:52:42 INFO - 2015-11-30 03:52:42,437 DEBUG : Generating results file: kraken 03:52:42 INFO - 2015-11-30 03:52:42,437 INFO : javascript benchmark 03:52:42 INFO - 2015-11-30 03:52:42,437 DEBUG : Working with test: v8_7 03:52:42 INFO - 2015-11-30 03:52:42,437 DEBUG : Generating results file: v8_7 03:52:42 INFO - 2015-11-30 03:52:42,437 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:42 INFO - 2015-11-30 03:52:42,583 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 03:52:42 INFO - 2015-11-30 03:52:42,583 DEBUG : process_Request line: dromaeo_css 7035.80 graph.html#tests=[[72,63,43]] 03:52:42 INFO - 2015-11-30 03:52:42,584 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:42 INFO - 2015-11-30 03:52:42,618 DEBUG : process_Request line: kraken 1518.50 graph.html#tests=[[232,63,43]] 03:52:42 INFO - 2015-11-30 03:52:42,618 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:52:42 INFO - 2015-11-30 03:52:42,654 DEBUG : process_Request line: v8_7 21018.86 graph.html#tests=[[230,63,43]] 03:52:42 INFO - 2015-11-30 03:52:42,655 INFO : javascript benchmark 03:52:42 INFO - 2015-11-30 03:52:42,659 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.935801283974, 3234.401635697396, 3278.803271803691, 3283.326917981814, 3318.2202182487094, 5358.544523715479, 5524.530414914732, 5525.392206857243, 5540.085885828838, 5559.11054231323, 5393.325834270716, 5545.861353466155, 5555.3611334696425, 5609.382967873541, 5649.548036157108, 5051.444341122483, 5150.896982060356, 5203.2975548301065, 5216.139337009407, 5227.686338819664, 5052.141136006888, 5056.14045612245, 5164.251183578379, 5183.196604526304, 5193.766280517386, 4844.297576851354, 5004.649674522785, 5027.648064635477, 5040.798368065273, 5108.948910510884, 5140.7172605506685, 5142.434332223453, 5145.073886700392, 5147.6654017488745, 5148.330717006766, 5044.142495775727, 5048.974755126201, 5068.062408454448, 5070.822521211777, 5102.056119617845, 5247.501487358695, 5288.603354748371, 5339.092354299778, 5378.650387724785, 5389.137737961907, 6037.516998640142, 6051.939480605181, 6052.0, 6052.485538729214, 6088.634681919099, 5702.6293290935955, 6100.755969761204, 6102.755889764404, 6116.938830611682, 6131.9386806131815, 5436.891262174774, 5515.255440515519, 5596.0, 5606.24315717377, 5638.661680299154, 6034.275886893601, 6091.2081429414775, 6122.142899994004, 6136.20229370179, 6145.5698101133385, 5770.076787713946, 5941.346451890288, 5950.494207992283, 5956.612820166675, 5974.790882319185, 5836.824895253149, 5874.618149820333, 5926.140709597084, 5933.02105152645, 5943.31651860033, 5923.555733320019, 5955.612885162451, 5956.970215148896, 5958.136070269787, 5974.0, 5938.287405511366, 5947.613405128653, 5955.225820643375, 6020.849478763066, 6070.817875463743, 4605.65457590682, 4632.953670463252, 4658.930116048262, 4672.766361681903, 4681.227597446451, 4116.670666346685, 4124.711270211116, 4125.23683118624, 4132.33882578786, 4147.315692910636, 5593.916091258634, 5651.745671444794, 5720.971395142998, 5763.423657634203, 5829.795957141479, 6085.391460853968, 6100.328963813977, 6135.386461353918, 6136.846578835475, 6157.476614487819, 5522.66863988162, 5810.31500864753, 5811.3316968548315, 5814.738336774855, 5838.357780644125, 5226.608004399685, 5227.059129356752, 5231.921521177185, 5241.449647786927, 5244.501772331622, 6109.435031337442, 6237.095621135, 6243.562950593415, 6245.437910587978, 6274.717637706314, 6013.338532761481, 6037.275526936795, 6055.485283750754, 6077.756889724362, 6108.144859719554, 6064.0, 6098.969505152446, 6138.183846674873, 6164.229471316085, 6166.876662466636, 5800.564957628279, 5897.144913987534, 5907.793227237026, 5912.526997840248, 6022.789202377896, 5984.102384642339, 5991.221141251609, 5992.970035149797, 6045.939540604713, 6077.179580756718, 5793.102069179284, 5842.970785146047, 5851.414858514115, 5856.0, 5986.161937328865, 5951.404859514014, 5959.314678811992, 5993.0, 6001.979663457136, 6013.368596297326, 5864.765409383577, 5871.442212989759, 5879.617824841372, 5880.8235752927485, 5886.0, 5844.444777746107, 5957.404259574181, 5959.67221802805, 6035.39646035393, 6094.329623741296, 5856.267966504187, 5867.647941123546, 5884.58807883444, 5894.0, 5898.203742494708], "unit": "ms", "name": "dojo.html", "value": 5539.377593343594}, {"lowerIsBetter": false, "replicates": [548.1901374896232, 590.509876802254, 601.2664549249915, 605.8818530386576, 611.1901730207476, 39033.0, 39423.80288098559, 39550.20899582007, 39840.60159398405, 39996.0, 42485.362719559234, 42961.78519107408, 43059.56940430595, 43099.3535096973, 43341.34987975175, 8603.870941935877, 8732.0, 8737.7815554611, 8765.956170219171, 8795.296376289882, 8508.106648801879, 8663.610137543825, 8679.609417576192, 8681.522516261603, 8698.913010869905, 8691.826163476726, 8786.384953053288, 8794.6921857735, 8795.472271663688, 8797.912020879805, 8677.522736249504, 8722.38943273971, 8723.38936274461, 8724.214820666139, 8745.212930836224, 8518.74443766688, 8676.956615216946, 8681.2186903179, 8684.0, 8686.391952563323, 40345.0, 40553.0, 40576.79711601423, 40696.0, 40821.0, 3132.577102091234, 3228.402745492068, 3312.9171770705684, 3458.723302135823, 3995.440638310639, 29274.414511709645, 29618.70381296181, 29888.402231955457, 30113.849430752707, 30736.692633073606, 3742.348704820624, 3820.503334566489, 3862.2661694278, 3901.7854018028997, 3903.6877049835944, 258515.9999999981, 259956.0, 260137.0, 261129.0, 261136.0, 41469.0, 41737.58262417337, 42150.0, 57375.71312143413, 57641.42358576361, 41600.37599436011, 41753.1649367011, 41856.58143418527, 42075.78962105231, 42157.78921105436, 14055.929720351538, 14163.575092747235, 14230.928845355707, 14235.572932812032, 14281.14313141215, 11301.15241356885, 11440.656780296604, 11536.826947595793, 11570.42147892602, 11594.536218551331, 14445.277736113152, 14445.566633001026, 14447.85552144486, 14473.348699308346, 14494.202818845064, 5753.913691294634, 5754.115971719157, 5897.410258974154, 5914.491804589802, 5926.525877929756, 925.6390007896925, 953.4517652349926, 1029.2897900448816, 1062.5909025025421, 1079.8056349857102, 25366.0, 25388.492230155294, 25452.363690907874, 25600.48799024009, 25681.22956311314, 1069.727219559023, 1075.4837677914645, 1093.3986307530827, 1118.681175864891, 1124.7694222684331, 13767.862321376859, 13862.0, 14073.155610663393, 14094.718105638034, 14160.787588186186, 318542.0, 323131.0, 323644.0, 326470.0, 327661.0, 49696.751516242184, 50009.749951250014, 50236.748816255684, 50275.497245027815, 50312.24531632029, 1317.3808310094241, 1321.9206847588982, 1328.3955800110925, 1332.946682132704, 1341.1349679456696, 24232.636510452005, 24995.87502062478, 25362.112326068498, 25424.0, 25466.0, 43940.78029609832, 44268.01587857108, 44365.0, 44462.11075778531, 44492.0, 295956.0, 297735.0, 298560.0, 299348.0, 300383.0, 31898.6810131905, 46102.0, 46193.76903115597, 46580.53419465762, 46703.766481167375, 43391.34912976371, 43681.0, 43808.34287485754, 44053.33919991267, 44368.11263774771, 37020.88865987541, 37410.8129459351, 37701.62298377091, 38206.61793382142, 38538.421923671725, 36970.336334864456, 37038.62961370352, 37518.812405937795, 37706.43440348342, 37896.43155352617, 31916.68083319137, 31969.200769980936, 31990.040298791075, 32008.6799132015, 32068.35863282768, 32144.19639509031, 33165.0, 34006.0, 34075.65924340725, 37179.442308365935, 24469.75530244746, 24523.38691532726, 24785.50428991446, 24963.251102466955, 25116.49767004686], "unit": "ms", "name": "ext.html", "value": 17874.12368276825}, {"lowerIsBetter": false, "replicates": [359.48414025872876, 360.66998696192985, 366.4649611567111, 366.6113919245598, 367.05849496042663, 16517.770101036356, 17130.91434542827, 17674.734878976826, 17782.377616783433, 18280.908595457004, 11308.547658093667, 12439.0, 16206.35174593015, 16219.945703529262, 16233.91883040586, 5037.62217833663, 5459.535939445152, 5461.5357694595805, 5470.097433923398, 5475.890482190353, 5405.972970135143, 5444.700541470237, 5462.371827239878, 5465.180222966547, 5475.972620136894, 4450.577195166454, 5144.151215049513, 5310.840674779763, 5588.189712491686, 5591.6365436246715, 4328.329108988112, 5296.470352964711, 5299.0, 5320.0, 5326.6537675050995, 5192.273081768555, 5358.169483729989, 5369.62412631116, 5374.543163831079, 5385.730713464351, 12728.936355318257, 12934.48262069516, 17196.57008574783, 20637.0, 20926.0, 2037.768906851963, 2048.6107639548586, 2105.5999360121527, 2150.537634408594, 2201.438633148537, 9568.712938611852, 9861.950690246575, 12248.203866748721, 12716.919061879751, 13386.397612107381, 1770.1326350088364, 1795.425463851568, 1798.082977681379, 1821.289697018164, 1851.0374605205218, 58580.0, 59784.0, 61232.693836530976, 61978.0, 63293.36706632921, 9984.750381240527, 10297.17622590191, 10370.688879333633, 10375.688729338131, 10393.53229104692, 13138.0, 13221.669458263621, 13241.337933103307, 13292.667683307995, 13407.128536645087, 7353.4484913631695, 7557.130929943017, 7562.205968373351, 7636.160022397532, 7816.921830781733, 7339.559626422431, 7361.079865016873, 7382.815429614196, 7686.231376862381, 7749.883751743729, 4426.313921342197, 4434.379186913835, 4449.065696203768, 4454.465464144323, 4477.574630410106, 1823.079344930828, 1873.7938826729048, 1881.2192939929776, 1883.50087226885, 1899.9620007599772, 430.85781692041553, 439.0669826618436, 450.2975358440843, 459.8459516062157, 465.1302065138146, 10270.897291027144, 10975.890241097486, 11076.390798505998, 11123.499442525106, 11133.332000080021, 448.8272015274143, 456.63925498856196, 946.5314669238771, 952.9332946693664, 953.6900507335143, 8930.419522731001, 9389.859152112724, 9433.76415589602, 10009.499525023719, 10081.949590252001, 519130.0, 526049.0, 529475.0, 537534.0, 539323.0, 76902.61548692333, 77208.0, 78472.0, 78680.21319786728, 79142.0, 1161.9419029048513, 1168.7311918258847, 1170.9355985420714, 1185.6502331812137, 1188.6909403555137, 14905.180215087841, 15072.397104116151, 15084.849151508344, 15111.848881511483, 15443.84556154424, 34357.48463773095, 34473.48289775706, 34612.82693586516, 35219.295614088085, 35417.82291088528, 46719.29921051255, 48543.271850921556, 49135.50864491309, 49256.0, 49689.503104968484, 9318.860217096613, 9658.227341812779, 9697.22422206236, 9720.125188733047, 9799.51002449889, 11335.489902954221, 15035.54893353201, 17242.396516121877, 17278.0, 17331.826681733524, 14429.134251944917, 14633.0, 14654.267286635839, 14686.926565367105, 14855.777163342775, 14435.278236088363, 14641.0, 14797.964142509922, 14942.103473791607, 15111.848881511045, 14683.92658036703, 14687.70624587481, 14694.0, 14722.337494812546, 14864.75743784412, 9745.610175592898, 9817.116459518678, 9845.60617575289, 9871.259655526008, 9912.900870991198, 11599.478023488795, 14227.146371217346, 14374.568762937128, 14475.27623618836, 14537.636559086108], "unit": "ms", "name": "jquery.html", "value": 8530.475448414029}, {"lowerIsBetter": false, "replicates": [1561.5315405378399, 1696.2706036404347, 1758.2527425844014, 1772.3087995681688, 1795.8922464652114, 7610.467267291285, 7922.762317130495, 8071.51570905746, 8079.192080791932, 8097.676092956282, 8019.358451323895, 8046.798830029237, 8110.959445202766, 8136.023677158749, 8137.593120343989, 2285.382946604416, 2316.9536609267802, 2336.707911511061, 2346.425125844162, 2347.424880904181, 2322.7328857181387, 2356.375560476475, 2371.833971621987, 2371.95256094878, 2376.5009348036933, 2285.0745448093467, 2325.7092863392077, 2337.322176568793, 2341.6019276723, 2346.4251258441705, 2264.3772962435296, 2316.4787922717423, 2324.8837558122195, 2343.215022967308, 2349.647552867075, 2340.6840076589615, 2362.4802543440587, 2368.834181607288, 2372.0867466025534, 2377.5720370333333, 7909.644066017043, 7948.602569871541, 7951.522908625443, 7952.483088599222, 7969.561674107922, 4761.095391875532, 4806.927896081562, 4840.564349208553, 4853.733044682576, 4868.488808675109, 3241.0, 3282.048206020251, 3348.7488438366977, 3349.1961929137074, 3359.160209947513, 1077.1167642533126, 1082.10726150925, 1111.4053981120062, 1113.4766659670024, 1123.3821398230941, 10837.970392812671, 10957.83563246544, 10998.12015038795, 11009.779804403866, 11030.117590592734, 4226.535081141072, 4258.850940217078, 4308.0, 4402.911941761211, 4435.933460998088, 8758.605862736193, 8799.25206357454, 8836.469811811312, 8841.381103322705, 8845.955770221108, 4799.3760811094335, 4803.879903002383, 4819.903601927942, 4842.104210721028, 4847.491013443538, 4398.714083584557, 4426.15902978433, 4444.799984000728, 4452.554744525586, 4466.553344665573, 3482.982585087109, 3519.4720791881423, 3580.838862251205, 3584.121890136933, 3595.3168897909313, 1069.7860427914447, 1083.967480975572, 1086.2613422872364, 1092.2736380307008, 1194.7849387110405, 1055.984160237597, 1093.0654290581597, 1096.6819622309602, 1213.83006379107, 1305.9542915997895, 7502.624868756649, 7549.0, 7584.051993500812, 7601.923980760122, 7625.923740762521, 1052.315994603514, 1086.6522712732008, 1160.709822544364, 1164.4643464006483, 1175.647305808254, 5879.2944846618675, 5882.176495290662, 5933.910991335047, 5954.434328738763, 5958.106284057426, 9296.628134874529, 9393.859092113624, 9399.0, 9593.232541396672, 9607.375520591138, 9386.953065234768, 9390.060993900555, 9406.90593094074, 9466.432014079177, 9512.904870951203, 7092.680829362691, 7218.314260145278, 7222.422206223489, 7289.781306560812, 7455.813604659818, 7286.927130728837, 7378.262173782578, 7396.630168491662, 7440.888386674313, 7451.105867295959, 8456.788580285296, 8515.233628973423, 8535.573221339033, 8594.226519613265, 8669.0, 8534.146585341416, 8609.48343099416, 8613.82772344537, 8666.956665216634, 8732.476051436934, 7092.361687448154, 7094.503384763224, 7149.964250178716, 7175.390091842252, 7177.031100801325, 7469.477136600386, 7504.8499030018, 7525.134609519975, 7609.162992070978, 7610.315071643357, 7124.679389427384, 7180.856382872209, 7189.532680375759, 7203.063601731741, 7233.457490688114, 7078.433725302067, 7136.821579460555, 7148.571085734872, 7201.459890508338, 7248.492605517563, 7246.311600397954, 7281.1262648482525, 7288.562686238843, 7291.41668666516, 7299.598522081336, 6600.339966003361, 6666.633335166418, 6676.532642714963, 6682.398584127452, 6689.264180939996, 6390.64851433157, 6445.8388540285, 6453.51598630114, 6470.935290647033, 6478.902816457663], "unit": "ms", "name": "mootools.html", "value": 4592.690770791016}, {"lowerIsBetter": false, "replicates": [330.40527051307646, 339.9201187720886, 340.0326072324237, 340.5776836722465, 345.84782695613944, 6263.937360626393, 6321.0, 6327.841803954898, 6341.143945567353, 6363.936360636392, 6086.7869624563145, 6217.906731399022, 6237.844053898655, 6238.532110091739, 6280.5289603279825, 4737.478877323491, 4745.145873742725, 4753.287006948968, 4754.714717116975, 4761.857144285677, 4754.6434017448655, 4761.357216775743, 4773.045390921812, 4775.068861571995, 4777.116233496814, 4622.491525932145, 4736.71579705217, 4740.620750339965, 4745.6915300505525, 4759.167145749498, 4711.269753188261, 4717.646176536757, 4733.408323959505, 4733.4793172751315, 4745.976270118645, 4108.219438306712, 4121.216968775923, 4124.1957818225455, 4132.504099508048, 4134.276501612206, 5863.032599621058, 5907.232059832238, 5925.081612350093, 5926.051831706906, 5932.673702946337, 5412.56699464042, 5490.313710786152, 5534.75093620784, 5549.445055494459, 5553.0837411827, 6658.434033107192, 6659.0, 6660.0, 6663.866722665568, 6669.666516674147, 4571.9085618287445, 4572.245579479382, 4573.382593349888, 4575.885602859922, 4584.4957054723955, 6745.797626071226, 6906.136732908387, 6917.827054323632, 6929.203141638725, 6933.653317334113, 4662.673612847068, 4671.813127474863, 4700.7179569225955, 4709.034647897173, 4718.976405117953, 4761.047790441926, 4765.26138448541, 4770.904581908342, 4781.784819683123, 4783.354247176656, 5525.309336332958, 5540.861478463071, 5542.473465020817, 5543.584231182677, 5561.416051314553, 6598.802035938834, 6670.199576050905, 6677.9666101670155, 6683.198016238082, 6703.832404189837, 1623.6037008172962, 1658.5687721192576, 1661.509854592898, 1661.9750703739453, 1687.0130973380465, 1085.1318944844093, 1087.6247694545368, 1098.5990113608475, 1099.6755956992706, 1106.8727096384018, 6405.423511883952, 6419.6197817469465, 6434.517411194179, 6440.098386225932, 6454.19322584677, 6837.897431538531, 6849.452043836481, 6851.794446166623, 6865.656717164122, 6875.106236189264, 6393.104965304861, 6406.519511036691, 6425.742970281136, 6436.356364363526, 6441.484681225491, 3801.82891769871, 3826.9234615308096, 3827.3302172119766, 3830.5977872323006, 3832.405977073558, 7114.608696521637, 7139.82150446243, 7156.534825236343, 7175.103112110986, 7230.313120253568, 7003.789886303419, 7118.216996130422, 7156.284371562906, 7160.248173941765, 7168.677409516585, 7223.494355395177, 7223.638818059076, 7224.819379515554, 7232.92767072333, 7250.129984401906, 6941.409980151744, 6950.65246737651, 6953.478489113236, 6955.339242771928, 6976.895346569704, 6741.696623652046, 6873.931260687529, 6888.311168883071, 6903.378695917391, 6922.653867306715, 7160.606166660884, 7191.532550384418, 7197.604131772803, 7198.064251647462, 7212.062431883822, 4616.49218585962, 4658.487566367765, 4658.8136474542, 4661.953380466152, 4662.743549104832, 6880.311968803079, 6993.055937448379, 6993.860122797414, 6999.580025198505, 7004.789856304319, 6774.356436138559, 6788.25329213796, 6791.0, 6792.320767923366, 6806.523543351917, 6776.695048722918, 6783.457323414016, 6789.049533065276, 6798.592084474947, 6801.829954251183, 6552.148220731275, 6646.105859830119, 6649.368310010541, 6654.767083152066, 6664.133662623828, 6779.15260592426, 6784.3554862288, 6786.049953006682, 6801.795946121624, 6811.114555107804, 6557.2131344239, 6593.80218593443, 6614.0, 6620.271770105188, 6640.83397915056], "unit": "ms", "name": "prototype.html", "value": 5025.645510842535}, {"lowerIsBetter": false, "replicates": [689.5724650716556, 781.6638845296527, 848.7156802471172, 868.439856292691, 890.7550423633502, 13770.862291377083, 14039.649008774786, 14053.789193162098, 14083.929580352109, 14181.290935453224, 12100.576479823187, 12105.818412723816, 12120.454579543919, 12137.0, 12514.12401131921, 820.9055958564767, 829.929455996241, 835.2858306148247, 847.0766864118141, 855.1320409784043, 842.3513894301384, 850.2985037344216, 855.324293807891, 855.9400841941067, 858.6779957515931, 886.450400751535, 890.0520945193381, 891.5631340643071, 892.4199270474211, 894.1058941058941, 881.1012766977678, 881.5239770523909, 882.0297672560229, 883.5361435246483, 884.3897710579679, 648.1120864415733, 651.7718798420563, 652.0317328766778, 653.137858027404, 653.3923451190391, 13531.526396576171, 13621.659458513517, 13634.0, 13635.181889086687, 13645.38595763193, 11540.769184616345, 11640.534378624845, 11657.067434605211, 11692.0, 11874.0500759939, 9462.479563623998, 9533.332666713333, 9584.377015494041, 9632.759181020461, 10140.478928160761, 3509.982450087733, 3587.1749497615433, 3611.6749492545796, 3667.064898450905, 3692.612275711065, 44221.77889110566, 44816.77591612021, 49282.26076608854, 49848.75075624599, 49962.7501862492, 9101.908980910239, 9136.08639136081, 9160.725178244664, 9166.72499824993, 9170.082991700776, 16986.06576638272, 17085.829141708426, 17118.828811711974, 17128.74306885398, 17155.485335439957, 7385.3722433592675, 7577.659005344663, 7579.1662917079075, 7690.884636730453, 7744.845103097907, 4098.507641116584, 4145.523264824524, 4169.353750168729, 4225.070484493406, 4298.118885628439, 3282.097423208637, 3296.307775367152, 3303.487959366302, 3316.8673253070087, 3319.850606722703, 588.3675049321996, 605.9303180134253, 606.6996836565839, 613.2303958532013, 618.9969050154721, 597.9133025711247, 600.1148306248336, 615.6983078291605, 622.4988883948374, 648.6951132967498, 7187.532810367309, 7457.067866516685, 7531.397488200931, 7546.622668866535, 7797.103333116765, 546.2107255016542, 551.4265164229157, 614.4316507230793, 632.4466092169351, 654.5385503220218, 3482.5820901491984, 3607.494950706903, 3860.729748917605, 3996.5803590623145, 4087.1008378156757, 53473.0, 54455.0, 54482.72758636181, 54760.17859732107, 54943.725281373336, 50727.0, 50855.74572127116, 50940.490595094314, 51080.48919510832, 51729.48270517322, 44314.11371772611, 46720.299195512096, 47491.762541187076, 47567.76216118897, 48481.272780908315, 7755.573443460438, 7835.158737696523, 7974.960125199337, 8241.50550966944, 8284.958575207085, 34766.65233347634, 34962.47556286607, 35542.46686299759, 35601.28797424089, 35661.0, 43773.78113109414, 43814.78092609644, 43815.78092109646, 44495.332570010825, 44579.77710111429, 10699.197560182862, 10699.5185216667, 10822.67531974042, 10908.61819836302, 11052.613158539412, 11809.881901180877, 11945.761084778429, 11988.880111198776, 11990.340531270864, 12079.094067945114, 10397.064264215955, 10447.68656940293, 10526.157907367546, 10787.352758834495, 11465.426728663366, 10601.363918164934, 11286.379249141048, 11294.548218071513, 11625.88374116248, 11732.94133529327, 10747.623833165802, 10814.513346899252, 11295.830562541732, 11311.208215425171, 11389.772204556028, 9883.30816842814, 9976.256489643796, 10250.794984100425, 10419.583216671248, 10438.37369757817, 8354.832903342021, 9186.448813071238, 9223.63569137293, 9347.672831450867, 9650.276229282972], "unit": "ms", "name": "yui.html", "value": 6221.95043561979}], "name": "dromaeo_css", "value": 7035.793725991638}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 110.0, 111.0, 124.0, 109.0, 111.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 147.0, 170.0, 133.0, 149.0, 152.0, 128.0, 168.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 164.0, 162.0, 163.0, 163.0, 164.0, 165.0, 170.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 75.0, 71.0, 137.0, 72.0, 78.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 141.0, 92.0, 93.0, 93.0, 145.0, 93.0, 94.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 113.0, 111.0, 110.0, 111.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 145.0, 146.0, 151.0, 145.0, 147.0, 146.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 98.0, 96.0, 97.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 61.0, 59.0, 61.0, 62.0, 63.0, 62.0, 58.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 71.0, 71.0, 71.0, 70.0, 71.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 84.0, 87.0, 88.0, 86.0, 87.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [130.0, 121.0, 129.0, 125.0, 122.0, 124.0, 120.0, 119.0, 116.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 143.0, 149.0, 152.0, 148.0, 149.0, 152.0, 151.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 66.0, 68.0, 68.0, 65.0, 66.0, 66.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1518.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7000828500414], "unit": "score", "name": "Richards", "value": 213.04756999999998}, {"lowerIsBetter": false, "replicates": [187.2308556450103], "unit": "score", "name": "DeltaBlue", "value": 353.1362380000001}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [738.5524372230428], "unit": "score", "name": "Earley", "value": 902.3909019999996}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [679.3478260869565], "unit": "score", "name": "Splay", "value": 119.95475200000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21018.864696393484}]} 03:52:42 INFO - RETURN: dromaeo_css: 7035.80 03:52:42 INFO - RETURN: kraken: 1518.50 03:52:42 INFO - RETURN: v8_7: 21018.86 03:52:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21018.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1518.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7035.80"}}} 03:52:42 INFO - Return code: 0 03:52:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:52:42 INFO - # TBPL SUCCESS # 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - Running post-run listener: _resource_record_post_run 03:52:43 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529215488; Read time: 8; Write time: 669212 03:52:43 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 214228992; Read time: 0; Write time: 450316 03:52:43 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275353600; Read time: 8; Write time: 198316 03:52:43 INFO - Running post-run listener: _upload_blobber_files 03:52:43 INFO - Blob upload gear active. 03:52:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:52:43 INFO - Copying logs to upload dir... 03:52:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.574610 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-30 03:52:42.390428) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-30 03:52:42.393773) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/0fOnldHcTGq3lAahUnCJEQ/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-30 03:52:42.444362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:52:42.444709) ========= 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=0cff312cb257a7829adc5a5d000001df-1448880855.383174-678274158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-30 03:52:42.494315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 03:52:42.494617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-30 03:52:42.494911) ========= ========= Total master_lag: 0.24 =========