builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1447731695.33 results: success (0) buildid: 20151116173008 builduid: 9060aa9993f94b6e92371d16981027e8 revision: d1a8f65dbf479db6960b5c56ca9102839d0d561e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.329190) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.329629) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.329950) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006509 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.357138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.357479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.372079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.372360) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.427157) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.427461) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.427842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.428144) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 19:41:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.4M=0.001s 2015-11-16 19:41:36 (20.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.602290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.602640) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022167 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.663430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:35.663787) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d1a8f65dbf479db6960b5c56ca9102839d0d561e --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/b2g-inbound --rev d1a8f65dbf479db6960b5c56ca9102839d0d561e --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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 19:41:36,550 truncating revision to first 12 chars 2015-11-16 19:41:36,550 Setting DEBUG logging. 2015-11-16 19:41:36,550 attempt 1/10 2015-11-16 19:41:36,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d1a8f65dbf47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 19:41:36,806 unpacking tar archive at: b2g-inbound-d1a8f65dbf47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:36.218096) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:36.219257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:36.238816) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:36.239190) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 19:41:36.239651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-16 19:41:36.239966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:41:37 INFO - MultiFileLogger online at 20151116 19:41:37 in /builds/slave/test-pgo 19:41:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:41:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:41:37 INFO - {'append_to_log': False, 19:41:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:41:37 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:41:37 INFO - 'branch': 'B2G-Inbound', 19:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:41:37 INFO - 'config_files': ('talos/linux_config.py',), 19:41:37 INFO - 'default_actions': ('clobber', 19:41:37 INFO - 'read-buildbot-config', 19:41:37 INFO - 'download-and-extract', 19:41:37 INFO - 'populate-webroot', 19:41:37 INFO - 'create-virtualenv', 19:41:37 INFO - 'install', 19:41:37 INFO - 'run-tests'), 19:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:41:37 INFO - 'download_minidump_stackwalk': True, 19:41:37 INFO - 'download_symbols': 'ondemand', 19:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:41:37 INFO - 'installer_path': 'installer.exe', 19:41:37 INFO - 'log_level': 'info', 19:41:37 INFO - 'log_name': 'talos', 19:41:37 INFO - 'log_to_console': True, 19:41:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:41:37 INFO - 'opt_config_files': (), 19:41:37 INFO - 'pip_index': False, 19:41:37 INFO - 'sps_profile': False, 19:41:37 INFO - 'sps_profile_interval': 0, 19:41:37 INFO - 'suite': 'dromaeojs', 19:41:37 INFO - 'system_bits': '64', 19:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:41:37 INFO - 'title': 'talos-linux64-ix-068', 19:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:41:37 INFO - 'use_talos_json': True, 19:41:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:41:37 INFO - 'work_dir': 'build'} 19:41:37 INFO - ##### 19:41:37 INFO - ##### Running clobber step. 19:41:37 INFO - ##### 19:41:37 INFO - Running pre-action listener: _resource_record_pre_action 19:41:37 INFO - Running main action method: clobber 19:41:37 INFO - rmtree: /builds/slave/test-pgo/build 19:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:41:38 INFO - Running post-action listener: _resource_record_post_action 19:41:38 INFO - ##### 19:41:38 INFO - ##### Running read-buildbot-config step. 19:41:38 INFO - ##### 19:41:38 INFO - Running pre-action listener: _resource_record_pre_action 19:41:38 INFO - Running main action method: read_buildbot_config 19:41:38 INFO - Using buildbot properties: 19:41:38 INFO - { 19:41:38 INFO - "properties": { 19:41:38 INFO - "buildnumber": 975, 19:41:38 INFO - "product": "firefox", 19:41:38 INFO - "script_repo_revision": "production", 19:41:38 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:41:38 INFO - "repository": "", 19:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:41:38 INFO - "buildid": "20151116173008", 19:41:38 INFO - "slavename": "talos-linux64-ix-068", 19:41:38 INFO - "pgo_build": "True", 19:41:38 INFO - "basedir": "/builds/slave/test-pgo", 19:41:38 INFO - "project": "", 19:41:38 INFO - "platform": "ubuntu64_hw", 19:41:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:41:38 INFO - "slavebuilddir": "test", 19:41:38 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:41:38 INFO - "branch": "b2g-inbound", 19:41:38 INFO - "repo_path": "integration/b2g-inbound", 19:41:38 INFO - "stage_platform": "linux64-pgo", 19:41:38 INFO - "builduid": "9060aa9993f94b6e92371d16981027e8", 19:41:38 INFO - "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e" 19:41:38 INFO - }, 19:41:38 INFO - "sourcestamp": { 19:41:38 INFO - "repository": "", 19:41:38 INFO - "hasPatch": false, 19:41:38 INFO - "project": "", 19:41:38 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 19:41:38 INFO - "changes": [ 19:41:38 INFO - { 19:41:38 INFO - "category": null, 19:41:38 INFO - "files": [ 19:41:38 INFO - { 19:41:38 INFO - "url": null, 19:41:38 INFO - "name": "https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:41:38 INFO - } 19:41:38 INFO - ], 19:41:38 INFO - "repository": "", 19:41:38 INFO - "rev": "d1a8f65dbf479db6960b5c56ca9102839d0d561e", 19:41:38 INFO - "who": "sendchange", 19:41:38 INFO - "when": 1447731638, 19:41:38 INFO - "number": 6669807, 19:41:38 INFO - "comments": "", 19:41:38 INFO - "project": "", 19:41:38 INFO - "at": "Mon 16 Nov 2015 19:40:38", 19:41:38 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 19:41:38 INFO - "revlink": "", 19:41:38 INFO - "properties": [ 19:41:38 INFO - [ 19:41:38 INFO - "buildid", 19:41:38 INFO - "20151116173008", 19:41:38 INFO - "Change" 19:41:38 INFO - ], 19:41:38 INFO - [ 19:41:38 INFO - "builduid", 19:41:38 INFO - "9060aa9993f94b6e92371d16981027e8", 19:41:38 INFO - "Change" 19:41:38 INFO - ], 19:41:38 INFO - [ 19:41:38 INFO - "pgo_build", 19:41:38 INFO - "True", 19:41:38 INFO - "Change" 19:41:38 INFO - ] 19:41:38 INFO - ], 19:41:38 INFO - "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e" 19:41:38 INFO - } 19:41:38 INFO - ], 19:41:38 INFO - "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e" 19:41:38 INFO - } 19:41:38 INFO - } 19:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:41:38 INFO - Running post-action listener: _resource_record_post_action 19:41:38 INFO - ##### 19:41:38 INFO - ##### Running download-and-extract step. 19:41:38 INFO - ##### 19:41:38 INFO - Running pre-action listener: _resource_record_pre_action 19:41:38 INFO - Running main action method: download_and_extract 19:41:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:38 INFO - https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/test_packages.json 19:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/test_packages.json 19:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:41:41 INFO - Downloaded 1302 bytes. 19:41:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:41:41 INFO - Using the following test package requirements: 19:41:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:41:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'jsshell-linux-x86_64.zip'], 19:41:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:41:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:41:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:41:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:41:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:41:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:41:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:41:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:41 INFO - https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:41:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:45 INFO - Downloaded 22461615 bytes. 19:41:45 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 19:41:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:45 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 19:41:46 INFO - Return code: 0 19:41:46 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 19:41: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')]} 19:41:46 INFO - https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:47 INFO - Downloaded 22461615 bytes. 19:41:47 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 19:41:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:41:47 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 19:41:49 INFO - Return code: 0 19:41:49 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')]} 19:41:49 INFO - https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:41:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:41:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:41:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:49 INFO - Downloaded 11131693 bytes. 19:41:49 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 19:41:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:41:49 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 19:41:50 INFO - Return code: 0 19:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:50 INFO - https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:41:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:41:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:41:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-QMREWb2SieqOApEEtIy4Q/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 19:41:51 INFO - Downloaded 57159487 bytes. 19:41:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:41:51 INFO - mkdir: /builds/slave/test-pgo/properties 19:41:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:41:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:41:51 INFO - Contents: 19:41:51 INFO - build_url:https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:41:51 INFO - Running post-action listener: _resource_record_post_action 19:41:51 INFO - Running post-action listener: set_extra_try_arguments 19:41:51 INFO - ##### 19:41:51 INFO - ##### Running populate-webroot step. 19:41:51 INFO - ##### 19:41:51 INFO - Running pre-action listener: _resource_record_pre_action 19:41:51 INFO - Running main action method: populate_webroot 19:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:41:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:41:51 INFO - '../fennec_ids.txt'], 19:41:51 INFO - 'tests': ['tcheck2']}, 19:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:41:51 INFO - '--tppagecycles', 19:41:51 INFO - '7'], 19:41:51 INFO - 'tests': ['tsvgm']}}, 19:41:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:41:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:41:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:41:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'tests': ['damp', 'tps']}, 19:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['damp', 'tps']}, 19:41:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:41:51 INFO - 'other': {'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'other_l64': {'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'other_nol64': {'tests': ['a11yr', 19:41:51 INFO - 'ts_paint', 19:41:51 INFO - 'tpaint', 19:41:51 INFO - 'sessionrestore', 19:41:51 INFO - 'sessionrestore_no_auto_restore']}, 19:41:51 INFO - 'svgr': {'tests': ['tsvgx', 19:41:51 INFO - 'tsvgr_opacity', 19:41:51 INFO - 'tart', 19:41:51 INFO - 'tscrollx', 19:41:51 INFO - 'cart']}, 19:41:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['tsvgx', 19:41:51 INFO - 'tsvgr_opacity', 19:41:51 INFO - 'tart', 19:41:51 INFO - 'tscrollx', 19:41:51 INFO - 'cart']}, 19:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'tests': ['tp5o']}, 19:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'talos_options': ['--e10s'], 19:41:51 INFO - 'tests': ['tp5o']}, 19:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'talos_options': ['--xperf_path', 19:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:41:51 INFO - 'tests': ['tp5n']}, 19:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:51 INFO - 'talos_options': ['--e10s', 19:41:51 INFO - '--xperf_path', 19:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:41:51 INFO - 'tests': ['tp5n']}}, 19:41:51 INFO - 'talos.zip': {'path': '', 19:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:41:51 INFO - Running post-action listener: _resource_record_post_action 19:41:51 INFO - ##### 19:41:51 INFO - ##### Running create-virtualenv step. 19:41:51 INFO - ##### 19:41:51 INFO - Running pre-action listener: _resource_record_pre_action 19:41:51 INFO - Running main action method: create_virtualenv 19:41:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:41:51 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 19:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:41:51 INFO - Using real prefix '/usr' 19:41:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:41:52 INFO - Installing distribute.............................................................................................................................................................................................done. 19:41:54 INFO - Installing pip.................done. 19:41:54 INFO - Return code: 0 19:41:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:41:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:41:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:41:54 INFO - Using env: {'DISPLAY': ':0', 19:41:54 INFO - 'HOME': '/home/cltbld', 19:41:54 INFO - 'LANG': 'en_US.UTF-8', 19:41:54 INFO - 'LANGUAGE': 'en_US:en', 19:41:54 INFO - 'LOGNAME': 'cltbld', 19:41:54 INFO - 'MAIL': '/var/mail/cltbld', 19:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:54 INFO - 'MOZ_NO_REMOTE': '1', 19:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:54 INFO - 'NO_EM_RESTART': '1', 19:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:54 INFO - 'SHELL': '/bin/bash', 19:41:54 INFO - 'SHLVL': '1', 19:41:54 INFO - 'TERM': 'linux', 19:41:54 INFO - 'TMOUT': '86400', 19:41:54 INFO - 'USER': 'cltbld', 19:41:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:54 INFO - '_': '/tools/buildbot/bin/python'} 19:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:54 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 19:41:54 INFO - Cleaning up... 19:41:54 INFO - Return code: 0 19:41:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:41:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:41:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:41:54 INFO - Using env: {'DISPLAY': ':0', 19:41:54 INFO - 'HOME': '/home/cltbld', 19:41:54 INFO - 'LANG': 'en_US.UTF-8', 19:41:54 INFO - 'LANGUAGE': 'en_US:en', 19:41:54 INFO - 'LOGNAME': 'cltbld', 19:41:54 INFO - 'MAIL': '/var/mail/cltbld', 19:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:54 INFO - 'MOZ_NO_REMOTE': '1', 19:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:54 INFO - 'NO_EM_RESTART': '1', 19:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:54 INFO - 'SHELL': '/bin/bash', 19:41:54 INFO - 'SHLVL': '1', 19:41:54 INFO - 'TERM': 'linux', 19:41:54 INFO - 'TMOUT': '86400', 19:41:54 INFO - 'USER': 'cltbld', 19:41:54 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:54 INFO - '_': '/tools/buildbot/bin/python'} 19:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:54 INFO - Downloading/unpacking psutil>=0.7.1 19:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:41:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:41:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:56 INFO - Installing collected packages: psutil 19:41:56 INFO - Running setup.py install for psutil 19:41:56 INFO - building 'psutil._psutil_linux' extension 19:41:56 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 19:41:56 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 19:41:56 INFO - building 'psutil._psutil_posix' extension 19:41:56 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 19:41:56 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 19:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:56 INFO - Successfully installed psutil 19:41:56 INFO - Cleaning up... 19:41:56 INFO - Return code: 0 19:41:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:41:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:41:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:41:56 INFO - Using env: {'DISPLAY': ':0', 19:41:56 INFO - 'HOME': '/home/cltbld', 19:41:56 INFO - 'LANG': 'en_US.UTF-8', 19:41:56 INFO - 'LANGUAGE': 'en_US:en', 19:41:56 INFO - 'LOGNAME': 'cltbld', 19:41:56 INFO - 'MAIL': '/var/mail/cltbld', 19:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:56 INFO - 'MOZ_NO_REMOTE': '1', 19:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:56 INFO - 'NO_EM_RESTART': '1', 19:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:56 INFO - 'SHELL': '/bin/bash', 19:41:56 INFO - 'SHLVL': '1', 19:41:56 INFO - 'TERM': 'linux', 19:41:56 INFO - 'TMOUT': '86400', 19:41:56 INFO - 'USER': 'cltbld', 19:41:56 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:56 INFO - '_': '/tools/buildbot/bin/python'} 19:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:41:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:41:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:41: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) 19:41:58 INFO - Installing collected packages: mozsystemmonitor 19:41:58 INFO - Running setup.py install for mozsystemmonitor 19:41:58 INFO - Successfully installed mozsystemmonitor 19:41:58 INFO - Cleaning up... 19:41:58 INFO - Return code: 0 19:41:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:41:58 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')]} 19:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:58 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')]} 19:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:58 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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:41:58 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 19:41:58 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 19:41:58 INFO - Using env: {'DISPLAY': ':0', 19:41:58 INFO - 'HOME': '/home/cltbld', 19:41:58 INFO - 'LANG': 'en_US.UTF-8', 19:41:58 INFO - 'LANGUAGE': 'en_US:en', 19:41:58 INFO - 'LOGNAME': 'cltbld', 19:41:58 INFO - 'MAIL': '/var/mail/cltbld', 19:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:58 INFO - 'MOZ_NO_REMOTE': '1', 19:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:58 INFO - 'NO_EM_RESTART': '1', 19:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:58 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:58 INFO - 'SHELL': '/bin/bash', 19:41:58 INFO - 'SHLVL': '1', 19:41:58 INFO - 'TERM': 'linux', 19:41:58 INFO - 'TMOUT': '86400', 19:41:58 INFO - 'USER': 'cltbld', 19:41:58 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:58 INFO - '_': '/tools/buildbot/bin/python'} 19:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:42:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:42:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:42:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:42:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:42:00 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 19:42:00 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 19:42:00 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 19:42:00 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 19:42:00 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 19:42:00 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 19:42:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:42:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:01 INFO - Downloading docopt-0.6.1.tar.gz 19:42:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:42:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:42:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:42:01 INFO - Running setup.py install for blobuploader 19:42:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:42:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:42:01 INFO - Running setup.py install for requests 19:42:01 INFO - Running setup.py install for docopt 19:42:02 INFO - Successfully installed blobuploader requests docopt 19:42:02 INFO - Cleaning up... 19:42:02 INFO - Return code: 0 19:42:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42: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')]} 19:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:42: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 19:42: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 19:42:02 INFO - Using env: {'DISPLAY': ':0', 19:42:02 INFO - 'HOME': '/home/cltbld', 19:42:02 INFO - 'LANG': 'en_US.UTF-8', 19:42:02 INFO - 'LANGUAGE': 'en_US:en', 19:42:02 INFO - 'LOGNAME': 'cltbld', 19:42:02 INFO - 'MAIL': '/var/mail/cltbld', 19:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:02 INFO - 'MOZ_NO_REMOTE': '1', 19:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:02 INFO - 'NO_EM_RESTART': '1', 19:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:02 INFO - 'SHELL': '/bin/bash', 19:42:02 INFO - 'SHLVL': '1', 19:42:02 INFO - 'TERM': 'linux', 19:42:02 INFO - 'TMOUT': '86400', 19:42:02 INFO - 'USER': 'cltbld', 19:42:02 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:02 INFO - '_': '/tools/buildbot/bin/python'} 19:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:02 INFO - Running setup.py (path:/tmp/pip-EMSEEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:02 INFO - Running setup.py (path:/tmp/pip-pz8_FG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:02 INFO - Running setup.py (path:/tmp/pip-FwrS5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:02 INFO - Running setup.py (path:/tmp/pip-pR2GeC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:02 INFO - Running setup.py (path:/tmp/pip-3Vn67X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:02 INFO - Running setup.py (path:/tmp/pip-0cOgyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:02 INFO - Running setup.py (path:/tmp/pip-JEyCXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:02 INFO - Running setup.py (path:/tmp/pip-BhVQv6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:02 INFO - Running setup.py (path:/tmp/pip-rHUDHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:03 INFO - Running setup.py (path:/tmp/pip-hewqSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:03 INFO - Running setup.py (path:/tmp/pip-TZYgcg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:03 INFO - Running setup.py (path:/tmp/pip-YbnL89-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:03 INFO - Running setup.py (path:/tmp/pip-e8_e72-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:03 INFO - Running setup.py (path:/tmp/pip-BVKjWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:03 INFO - Running setup.py (path:/tmp/pip-Gl4G5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:03 INFO - Running setup.py (path:/tmp/pip-Xv3qqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:03 INFO - Running setup.py (path:/tmp/pip-FF9aks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:42:03 INFO - Running setup.py install for manifestparser 19:42:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:42:03 INFO - Running setup.py install for mozcrash 19:42:03 INFO - Running setup.py install for mozdebug 19:42:03 INFO - Running setup.py install for mozdevice 19:42:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozfile 19:42:04 INFO - Running setup.py install for mozhttpd 19:42:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozinfo 19:42:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozInstall 19:42:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozleak 19:42:04 INFO - Running setup.py install for mozlog 19:42:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for moznetwork 19:42:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozprocess 19:42:04 INFO - Running setup.py install for mozprofile 19:42:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:42:04 INFO - Running setup.py install for mozrunner 19:42:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:42:05 INFO - Running setup.py install for mozscreenshot 19:42:05 INFO - Running setup.py install for moztest 19:42:05 INFO - Running setup.py install for mozversion 19:42:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:42:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:42:05 INFO - Cleaning up... 19:42:05 INFO - Return code: 0 19:42:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42: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')]} 19:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:42: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 19:42: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 19:42:05 INFO - Using env: {'DISPLAY': ':0', 19:42:05 INFO - 'HOME': '/home/cltbld', 19:42:05 INFO - 'LANG': 'en_US.UTF-8', 19:42:05 INFO - 'LANGUAGE': 'en_US:en', 19:42:05 INFO - 'LOGNAME': 'cltbld', 19:42:05 INFO - 'MAIL': '/var/mail/cltbld', 19:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:05 INFO - 'MOZ_NO_REMOTE': '1', 19:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:05 INFO - 'NO_EM_RESTART': '1', 19:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:05 INFO - 'SHELL': '/bin/bash', 19:42:05 INFO - 'SHLVL': '1', 19:42:05 INFO - 'TERM': 'linux', 19:42:05 INFO - 'TMOUT': '86400', 19:42:05 INFO - 'USER': 'cltbld', 19:42:05 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:05 INFO - '_': '/tools/buildbot/bin/python'} 19:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42:05 INFO - Running setup.py (path:/tmp/pip-Z6xAL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:42: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)) 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42:05 INFO - Running setup.py (path:/tmp/pip-hMy2ea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:42: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)) 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42:05 INFO - Running setup.py (path:/tmp/pip-kl3Kg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:42: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)) 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:05 INFO - Running setup.py (path:/tmp/pip-jy3qSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:42:05 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)) 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:05 INFO - Running setup.py (path:/tmp/pip-tIb6Qx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:42:05 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)) 19:42:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42:05 INFO - Running setup.py (path:/tmp/pip-B7NHW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42:06 INFO - Running setup.py (path:/tmp/pip-bm7p1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42:06 INFO - Running setup.py (path:/tmp/pip-4imcPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42:06 INFO - Running setup.py (path:/tmp/pip-LtAuoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:06 INFO - Running setup.py (path:/tmp/pip-hevmBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42:06 INFO - Running setup.py (path:/tmp/pip-Z7yxJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42:06 INFO - Running setup.py (path:/tmp/pip-daygvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42:06 INFO - Running setup.py (path:/tmp/pip-oBU0XV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42:06 INFO - Running setup.py (path:/tmp/pip-2WuL7W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42:06 INFO - Running setup.py (path:/tmp/pip-ifNmqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:42:06 INFO - Running setup.py (path:/tmp/pip-gJEGnU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:42: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)) 19:42:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42:06 INFO - Running setup.py (path:/tmp/pip-WIEW2d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:08 INFO - Downloading blessings-1.5.1.tar.gz 19:42: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 19:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:42:08 INFO - Installing collected packages: blessings 19:42:08 INFO - Running setup.py install for blessings 19:42:08 INFO - Successfully installed blessings 19:42:08 INFO - Cleaning up... 19:42:08 INFO - Return code: 0 19:42:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:42:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:42:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:42:08 INFO - Reading from file tmpfile_stdout 19:42:08 INFO - Current package versions: 19:42:08 INFO - argparse == 1.2.1 19:42:08 INFO - blessings == 1.5.1 19:42:08 INFO - blobuploader == 1.2.4 19:42:08 INFO - docopt == 0.6.1 19:42:08 INFO - manifestparser == 1.1 19:42:08 INFO - mozInstall == 1.12 19:42:08 INFO - mozcrash == 0.16 19:42:08 INFO - mozdebug == 0.1 19:42:08 INFO - mozdevice == 0.47 19:42:08 INFO - mozfile == 1.2 19:42:08 INFO - mozhttpd == 0.7 19:42:08 INFO - mozinfo == 0.9 19:42:08 INFO - mozleak == 0.1 19:42:08 INFO - mozlog == 3.0 19:42:08 INFO - moznetwork == 0.27 19:42:08 INFO - mozprocess == 0.22 19:42:08 INFO - mozprofile == 0.27 19:42:08 INFO - mozrunner == 6.11 19:42:08 INFO - mozscreenshot == 0.1 19:42:08 INFO - mozsystemmonitor == 0.0 19:42:08 INFO - moztest == 0.7 19:42:08 INFO - mozversion == 1.4 19:42:08 INFO - psutil == 3.1.1 19:42:08 INFO - requests == 1.2.3 19:42:08 INFO - wsgiref == 0.1.2 19:42:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:42:08 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')]} 19:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:08 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')]} 19:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:08 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 0x7fa38482bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', '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 19:42:08 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 19:42:08 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 19:42:08 INFO - Using env: {'DISPLAY': ':0', 19:42:08 INFO - 'HOME': '/home/cltbld', 19:42:08 INFO - 'LANG': 'en_US.UTF-8', 19:42:08 INFO - 'LANGUAGE': 'en_US:en', 19:42:08 INFO - 'LOGNAME': 'cltbld', 19:42:08 INFO - 'MAIL': '/var/mail/cltbld', 19:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:08 INFO - 'MOZ_NO_REMOTE': '1', 19:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:08 INFO - 'NO_EM_RESTART': '1', 19:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:08 INFO - 'SHELL': '/bin/bash', 19:42:08 INFO - 'SHLVL': '1', 19:42:08 INFO - 'TERM': 'linux', 19:42:08 INFO - 'TMOUT': '86400', 19:42:08 INFO - 'USER': 'cltbld', 19:42:08 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:08 INFO - '_': '/tools/buildbot/bin/python'} 19:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42: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)) 19:42:09 INFO - Cleaning up... 19:42:09 INFO - Return code: 0 19:42:09 INFO - Running post-action listener: _resource_record_post_action 19:42:09 INFO - Running post-action listener: _start_resource_monitoring 19:42:09 INFO - Starting resource monitoring. 19:42:09 INFO - ##### 19:42:09 INFO - ##### Running install step. 19:42:09 INFO - ##### 19:42:09 INFO - Running pre-action listener: _resource_record_pre_action 19:42:09 INFO - Running main action method: install 19:42:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:42:09 INFO - Reading from file tmpfile_stdout 19:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:42:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:42:09 INFO - Reading from file tmpfile_stdout 19:42:09 INFO - Output received: 19:42:09 INFO - Usage: mozinstall [options] installer 19:42:09 INFO - Options: 19:42:09 INFO - -h, --help show this help message and exit 19:42:09 INFO - -d DEST, --destination=DEST 19:42:09 INFO - Directory to install application into. [default: 19:42:09 INFO - "/builds/slave/test-pgo"] 19:42:09 INFO - --app=APP Application being installed. [default: firefox] 19:42:09 INFO - mkdir: /builds/slave/test-pgo/build/application 19:42:09 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'] 19:42:09 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 19:42:23 INFO - Reading from file tmpfile_stdout 19:42:23 INFO - Output received: 19:42:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:42:23 INFO - Running post-action listener: _resource_record_post_action 19:42:23 INFO - ##### 19:42:23 INFO - ##### Running run-tests step. 19:42:23 INFO - ##### 19:42:23 INFO - Running pre-action listener: _resource_record_pre_action 19:42:23 INFO - Running main action method: run_tests 19:42:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:42:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:42:23 INFO - Python 2.7.3 19:42:23 INFO - Return code: 0 19:42:23 INFO - grabbing minidump binary from tooltool 19:42:23 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')]} 19:42:23 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 0x2cdba90>, '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 0x2d2df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d2e2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:42:23 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 19:42:23 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 19:42:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:42:23 INFO - Return code: 0 19:42:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:42:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:42:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:42:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:42:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:42:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:42:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 19:42:23 INFO - Using env: {'DISPLAY': ':0', 19:42:23 INFO - 'HOME': '/home/cltbld', 19:42:23 INFO - 'LANG': 'en_US.UTF-8', 19:42:23 INFO - 'LANGUAGE': 'en_US:en', 19:42:23 INFO - 'LOGNAME': 'cltbld', 19:42:23 INFO - 'MAIL': '/var/mail/cltbld', 19:42:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:42:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:23 INFO - 'MOZ_NO_REMOTE': '1', 19:42:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:23 INFO - 'NO_EM_RESTART': '1', 19:42:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:42:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:42:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:42:23 INFO - 'SHELL': '/bin/bash', 19:42:23 INFO - 'SHLVL': '1', 19:42:23 INFO - 'TERM': 'linux', 19:42:23 INFO - 'TMOUT': '86400', 19:42:23 INFO - 'USER': 'cltbld', 19:42:23 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529', 19:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:23 INFO - '_': '/tools/buildbot/bin/python'} 19:42:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 19:42:24 INFO - mozversion INFO | application_buildid: 20151116173008 19:42:24 INFO - mozversion INFO | application_changeset: d1a8f65dbf479db6960b5c56ca9102839d0d561e 19:42:24 INFO - mozversion INFO | application_display_name: Nightly 19:42:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:42:24 INFO - mozversion INFO | application_name: Firefox 19:42:24 INFO - mozversion INFO | application_remotingname: firefox 19:42:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:42:24 INFO - mozversion INFO | application_vendor: Mozilla 19:42:24 INFO - mozversion INFO | application_version: 45.0a1 19:42:24 INFO - mozversion INFO | platform_buildid: 20151116173008 19:42:24 INFO - mozversion INFO | platform_changeset: d1a8f65dbf479db6960b5c56ca9102839d0d561e 19:42:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:42:24 INFO - mozversion INFO | platform_version: 45.0a1 19:42:24 INFO - 2015-11-16 19:42:24,140 DEBUG : using testdate: 1447731744 19:42:24 INFO - 2015-11-16 19:42:24,140 DEBUG : actual date: 1447731744 19:42:24 INFO - 2015-11-16 19:42:24,187 INFO : starting webserver on 'localhost:48995' 19:42:24 INFO - 2015-11-16 19:42:24,188 INFO : Starting test suite talos-linux64-ix-068 19:42:24 INFO - 2015-11-16 19:42:24,188 INFO : Starting test dromaeo_css 19:42:24 INFO - 2015-11-16 19:42:24,188 DEBUG : operating with platform_type : linux_ 19:42:24 INFO - 2015-11-16 19:42:24,189 INFO : Initialising browser for dromaeo_css test... 19:42:24 INFO - 2015-11-16 19:42:24,203 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDwOqt5/profile http://localhost:48995/getInfo.html 19:42:28 INFO - 2015-11-16 19:42:28,332 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:42:28 INFO - 2015-11-16 19:42:28,332 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:42:28 INFO - 2015-11-16 19:42:28,332 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:42:28 INFO - 2015-11-16 19:42:28,332 DEBUG : BROWSER_OUTPUT: __metrics 19:42:28 INFO - 2015-11-16 19:42:28,635 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:29 INFO - 2015-11-16 19:42:29,824 INFO : Browser initialized. 19:42:29 INFO - 2015-11-16 19:42:29,824 INFO : Running cycle 1/1 for dromaeo_css test... 19:42:29 INFO - 2015-11-16 19:42:29,825 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDwOqt5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:42:41 INFO - 2015-11-16 19:42:41,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 142049280 19:42:41 INFO - 2015-11-16 19:42:41,645 DEBUG : BROWSER_OUTPUT: 19:43:33 INFO - 2015-11-16 19:43:33,404 DEBUG : BROWSER_OUTPUT: 1447731813401 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] 19:45:41 INFO - 2015-11-16 19:45:41,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48995/tests/dromaeo/cssquery-ext.html) 19:45:43 INFO - 2015-11-16 19:45:43,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 262770688 19:45:43 INFO - 2015-11-16 19:45:43,035 DEBUG : BROWSER_OUTPUT: 19:48:45 INFO - 2015-11-16 19:48:45,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-ext.html (next: http://localhost:48995/tests/dromaeo/cssquery-jquery.html) 19:48:46 INFO - 2015-11-16 19:48:46,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 226467840 19:48:46 INFO - 2015-11-16 19:48:46,119 DEBUG : BROWSER_OUTPUT: 19:51:47 INFO - 2015-11-16 19:51:47,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48995/tests/dromaeo/cssquery-mootools.html) 19:51:48 INFO - 2015-11-16 19:51:48,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 216653824 19:51:48 INFO - 2015-11-16 19:51:48,484 DEBUG : BROWSER_OUTPUT: 19:54:50 INFO - 2015-11-16 19:54:50,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48995/tests/dromaeo/cssquery-prototype.html) 19:54:50 INFO - 2015-11-16 19:54:50,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 201043968 19:54:50 INFO - 2015-11-16 19:54:50,889 DEBUG : BROWSER_OUTPUT: 19:57:53 INFO - 2015-11-16 19:57:53,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48995/tests/dromaeo/cssquery-yui.html) 19:57:53 INFO - 2015-11-16 19:57:53,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 205602816 19:57:53 INFO - 2015-11-16 19:57:53,926 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/dromaeo/cssquery-yui.html (next: http://localhost:48995/tests/dromaeo/cssquery-dojo.html) 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 259211264 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:00:56 INFO - 2015-11-16 20:00:56,420 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:00:56 INFO - 2015-11-16 20:00:56,424 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3204.919877003075;3270.5748252727144;3292.275699346143;3303.2237424205323;3314.685104915033;5277.551408130314;5342.118550439182;5464.23500709901;5481.12302031675;5502.119660854264;5479.2602998595175;5490.039243132456;5563.388027316992;5586.497215250627;5594.888102237953;5033.6728112672745;5076.593872490211;5078.148155466418;5139.768710408022;5158.3552055993005;5102.438731739506;5181.715005674687;5190.195519694435;5190.429052804188;5209.505097015777;4790.856274311776;4892.902141957141;4913.950860491421;5049.570786483153;5050.646454748169;5027.673201241944;5034.3455350804525;5035.219540971156;5050.7222102784335;5082.542571168613;5012.624053195988;5019.046381187599;5028.748562571856;5037.219231019198;5061.316722242487;5163.40620828602;5271.051210782058;5313.814016509404;5378;5384;5872;6040.426159514839;6059.757609695607;6064.787732429388;6077.878442431171;6072.696365181768;6088.269407671063;6091.325109430976;6091.390860913917;6094.238220222473;5405.540529055035;5454.53636440903;5493.313335833021;5533.142362933751;5565.666060036411;6065.848353791102;6067.696615169224;6070.848228794227;6095.4818840398175;6129.172561704202;5662.292213473316;5884.7940322088525;5886.646801191942;5890.911636325459;5893.882122357529;5785.71071446426;5884.382139875337;5908.20239267702;5914.881702366015;5922.8815423691285;5936.614120082181;5939.495142912814;5945.940540594539;5967.79112731061;5974.2233509643465;5663.320401551758;5931.703414829241;5950.940490595039;5951.702414879239;5961.463468287789;4466.64266858657;4510.458744950627;4520.909581808345;4541.795619197144;4586.816527338936;4080.3063479208604;4104;4114.115465174942;4145.357469592218;4146.212219678251;5556.777728890799;5669.262995810601;5713.857153571194;5730.34101078373;5735.541156707537;5917.881642367129;5953.910691339634;5973.731182096816;5979.850503737354;6005.609635373687;5625.493705566437;5629.662220266715;5649.858753531113;5700.515456186187;5717.171010203498;5011.874703132451;5154.742262886841;5171.844844654666;5202.765875535534;5272.604554658416;6029.758809647565;6044.486218671374;6047.78832740852;6110.170335690841;6141.324454310112;6013.609115407485;6079.05774604937;6085.939140608537;6087.178230938944;6094.085887116968;5936.851578710567;6258.311585725658;6260.812175634738;6289.96855015722;6294.905576416266;5784.4504772046585;5787.160861675117;5815.912761308668;5889.469947704727;5927.2590926134235;5910.586258961831;5912.497437717842;5914.260717410324;5919.881602368015;6034.909476357946;5655.179998900054;5764.596478246483;5765.308163020464;5767.596268261182;5770.884582308414;5735.770569177186;5739.8565035874435;5761.07822748375;5864.794732184524;5873.765049397976;5717.7141142941855;5743.7989670363;5748.540116790563;5749.683767392834;5762.8847423050465;5670.092785154356;5858.677772722541;5878.706064696663;5900.380460051632;5913.29040515141;5689.601727879174;5719.942800572107;5771.855703607275;5791.739371728198;5824.126381042877 20:00:56 INFO - 2015-11-16 20:00:56,424 DEBUG : BROWSER_OUTPUT: |1;ext.html;583.1107560969521;585.5871610514588;587.4125874125874;590.2503820148413;602.0337358539547;30481.39037219254;40166;40993.795031024805;40998.38502422466;41066.178676426454;44305.77847110768;44822.32766508505;44854.77572612133;44860.55139448604;44900.77549612247;7660.080790305144;7820.296173344398;8723.214910658055;8899.065598112202;8899.466032038066;10494.790104197911;10721;10786.137109031299;10808.243422960357;10827.78344433111;10383.532741026635;10505.474726263694;10508.684739457829;10514.579416823319;10527.368357898513;7737.9226207737765;7975.920240797575;7977.641006154737;8012.959935200345;10399.636012739556;10493.895061049368;10793.83809242862;10794.73013174669;10797.46012699362;10799.136069114453;41034.38448423276;41290;41374.37938430926;41421.79289103566;41482.792586037176;3206.9679303206904;3255.2675647979254;3300.3399320135827;3423.726101911841;3616.914925522333;30505.69494305051;31064.22339441532;31145.688543114506;31172.220694482592;31522.684773152432;3461.5326930864517;3674.0998455378603;3709.462127991453;3718.4236443351324;3760.417135344026;284652;284836;285236;285964;286513.9999999979;57515;58842.41157588369;60348;60806.39193608096;61207.387926120166;55767;55820.85970543237;56067.71966140143;56105.43894561084;56220.43779562234;13473.663158421117;13711.725765484634;13737.450501979809;13786.724265514633;13865.23741194244;10641.148708103334;10692.251542391958;10728.088112510368;10856.294340867818;10914.508847101899;18932.81067189338;19198.232070717015;19620;19686;19850;7543.547387156788;7738.574378409129;7840;7852.293293603603;7884.84230315402;875.6891303587262;891.7057371067532;1124.2242852431796;1138.8177891537314;1157.1032449851432;28641.28396790097;28927;29001.419971600873;29327.706722932926;29598;989.5349185882624;1042.1454407386022;1047.1361127070197;1102.079763397556;1104.7900898829196;15161.166135862633;15216.239188040554;15390.3074361654;15446.691066178613;15713.528594142193;353290;357472;358309;358596;360412;53770.7311463448;53901.1914821278;54015.45984540183;54019.18971215435;54102.966614339886;1341.8658134186503;1352.9052966292265;1371.9725605487833;1375.3742047368623;1377.2975782351073;22285.428904373344;28080.578791318556;28649.570256445753;29167.124986250445;29620.555691665075;43703.78148109239;44043.35739855619;44177.55822441863;44179;44262.778686106365;233954;233986;234260;235005;391682;27357.72642273552;31100.222494436915;31278.843605781825;31336.21659458532;31833.36333273368;37822.243555128196;37975.430368543944;38391.42412863753;38973;39054.4141837867;34102.48846267258;40256.3961540583;45157.32264016108;45695.54304456913;45859;38482.61517384902;39269.2146157081;40871;41421;42326.15347693091;37476.812615936746;37571;37769.62230377771;40638.187236255704;40662.59337406588;38036;38530.80734596309;39287.01782455347;39670.80164599159;40285.79857100813;26668.19995400141;27030.1890943272;27191.320216994733;27249.455010900067;27260 20:00:56 INFO - 2015-11-16 20:00:56,428 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.5364465261202;348.7157966257498;349.67480243373655;350.9491123787051;354.2878813584696;17256.98002849501;17658.64682706347;17846.196921138548;18309.169083091685;18313.35903243387;16423.83576164241;16536.66926661466;16770;17195.140242987833;17199.312027518885;5094.210397388401;5103.2855400244;5202.713850738208;5204.557612602934;5249.842504724865;5233.842984710445;5284;5284.709340986245;5288.524032837044;5292.788288468457;3845.576986531479;4122.4228607994755;5234.7120908350025;5236.162214045753;5236.764345604438;4058.5738497457783;5959.255093113361;5959.880802383971;5963.19496867926;5963.28440587128;4206.789660516962;4283.935740963888;5210.270562121268;5211.166213405837;5215.478452154792;12045.759084818343;12503.249805011728;13883.583492495241;14304.499342522962;14529.636759081002;1720.81931397204;1939.7187407825927;1959.4905324615702;1993.8604297699167;2045.8977051147533;9692.41845489273;9805.31362804604;9997.550110244983;10154.695359139238;10362.430066346347;1592.1243316176058;1594.4100682747342;1616.2161351744394;1628.8696904247631;1662.1772222749696;58950.705246473495;59800.102998455055;60787;61188;61801.690991545205;7054.506184567031;7117.3238542338395;7118.967749676372;7138.535995160298;7184.82037949045;8541.786455338666;8544;8545.786355341043;8554.572271386405;8555.230029297392;5386.084365657847;5444.265024221759;5444.673319600757;5519.530839878656;5626.2967129108865;5412.891742165213;5433.157860531624;5610.663360198401;5636.859078522988;5654.038813401731;3311.089450401159;3334.1997920498907;3345.983270083634;3364.1253274148407;3369.5451114099774;1156.4969238381163;1165.2172176569861;1165.9008984236266;1175.26545908807;1210.6005018344101;456.121965216956;471.2248351461826;476.8032239079934;488.2042271098158;496.36465324384847;11896.16726829131;12122.939385303018;12402.689932751753;12429.37853107341;12454.190477618926;461.2366533387249;471.1613328275675;489.09517392822994;529.4811085136588;530.5755395683437;4776.498467660846;6308;6620.139381880421;6731.057651928734;6759.324067593201;390711;390789;392989;398166;480642;60363.69818150969;61290.38709612847;62159;80296.19703803003;80497.59751201324;543.5542854858978;559.3036669346608;561.5199004850875;561.901667208237;561.9859503512445;10602.469876506299;11152.275102118336;11259.774804504028;11436.313821170756;11547.13396495283;34327;34462.655373445945;35265;36712.449313260855;37319.813400933905;42647.360289596305;43549;43867;44239.336409953234;44811.77594112139;6687.6321802301345;6867.21027081872;6909.654517274015;6932.653367331714;6949.478789090737;12140.75718485643;12381.133320667466;12460;12502;12621.495140194656;10761.139108871428;10824.188185885932;10863.456827158769;10994.34033957965;11090.168237382068;10201.846972295272;10504;10630.415327156772;10720.780129088822;10793.40636265013;10685.305455145392;11252.66242012741;11379.487923043318;11559.711007224887;11580.36308003068;6659.433948114271;6828.624425656637;6958.79123626292;6963.059986901703;6970.302969702989;11028.944855275673;11076.501557429774;11122.721931951766;11209.327440353605;11463.770724585294 20:00:56 INFO - 2015-11-16 20:00:56,428 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1311.377095879458;1672.3059930128995;1689.2736123466912;1709.1795937949792;1720.6750801882547;6573.244076931154;7525.51084179528;7757.10793258774;7768.4562080654305;7768.650410731517;7529.510581812192;7631.275028872262;7665.731699390522;7671.50135241209;7692.692292308301;1993.5913137806788;2028.310374472679;2033.593281343737;2212.5132470856424;2235.2958817972367;2023.989880050605;2228.8632797273426;2291.4271432141963;2299.1608063056947;2300.539892021594;2200.8129309008673;2223.399682085836;2231.364061242546;2265.535565209128;2270.545890821834;1981.0688976181243;2021.6259991901545;2257.074599414232;2269.4439862233694;2303.8963246653857;2283.931482055541;2290.03818396274;2295.3802473332275;2296.9310920672406;2297.1156104899733;7399.4450416219;7517.097948246191;7523.059617547807;7525.548467091992;7526.24737526243;4512.638988880882;4585.266357382803;4605.102005109005;4621.37611422457;4630.374899388573;2986.910392688223;3060.1890499017777;3084.5064789633775;3095.9845200773852;3104.3170502489415;993.7813680990171;1006.8489726541004;1019.2253887045824;1031.102940441813;1054.8997845204694;10625.203109766799;10680.732981675521;10690.358578485315;10701.999999999922;10708.78582428347;4265.3601959705675;4328.04782947751;4343.500497442835;4385.51759306476;4387.341898715218;8765.07966663491;8853.73438796837;8855.955720221358;8867.645294188289;8870.246029087471;4706.788194531255;4712.835050773207;4735.337052812609;4741.051789642085;4746.288056791509;4252.447181866338;4284.807183676679;4292.334688123346;4303.397524346594;4305.052888364555;3639.94540081899;3665.9450108248398;3688.686461650736;3699.963000370016;3700.481932529448;1169.8888605582626;1181.8640856301636;1192.5647138794277;1198.4307453959475;1198.6463993121877;1308.8952883769275;1311.895048396126;1312.4312814364048;1328.880400763936;1351.716139610673;7020.438364930793;7107.324804143598;7137.89293160603;7139.036230108973;7139.928600713926;488.95599396053814;490.19363147622676;491.6632107006712;496.58783209935666;510.16842546648724;5206.843794686166;5296.814611488579;5654.773809047674;5770.682612456355;5936.910946335808;8430.578471076422;8677.262432693291;8804.383693141419;8830.823383532294;8878.600462979182;8733.519656418957;8767.676565710091;8890.06654301289;8901.866472002925;8962.910370896208;6892.862142757217;6904.13698287714;6962.930370696329;6998.440124790106;7000.9649951750935;6833.453323734188;7014.824629384306;7016.5790052597;7043.436525078084;7048.083749112582;7910.8813367798375;8059.798505037421;8168.3465322772845;8364.958175209085;8367.790805229917;8135.75592732219;8355.248027677539;8522.062573116827;8536.274416674652;8543.530105843989;6921.446284297345;6999.615021173884;7068.974998625068;7091.503594748318;7097.964510177416;7252.87580425035;7441.1070671519765;7451.254874512505;7451.701931922662;7466;6947;7071.116110486189;7155.998160257464;7222.458315626244;7264.164621068433;7039.395423693266;7048.823779405556;7053.753118640823;7142.5714457132735;7182.281771822776;6740.359665831738;6789.660516974231;6811.761588344384;6821.488388370793;6824.454043676593;6456.031595260749;6495.675216239264;6501.44737697301;6503.577267477599;6509.088727578048;6499.480041596756;6521.608703477807;6533.836654083496;6539.738410463528;6585.670716464253 20:00:56 INFO - 2015-11-16 20:00:56,428 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.20731311942296;328.01922252465107;328.34495182111687;328.4793602140607;334.59179800643216;5957.225560677111;6001.189839371678;6010.549208809341;6036.788712395067;6093.78671746489;5721.199032135494;5803.303603567567;5862.472377486026;5959.672218028007;6006.4293892080295;4608.5161058088925;4637.675362724611;4638.814447422107;4647.14027904837;4648.1865673507;4433.4901486329;4638;4645.047765208141;4645.210314246569;4653.86038418848;4431.534688857671;4443.977885086432;4533.977330113345;4550.226461501553;4555.088982203556;4553.726776393411;4557.609928971662;4566.589006989387;4578.313253012058;4583.72497650142;4019.2966230909765;4021.3565829467143;4027.134166154291;4028.395740638898;4033.3748269018347;5533.114701647757;5637.80267690633;5640.492355687967;5644.887102257973;5660.3490598581275;5339.893202135974;5349.277847490578;5352.464753524617;5359.249705041298;5363.9463605363835;6296.937030629727;6330.9683451582905;6335.334789847046;6343.46080583151;6350.079238510436;4455.240180128863;4457.309117086825;4467.084247729208;4469.262571675669;4470.329450582439;6419.069234960904;6583;6601.900971485384;6621.33786621334;6629.7348106075215;4423.159599676052;4424.668149888771;4431.711938723973;4441.733495990251;4442.622377097919;4486.304622783474;4490.887727806831;4495.056038232008;4500.504944456107;4501.324801279834;5245.501677340647;5248.685078895279;5249.658772179872;5252.264682944391;5260.842174734764;6211.875762484725;6438.645874476855;6452.064450654629;6456.225252969673;6465.224173099165;1575.4170956745847;1593.80874295083;1596.0822527046994;1597.6884507521154;1598.3846219205457;1030.835066389374;1035.425338936882;1040.2977989856815;1064;1078.5146683992234;6202.100695399142;6206.689665516707;6213.1922850029205;6213.937860621426;6214.098955651405;6601.108850305243;6602.471802255808;6611.173603299588;6618.768343107968;6618.933810661928;6029.186059881948;6145.661988590581;6159.722812473449;6173.135760993465;6181.412765787243;3509.964560454672;3555.2356243407276;3569.37535931211;3573.874914377984;3578.9642103579154;6814.931850681529;6833.555818871758;6844.726210951506;6887.965560172167;6913.343232392915;6668.366505182;6789.626570538569;6842.589444633338;6847.965760171267;6851.2806155353965;6862.142232221072;6905.343992320722;6910.827229319308;6916.861662766817;6921.377076063179;6487.870242595216;6658.234303055017;6669.333066693292;6670.966645166744;6673.199216093905;6534.803955881332;6584.209894812653;6616.437602803623;6622.933770662232;6627.37039981201;6861.862762744817;6885.554033652989;6901.206361268519;6936.098307220029;6936.375726184668;4512;4521.79651915658;4525.954740452553;4526.411566496467;4527.366168736446;6562.310957349409;6639.867202655823;6663.333666633298;6669.699863506251;6677.432418244503;6418.0693799397895;6455.419012288917;6457;6464.547481676237;6487.059376390492;6405.103285540122;6421.646809425526;6436.452901503425;6440.6135631862235;6448.484121270193;6188.319284878749;6361.427471527585;6364;6366.745330186741;6385.169927909342;6509.381608747161;6514.348565143448;6529.053287273414;6531.150950376421;6537.70580323877;6205.100260462117;6348.5238607105575;6353.4599559038;6356.046593011085;6360.332165122595 20:00:56 INFO - 2015-11-16 20:00:56,429 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.9085114360705;743.591024936285;745.8060904164917;775.848709501647;829.2743849132007;12763.872361276384;13182.472701091945;13197.076204665676;13241.867581324195;13242.933785331072;13519.12125711828;13796;13927;13927.164370137798;13931.512397066104;681.4616453002122;688;812.4881324765404;826.0582935453588;827.3711978896052;805.3838813307824;810.1291112054536;814.5072231300067;815.5066184958104;815.9836803263961;842.9072801991807;844.0504432513422;844.0757370679097;847.6524624903791;848.6987119572556;711.1466240511381;719.4172720096713;835.778518692547;845.8773477845708;846.5259454705384;604.3714536881638;609.430182779103;610.856448734547;611.9755209791603;613.0865011133424;12821.294828784414;12945.805812912813;12961.546345877849;12966.87033129666;12968.805467917895;9907.207423406111;9975.152112070482;10234.181265498817;10296.639617613348;10986.725331866768;9134.680286190018;9497.5726092326;9514.90485095154;9580.425174489483;10147.847782283197;3012.9397412051853;3062.8162310261455;3079.7844150909445;3091;3109.051739219537;42378.364324535156;42627.786861065804;42747.78626106881;42793.57206427958;43438.565614343766;7121.67952442131;7787.260210280015;7800.375969922393;7819.296263336327;7821;12354.75290494203;12387.07096967713;12398.25610463375;12403.193792403645;12566.874331256753;6528.412442880069;6771.93228067713;6797.082393876863;6853.691583878737;6920.100386949664;3960.8019599019935;4084.101497670508;4261.31818908973;4276.57234276576;4308.74147551148;2694.5688689809535;2736.493748656505;2740.369714965529;2741.150243424545;2742.903998360088;407.43163287214765;422.2231094785609;427.56388483747025;429.0988923261189;431.87043886834454;540.5081375947947;595.6128516464333;614.6926536731634;639.728115550889;640.7084776426808;8197.631106600218;8360.498370097814;8397.70608028716;8459.873101903477;8616.741497755078;489.9167141585939;517.0950836036935;538.3082738680777;627.6202648736496;642.2549842183046;3169.6830316968117;3248.4964830451318;3260.190594220183;3346.314005628889;3390.0168951004425;56883;58427.41572584305;58516.70741646265;58903.41096589065;59031.70484147638;51677;52402;53220.46779532233;53796;54470;47305.58083257508;47424.5257547427;47548.76225618919;47607.28589071236;48279;8470.915290847013;8589.785255368415;8874.64501419936;9177.77055573616;9180.586873590571;32510.349793003534;32780.34439311248;34329;34414;34538;43789.78105109454;45204;45445.09109817851;45633.08733825371;45922.54077459183;8423.789405264672;8659.523726194868;8721.781955451164;8770.517621530877;8830.470171789713;11877.821832672344;12749.362531873183;12802.231866088065;12843.614691559269;13019.609411717664;11322.60370887015;11542.94228528852;12156.088293378209;12545.498180072695;12566.748665026465;11278.09775217997;11533.365664888175;11553.595624153115;11628;11938.58214962472;12108.878911211128;12211.877881221075;12219.877801221874;12239.938800305941;12518.749625007267;10010.699679009642;10012.949935250568;10145.9492702536;10259.281850270409;10793.460326983777;9134.451932884049;9740.220782337254;9976.152027077489;10072.949635251776;10183.032611901857 20:00:56 INFO - 2015-11-16 20:00:56,429 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:00:56 INFO - 2015-11-16 20:00:56,430 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:00:56 INFO - 2015-11-16 20:00:56,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 20:00:56 INFO - 2015-11-16 20:00:56,430 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:00:56 INFO - 2015-11-16 20:00:56,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1447732856419__endTimestamp 20:00:56 INFO - 2015-11-16 20:00:56,431 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,431 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:00:56 INFO - 2015-11-16 20:00:56,431 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:00:56 INFO - 2015-11-16 20:00:56,432 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,432 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5521.92 Median:5735.77 stddev:624.76 (10.9%) stddev-sans-first:599.66 20:00:56 INFO - 2015-11-16 20:00:56,432 DEBUG : BROWSER_OUTPUT: Values: 3204.9 3270.6 3292.3 3303.2 3314.7 5277.6 5342.1 5464.2 5481.1 5502.1 5479.3 5490.0 5563.4 5586.5 5594.9 5033.7 5076.6 5078.1 5139.8 5158.4 5102.4 5181.7 5190.2 5190.4 5209.5 4790.9 4892.9 4914.0 5049.6 5050.6 5027.7 5034.3 5035.2 5050.7 5082.5 5012.6 5019.0 5028.7 5037.2 5061.3 5163.4 5271.1 5313.8 5378.0 5384.0 5872.0 6040.4 6059.8 6064.8 6077.9 6072.7 6088.3 6091.3 6091.4 6094.2 5405.5 5454.5 5493.3 5533.1 5565.7 6065.8 6067.7 6070.8 6095.5 6129.2 5662.3 5884.8 5886.6 5890.9 5893.9 5785.7 5884.4 5908.2 5914.9 5922.9 5936.6 5939.5 5945.9 5967.8 5974.2 5663.3 5931.7 5950.9 5951.7 5961.5 4466.6 4510.5 4520.9 4541.8 4586.8 4080.3 4104.0 4114.1 4145.4 4146.2 5556.8 5669.3 5713.9 5730.3 5735.5 5917.9 5953.9 5973.7 5979.9 6005.6 5625.5 5629.7 5649.9 5700.5 5717.2 5011.9 5154.7 5171.8 5202.8 5272.6 6029.8 6044.5 6047.8 6110.2 6141.3 6013.6 6079.1 6085.9 6087.2 6094.1 5936.9 6258.3 6260.8 6290.0 6294.9 5784.5 5787.2 5815.9 5889.5 5927.3 5910.6 5912.5 5914.3 5919.9 6034.9 5655.2 5764.6 5765.3 5767.6 5770.9 5735.8 5739.9 5761.1 5864.8 5873.8 5717.7 5743.8 5748.5 5749.7 5762.9 5670.1 5858.7 5878.7 5900.4 5913.3 5689.6 5719.9 5771.9 5791.7 5824.1 20:00:56 INFO - 2015-11-16 20:00:56,432 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,433 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47746.73 Median:357890.50 stddev:80570.34 (22.5%) stddev-sans-first:80718.54 20:00:56 INFO - 2015-11-16 20:00:56,433 DEBUG : BROWSER_OUTPUT: Values: 583.1 585.6 587.4 590.3 602.0 30481.4 40166.0 40993.8 40998.4 41066.2 44305.8 44822.3 44854.8 44860.6 44900.8 7660.1 7820.3 8723.2 8899.1 8899.5 10494.8 10721.0 10786.1 10808.2 10827.8 10383.5 10505.5 10508.7 10514.6 10527.4 7737.9 7975.9 7977.6 8013.0 10399.6 10493.9 10793.8 10794.7 10797.5 10799.1 41034.4 41290.0 41374.4 41421.8 41482.8 3207.0 3255.3 3300.3 3423.7 3616.9 30505.7 31064.2 31145.7 31172.2 31522.7 3461.5 3674.1 3709.5 3718.4 3760.4 284652.0 284836.0 285236.0 285964.0 286514.0 57515.0 58842.4 60348.0 60806.4 61207.4 55767.0 55820.9 56067.7 56105.4 56220.4 13473.7 13711.7 13737.5 13786.7 13865.2 10641.1 10692.3 10728.1 10856.3 10914.5 18932.8 19198.2 19620.0 19686.0 19850.0 7543.5 7738.6 7840.0 7852.3 7884.8 875.7 891.7 1124.2 1138.8 1157.1 28641.3 28927.0 29001.4 29327.7 29598.0 989.5 1042.1 1047.1 1102.1 1104.8 15161.2 15216.2 15390.3 15446.7 15713.5 353290.0 357472.0 358309.0 358596.0 360412.0 53770.7 53901.2 54015.5 54019.2 54103.0 1341.9 1352.9 1372.0 1375.4 1377.3 22285.4 28080.6 28649.6 29167.1 29620.6 43703.8 44043.4 44177.6 44179.0 44262.8 233954.0 233986.0 234260.0 235005.0 391682.0 27357.7 31100.2 31278.8 31336.2 31833.4 37822.2 37975.4 38391.4 38973.0 39054.4 34102.5 40256.4 45157.3 45695.5 45859.0 38482.6 39269.2 40871.0 41421.0 42326.2 37476.8 37571.0 37769.6 40638.2 40662.6 38036.0 38530.8 39287.0 39670.8 40285.8 26668.2 27030.2 27191.3 27249.5 27260.0 20:00:56 INFO - 2015-11-16 20:00:56,433 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,433 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23326.26 Median:23465.65 stddev:67733.82 (288.7%) stddev-sans-first:67901.85 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: Values: 348.5 348.7 349.7 350.9 354.3 17257.0 17658.6 17846.2 18309.2 18313.4 16423.8 16536.7 16770.0 17195.1 17199.3 5094.2 5103.3 5202.7 5204.6 5249.8 5233.8 5284.0 5284.7 5288.5 5292.8 3845.6 4122.4 5234.7 5236.2 5236.8 4058.6 5959.3 5959.9 5963.2 5963.3 4206.8 4283.9 5210.3 5211.2 5215.5 12045.8 12503.2 13883.6 14304.5 14529.6 1720.8 1939.7 1959.5 1993.9 2045.9 9692.4 9805.3 9997.6 10154.7 10362.4 1592.1 1594.4 1616.2 1628.9 1662.2 58950.7 59800.1 60787.0 61188.0 61801.7 7054.5 7117.3 7119.0 7138.5 7184.8 8541.8 8544.0 8545.8 8554.6 8555.2 5386.1 5444.3 5444.7 5519.5 5626.3 5412.9 5433.2 5610.7 5636.9 5654.0 3311.1 3334.2 3346.0 3364.1 3369.5 1156.5 1165.2 1165.9 1175.3 1210.6 456.1 471.2 476.8 488.2 496.4 11896.2 12122.9 12402.7 12429.4 12454.2 461.2 471.2 489.1 529.5 530.6 4776.5 6308.0 6620.1 6731.1 6759.3 390711.0 390789.0 392989.0 398166.0 480642.0 60363.7 61290.4 62159.0 80296.2 80497.6 543.6 559.3 561.5 561.9 562.0 10602.5 11152.3 11259.8 11436.3 11547.1 34327.0 34462.7 35265.0 36712.4 37319.8 42647.4 43549.0 43867.0 44239.3 44811.8 6687.6 6867.2 6909.7 6932.7 6949.5 12140.8 12381.1 12460.0 12502.0 12621.5 10761.1 10824.2 10863.5 10994.3 11090.2 10201.8 10504.0 10630.4 10720.8 10793.4 10685.3 11252.7 11379.5 11559.7 11580.4 6659.4 6828.6 6958.8 6963.1 6970.3 11028.9 11076.5 11122.7 11209.3 11463.8 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5355.64 Median:6497.58 stddev:2763.47 (42.5%) stddev-sans-first:2754.50 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: Values: 1311.4 1672.3 1689.3 1709.2 1720.7 6573.2 7525.5 7757.1 7768.5 7768.7 7529.5 7631.3 7665.7 7671.5 7692.7 1993.6 2028.3 2033.6 2212.5 2235.3 2024.0 2228.9 2291.4 2299.2 2300.5 2200.8 2223.4 2231.4 2265.5 2270.5 1981.1 2021.6 2257.1 2269.4 2303.9 2283.9 2290.0 2295.4 2296.9 2297.1 7399.4 7517.1 7523.1 7525.5 7526.2 4512.6 4585.3 4605.1 4621.4 4630.4 2986.9 3060.2 3084.5 3096.0 3104.3 993.8 1006.8 1019.2 1031.1 1054.9 10625.2 10680.7 10690.4 10702.0 10708.8 4265.4 4328.0 4343.5 4385.5 4387.3 8765.1 8853.7 8856.0 8867.6 8870.2 4706.8 4712.8 4735.3 4741.1 4746.3 4252.4 4284.8 4292.3 4303.4 4305.1 3639.9 3665.9 3688.7 3700.0 3700.5 1169.9 1181.9 1192.6 1198.4 1198.6 1308.9 1311.9 1312.4 1328.9 1351.7 7020.4 7107.3 7137.9 7139.0 7139.9 489.0 490.2 491.7 496.6 510.2 5206.8 5296.8 5654.8 5770.7 5936.9 8430.6 8677.3 8804.4 8830.8 8878.6 8733.5 8767.7 8890.1 8901.9 8962.9 6892.9 6904.1 6962.9 6998.4 7001.0 6833.5 7014.8 7016.6 7043.4 7048.1 7910.9 8059.8 8168.3 8365.0 8367.8 8135.8 8355.2 8522.1 8536.3 8543.5 6921.4 6999.6 7069.0 7091.5 7098.0 7252.9 7441.1 7451.3 7451.7 7466.0 6947.0 7071.1 7156.0 7222.5 7264.2 7039.4 7048.8 7053.8 7142.6 7182.3 6740.4 6789.7 6811.8 6821.5 6824.5 6456.0 6495.7 6501.4 6503.6 6509.1 6499.5 6521.6 6533.8 6539.7 6585.7 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,435 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5349.15 Median:6119.72 stddev:1632.30 (26.7%) stddev-sans-first:1592.71 20:00:56 INFO - 2015-11-16 20:00:56,436 DEBUG : BROWSER_OUTPUT: Values: 324.2 328.0 328.3 328.5 334.6 5957.2 6001.2 6010.5 6036.8 6093.8 5721.2 5803.3 5862.5 5959.7 6006.4 4608.5 4637.7 4638.8 4647.1 4648.2 4433.5 4638.0 4645.0 4645.2 4653.9 4431.5 4444.0 4534.0 4550.2 4555.1 4553.7 4557.6 4566.6 4578.3 4583.7 4019.3 4021.4 4027.1 4028.4 4033.4 5533.1 5637.8 5640.5 5644.9 5660.3 5339.9 5349.3 5352.5 5359.2 5363.9 6296.9 6331.0 6335.3 6343.5 6350.1 4455.2 4457.3 4467.1 4469.3 4470.3 6419.1 6583.0 6601.9 6621.3 6629.7 4423.2 4424.7 4431.7 4441.7 4442.6 4486.3 4490.9 4495.1 4500.5 4501.3 5245.5 5248.7 5249.7 5252.3 5260.8 6211.9 6438.6 6452.1 6456.2 6465.2 1575.4 1593.8 1596.1 1597.7 1598.4 1030.8 1035.4 1040.3 1064.0 1078.5 6202.1 6206.7 6213.2 6213.9 6214.1 6601.1 6602.5 6611.2 6618.8 6618.9 6029.2 6145.7 6159.7 6173.1 6181.4 3510.0 3555.2 3569.4 3573.9 3579.0 6814.9 6833.6 6844.7 6888.0 6913.3 6668.4 6789.6 6842.6 6848.0 6851.3 6862.1 6905.3 6910.8 6916.9 6921.4 6487.9 6658.2 6669.3 6671.0 6673.2 6534.8 6584.2 6616.4 6622.9 6627.4 6861.9 6885.6 6901.2 6936.1 6936.4 4512.0 4521.8 4526.0 4526.4 4527.4 6562.3 6639.9 6663.3 6669.7 6677.4 6418.1 6455.4 6457.0 6464.5 6487.1 6405.1 6421.6 6436.5 6440.6 6448.5 6188.3 6361.4 6364.0 6366.7 6385.2 6509.4 6514.3 6529.1 6531.2 6537.7 6205.1 6348.5 6353.5 6356.0 6360.3 20:00:56 INFO - 2015-11-16 20:00:56,436 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-16 20:00:56,436 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13372.25 Median:46614.06 stddev:15965.16 (34.2%) stddev-sans-first:15981.73 20:00:56 INFO - 2015-11-16 20:00:56,437 DEBUG : BROWSER_OUTPUT: Values: 731.9 743.6 745.8 775.8 829.3 12763.9 13182.5 13197.1 13241.9 13242.9 13519.1 13796.0 13927.0 13927.2 13931.5 681.5 688.0 812.5 826.1 827.4 805.4 810.1 814.5 815.5 816.0 842.9 844.1 844.1 847.7 848.7 711.1 719.4 835.8 845.9 846.5 604.4 609.4 610.9 612.0 613.1 12821.3 12945.8 12961.5 12966.9 12968.8 9907.2 9975.2 10234.2 10296.6 10986.7 9134.7 9497.6 9514.9 9580.4 10147.8 3012.9 3062.8 3079.8 3091.0 3109.1 42378.4 42627.8 42747.8 42793.6 43438.6 7121.7 7787.3 7800.4 7819.3 7821.0 12354.8 12387.1 12398.3 12403.2 12566.9 6528.4 6771.9 6797.1 6853.7 6920.1 3960.8 4084.1 4261.3 4276.6 4308.7 2694.6 2736.5 2740.4 2741.2 2742.9 407.4 422.2 427.6 429.1 431.9 540.5 595.6 614.7 639.7 640.7 8197.6 8360.5 8397.7 8459.9 8616.7 489.9 517.1 538.3 627.6 642.3 3169.7 3248.5 3260.2 3346.3 3390.0 56883.0 58427.4 58516.7 58903.4 59031.7 51677.0 52402.0 53220.5 53796.0 54470.0 47305.6 47424.5 47548.8 47607.3 48279.0 8470.9 8589.8 8874.6 9177.8 9180.6 32510.3 32780.3 34329.0 34414.0 34538.0 43789.8 45204.0 45445.1 45633.1 45922.5 8423.8 8659.5 8721.8 8770.5 8830.5 11877.8 12749.4 12802.2 12843.6 13019.6 11322.6 11542.9 12156.1 12545.5 12566.7 11278.1 11533.4 11553.6 11628.0 11938.6 12108.9 12211.9 12219.9 12239.9 12518.7 10010.7 10012.9 10145.9 10259.3 10793.5 9134.5 9740.2 9976.2 10072.9 10183.0 20:00:56 INFO - 2015-11-16 20:00:56,437 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:00:56 INFO - 2015-11-16 20:00:56,437 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-16 20:00:57,054 INFO : Browser exited with error code: 0 20:00:57 INFO - 2015-11-16 20:00:57,077 INFO : Completed test dromaeo_css (00:18:32) 20:00:57 INFO - 2015-11-16 20:00:57,077 INFO : Starting test kraken 20:00:57 INFO - 2015-11-16 20:00:57,077 DEBUG : operating with platform_type : linux_ 20:00:57 INFO - 2015-11-16 20:00:57,077 INFO : Initialising browser for kraken test... 20:00:57 INFO - 2015-11-16 20:00:57,083 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5zOt75/profile http://localhost:48995/getInfo.html 20:01:00 INFO - 2015-11-16 20:01:00,779 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:00 INFO - 2015-11-16 20:01:00,779 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:00 INFO - 2015-11-16 20:01:00,779 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:00 INFO - 2015-11-16 20:01:00,779 DEBUG : BROWSER_OUTPUT: __metrics 20:01:00 INFO - 2015-11-16 20:01:00,847 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:02 INFO - 2015-11-16 20:01:02,088 INFO : Browser initialized. 20:01:02 INFO - 2015-11-16 20:01:02,089 INFO : Running cycle 1/1 for kraken test... 20:01:02 INFO - 2015-11-16 20:01:02,089 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5zOt75/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:01:13 INFO - 2015-11-16 20:01:13,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 142024704 20:01:13 INFO - 2015-11-16 20:01:13,942 DEBUG : BROWSER_OUTPUT: 20:01:16 INFO - 2015-11-16 20:01:16,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-beat-detection) 20:01:17 INFO - 2015-11-16 20:01:17,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 181198848 20:01:17 INFO - 2015-11-16 20:01:17,011 DEBUG : BROWSER_OUTPUT: 20:01:19 INFO - 2015-11-16 20:01:19,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-dft) 20:01:20 INFO - 2015-11-16 20:01:20,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 168845312 20:01:20 INFO - 2015-11-16 20:01:20,179 DEBUG : BROWSER_OUTPUT: 20:01:23 INFO - 2015-11-16 20:01:23,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-fft) 20:01:23 INFO - 2015-11-16 20:01:23,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 151736320 20:01:23 INFO - 2015-11-16 20:01:23,673 DEBUG : BROWSER_OUTPUT: 20:01:25 INFO - 2015-11-16 20:01:25,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48995/tests/kraken/driver.html?testName=audio-oscillator) 20:01:26 INFO - 2015-11-16 20:01:26,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 155340800 20:01:26 INFO - 2015-11-16 20:01:26,239 DEBUG : BROWSER_OUTPUT: 20:01:28 INFO - 2015-11-16 20:01:28,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:01:28 INFO - 2015-11-16 20:01:28,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 154804224 20:01:28 INFO - 2015-11-16 20:01:28,959 DEBUG : BROWSER_OUTPUT: 20:01:31 INFO - 2015-11-16 20:01:31,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-darkroom) 20:01:32 INFO - 2015-11-16 20:01:32,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 156651520 20:01:32 INFO - 2015-11-16 20:01:32,432 DEBUG : BROWSER_OUTPUT: 20:01:35 INFO - 2015-11-16 20:01:35,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48995/tests/kraken/driver.html?testName=imaging-desaturate) 20:01:36 INFO - 2015-11-16 20:01:36,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 20:01:36 INFO - 2015-11-16 20:01:36,402 DEBUG : BROWSER_OUTPUT: 20:01:39 INFO - 2015-11-16 20:01:39,161 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48995/tests/kraken/driver.html?testName=json-parse-financial) 20:01:39 INFO - 2015-11-16 20:01:39,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 156340224 20:01:39 INFO - 2015-11-16 20:01:39,728 DEBUG : BROWSER_OUTPUT: 20:01:41 INFO - 2015-11-16 20:01:41,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:01:41 INFO - 2015-11-16 20:01:41,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 167137280 20:01:41 INFO - 2015-11-16 20:01:41,843 DEBUG : BROWSER_OUTPUT: 20:01:43 INFO - 2015-11-16 20:01:43,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:01:44 INFO - 2015-11-16 20:01:44,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 166543360 20:01:44 INFO - 2015-11-16 20:01:44,230 DEBUG : BROWSER_OUTPUT: 20:01:46 INFO - 2015-11-16 20:01:46,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:01:46 INFO - 2015-11-16 20:01:46,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 171307008 20:01:46 INFO - 2015-11-16 20:01:46,865 DEBUG : BROWSER_OUTPUT: 20:01:49 INFO - 2015-11-16 20:01:49,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:01:49 INFO - 2015-11-16 20:01:49,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 180551680 20:01:49 INFO - 2015-11-16 20:01:49,865 DEBUG : BROWSER_OUTPUT: 20:01:52 INFO - 2015-11-16 20:01:52,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:01:52 INFO - 2015-11-16 20:01:52,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 179642368 20:01:52 INFO - 2015-11-16 20:01:52,988 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48995/tests/kraken/driver.html?testName=ai-astar) 20:01:54 INFO - 2015-11-16 20:01:54,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 239190016 20:01:54 INFO - 2015-11-16 20:01:54,875 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;106;109;114;113;102;110;111;108 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;127;148;162;127;170;148;126;159;129 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;161;160;161;162;163;162;161 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;84;90;72;71;73;113;89;71 20:01:54 INFO - 2015-11-16 20:01:54,876 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;132;89;90;90;132;90;90;141 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;110;109;110;110 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;146;147;147;149;146;145 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;96;95;96;95 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;58;57;58;57;58;66;56;55 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;70;70;69;69;70;70 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;85;88;83;85;89;85;88;87 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;115;122;122;117;120;118;123;127;115 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;150;153;149;140;151;149;148;143 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;65;65;65;66;65;66;66 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:54 INFO - 2015-11-16 20:01:54,877 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:01:54 INFO - 2015-11-16 20:01:54,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 20:01:54 INFO - 2015-11-16 20:01:54,878 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:01:54 INFO - 2015-11-16 20:01:54,878 DEBUG : BROWSER_OUTPUT: __startTimestamp1447732914875__endTimestamp 20:01:54 INFO - 2015-11-16 20:01:54,878 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.50 (3.2%) stddev-sans-first:3.67 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 106.0 109.0 114.0 113.0 102.0 110.0 111.0 108.0 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,880 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.80 Median:150.00 stddev:16.47 (11.0%) stddev-sans-first:17.26 20:01:54 INFO - 2015-11-16 20:01:54,881 DEBUG : BROWSER_OUTPUT: Values: 152.0 127.0 148.0 162.0 127.0 170.0 148.0 126.0 159.0 129.0 20:01:54 INFO - 2015-11-16 20:01:54,881 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,881 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 20:01:54 INFO - 2015-11-16 20:01:54,882 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 161.0 160.0 161.0 162.0 163.0 162.0 161.0 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:13.48 (18.3%) stddev-sans-first:13.99 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 84.0 90.0 72.0 71.0 73.0 113.0 89.0 71.0 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:90.00 stddev:21.81 (24.2%) stddev-sans-first:22.66 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 132.0 89.0 90.0 90.0 132.0 90.0 90.0 141.0 20:01:54 INFO - 2015-11-16 20:01:54,883 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 149.0 146.0 145.0 20:01:54 INFO - 2015-11-16 20:01:54,884 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:3.00 (5.2%) stddev-sans-first:3.16 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 58.0 57.0 58.0 57.0 58.0 66.0 56.0 55.0 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 70.0 70.0 20:01:54 INFO - 2015-11-16 20:01:54,885 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.50 stddev:1.81 (2.1%) stddev-sans-first:1.92 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 85.0 88.0 83.0 85.0 89.0 85.0 88.0 87.0 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.00 stddev:3.78 (3.1%) stddev-sans-first:4.01 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 122.0 122.0 117.0 120.0 118.0 123.0 127.0 115.0 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:149.00 stddev:4.71 (3.2%) stddev-sans-first:4.01 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 150.0 153.0 149.0 140.0 151.0 149.0 148.0 143.0 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:54 INFO - 2015-11-16 20:01:54,886 DEBUG : BROWSER_OUTPUT: 20:01:55 INFO - 2015-11-16 20:01:55,705 INFO : Browser exited with error code: 0 20:01:55 INFO - 2015-11-16 20:01:55,761 INFO : Completed test kraken (00:00:58) 20:01:55 INFO - 2015-11-16 20:01:55,761 INFO : Starting test v8_7 20:01:55 INFO - 2015-11-16 20:01:55,761 DEBUG : operating with platform_type : linux_ 20:01:55 INFO - 2015-11-16 20:01:55,762 INFO : Initialising browser for v8_7 test... 20:01:55 INFO - 2015-11-16 20:01:55,768 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFgwY2H/profile http://localhost:48995/getInfo.html 20:01:59 INFO - 2015-11-16 20:01:59,424 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:59 INFO - 2015-11-16 20:01:59,424 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:59 INFO - 2015-11-16 20:01:59,424 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:59 INFO - 2015-11-16 20:01:59,424 DEBUG : BROWSER_OUTPUT: __metrics 20:01:59 INFO - 2015-11-16 20:01:59,585 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:02:00 INFO - 2015-11-16 20:02:00,772 INFO : Browser initialized. 20:02:00 INFO - 2015-11-16 20:02:00,773 INFO : Running cycle 1/1 for v8_7 test... 20:02:00 INFO - 2015-11-16 20:02:00,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFgwY2H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:02:12 INFO - 2015-11-16 20:02:12,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 141058048 20:02:12 INFO - 2015-11-16 20:02:12,550 DEBUG : BROWSER_OUTPUT: 20:02:33 INFO - 2015-11-16 20:02:33,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48995/tests/v8_7/run.html (next: http://localhost:48995/tests/v8_7/run.html) 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 608694272 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5322976287817 20:02:34 INFO - 2015-11-16 20:02:34,227 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.4012441679627 20:02:34 INFO - 2015-11-16 20:02:34,228 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.45229383619477 20:02:34 INFO - 2015-11-16 20:02:34,228 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 20:02:34 INFO - 2015-11-16 20:02:34,228 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 20:02:34 INFO - 2015-11-16 20:02:34,228 DEBUG : BROWSER_OUTPUT: |5;Earley;801.2820512820513 20:02:34 INFO - 2015-11-16 20:02:34,228 DEBUG : BROWSER_OUTPUT: |6;Boyer;11929.411764705883 20:02:34 INFO - 2015-11-16 20:02:34,229 DEBUG : BROWSER_OUTPUT: |7;RegExp;26051.28205128205 20:02:34 INFO - 2015-11-16 20:02:34,229 DEBUG : BROWSER_OUTPUT: |8;Splay;640.5353728489483 20:02:34 INFO - 2015-11-16 20:02:34,229 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 20:02:34 INFO - 2015-11-16 20:02:34,229 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: __startTimestamp1447732954227__endTimestamp 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.53 Median:163.53 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,230 DEBUG : BROWSER_OUTPUT: Values: 163.5 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.40 Median:194.40 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: Values: 194.4 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: Values: 281.5 20:02:34 INFO - 2015-11-16 20:02:34,231 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: Values: 5050.5 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: Values: 1964.6 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.28 Median:801.28 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,232 DEBUG : BROWSER_OUTPUT: Values: 801.3 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11929.41 Median:11929.41 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: Values: 11929.4 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: Values: 26051.3 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:640.54 Median:640.54 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: Values: 640.5 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: Values: 4830.9 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:02:34 INFO - 2015-11-16 20:02:34,233 DEBUG : BROWSER_OUTPUT: 20:02:35 INFO - 2015-11-16 20:02:35,102 INFO : Browser exited with error code: 0 20:02:35 INFO - 2015-11-16 20:02:35,116 INFO : Completed test v8_7 (00:00:39) 20:02:35 INFO - 2015-11-16 20:02:35,201 INFO : Completed test suite (00:20:11) 20:02:35 INFO - 2015-11-16 20:02:35,202 DEBUG : Working with test: dromaeo_css 20:02:35 INFO - 2015-11-16 20:02:35,202 DEBUG : Generating results file: dromaeo_css 20:02:35 INFO - 2015-11-16 20:02:35,203 DEBUG : Working with test: kraken 20:02:35 INFO - 2015-11-16 20:02:35,203 DEBUG : Generating results file: kraken 20:02:35 INFO - 2015-11-16 20:02:35,203 INFO : javascript benchmark 20:02:35 INFO - 2015-11-16 20:02:35,203 DEBUG : Working with test: v8_7 20:02:35 INFO - 2015-11-16 20:02:35,203 DEBUG : Generating results file: v8_7 20:02:35 INFO - 2015-11-16 20:02:35,204 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:35 INFO - 2015-11-16 20:02:35,264 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 20:02:35 INFO - 2015-11-16 20:02:35,264 DEBUG : process_Request line: dromaeo_css 6700.93 graph.html#tests=[[72,201,35]] 20:02:35 INFO - 2015-11-16 20:02:35,264 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:35 INFO - 2015-11-16 20:02:35,296 DEBUG : process_Request line: kraken 1498.30 graph.html#tests=[[232,201,35]] 20:02:35 INFO - 2015-11-16 20:02:35,296 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:02:35 INFO - 2015-11-16 20:02:35,328 DEBUG : process_Request line: v8_7 19763.30 graph.html#tests=[[230,201,35]] 20:02:35 INFO - 2015-11-16 20:02:35,330 INFO : javascript benchmark 20:02:35 INFO - 2015-11-16 20:02:35,334 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [348.5364465261202, 348.7157966257498, 349.67480243373655, 350.9491123787051, 354.2878813584696, 17256.98002849501, 17658.64682706347, 17846.196921138548, 18309.169083091685, 18313.35903243387, 16423.83576164241, 16536.66926661466, 16770.0, 17195.140242987833, 17199.312027518885, 5094.210397388401, 5103.2855400244, 5202.713850738208, 5204.557612602934, 5249.842504724865, 5233.842984710445, 5284.0, 5284.709340986245, 5288.524032837044, 5292.788288468457, 3845.576986531479, 4122.4228607994755, 5234.7120908350025, 5236.162214045753, 5236.764345604438, 4058.5738497457783, 5959.255093113361, 5959.880802383971, 5963.19496867926, 5963.28440587128, 4206.789660516962, 4283.935740963888, 5210.270562121268, 5211.166213405837, 5215.478452154792, 12045.759084818343, 12503.249805011728, 13883.583492495241, 14304.499342522962, 14529.636759081002, 1720.81931397204, 1939.7187407825927, 1959.4905324615702, 1993.8604297699167, 2045.8977051147533, 9692.41845489273, 9805.31362804604, 9997.550110244983, 10154.695359139238, 10362.430066346347, 1592.1243316176058, 1594.4100682747342, 1616.2161351744394, 1628.8696904247631, 1662.1772222749696, 58950.705246473495, 59800.102998455055, 60787.0, 61188.0, 61801.690991545205, 7054.506184567031, 7117.3238542338395, 7118.967749676372, 7138.535995160298, 7184.82037949045, 8541.786455338666, 8544.0, 8545.786355341043, 8554.572271386405, 8555.230029297392, 5386.084365657847, 5444.265024221759, 5444.673319600757, 5519.530839878656, 5626.2967129108865, 5412.891742165213, 5433.157860531624, 5610.663360198401, 5636.859078522988, 5654.038813401731, 3311.089450401159, 3334.1997920498907, 3345.983270083634, 3364.1253274148407, 3369.5451114099774, 1156.4969238381163, 1165.2172176569861, 1165.9008984236266, 1175.26545908807, 1210.6005018344101, 456.121965216956, 471.2248351461826, 476.8032239079934, 488.2042271098158, 496.36465324384847, 11896.16726829131, 12122.939385303018, 12402.689932751753, 12429.37853107341, 12454.190477618926, 461.2366533387249, 471.1613328275675, 489.09517392822994, 529.4811085136588, 530.5755395683437, 4776.498467660846, 6308.0, 6620.139381880421, 6731.057651928734, 6759.324067593201, 390711.0, 390789.0, 392989.0, 398166.0, 480642.0, 60363.69818150969, 61290.38709612847, 62159.0, 80296.19703803003, 80497.59751201324, 543.5542854858978, 559.3036669346608, 561.5199004850875, 561.901667208237, 561.9859503512445, 10602.469876506299, 11152.275102118336, 11259.774804504028, 11436.313821170756, 11547.13396495283, 34327.0, 34462.655373445945, 35265.0, 36712.449313260855, 37319.813400933905, 42647.360289596305, 43549.0, 43867.0, 44239.336409953234, 44811.77594112139, 6687.6321802301345, 6867.21027081872, 6909.654517274015, 6932.653367331714, 6949.478789090737, 12140.75718485643, 12381.133320667466, 12460.0, 12502.0, 12621.495140194656, 10761.139108871428, 10824.188185885932, 10863.456827158769, 10994.34033957965, 11090.168237382068, 10201.846972295272, 10504.0, 10630.415327156772, 10720.780129088822, 10793.40636265013, 10685.305455145392, 11252.66242012741, 11379.487923043318, 11559.711007224887, 11580.36308003068, 6659.433948114271, 6828.624425656637, 6958.79123626292, 6963.059986901703, 6970.302969702989, 11028.944855275673, 11076.501557429774, 11122.721931951766, 11209.327440353605, 11463.770724585294], "dojo.html": [3204.919877003075, 3270.5748252727144, 3292.275699346143, 3303.2237424205323, 3314.685104915033, 5277.551408130314, 5342.118550439182, 5464.23500709901, 5481.12302031675, 5502.119660854264, 5479.2602998595175, 5490.039243132456, 5563.388027316992, 5586.497215250627, 5594.888102237953, 5033.6728112672745, 5076.593872490211, 5078.148155466418, 5139.768710408022, 5158.3552055993005, 5102.438731739506, 5181.715005674687, 5190.195519694435, 5190.429052804188, 5209.505097015777, 4790.856274311776, 4892.902141957141, 4913.950860491421, 5049.570786483153, 5050.646454748169, 5027.673201241944, 5034.3455350804525, 5035.219540971156, 5050.7222102784335, 5082.542571168613, 5012.624053195988, 5019.046381187599, 5028.748562571856, 5037.219231019198, 5061.316722242487, 5163.40620828602, 5271.051210782058, 5313.814016509404, 5378.0, 5384.0, 5872.0, 6040.426159514839, 6059.757609695607, 6064.787732429388, 6077.878442431171, 6072.696365181768, 6088.269407671063, 6091.325109430976, 6091.390860913917, 6094.238220222473, 5405.540529055035, 5454.53636440903, 5493.313335833021, 5533.142362933751, 5565.666060036411, 6065.848353791102, 6067.696615169224, 6070.848228794227, 6095.4818840398175, 6129.172561704202, 5662.292213473316, 5884.7940322088525, 5886.646801191942, 5890.911636325459, 5893.882122357529, 5785.71071446426, 5884.382139875337, 5908.20239267702, 5914.881702366015, 5922.8815423691285, 5936.614120082181, 5939.495142912814, 5945.940540594539, 5967.79112731061, 5974.2233509643465, 5663.320401551758, 5931.703414829241, 5950.940490595039, 5951.702414879239, 5961.463468287789, 4466.64266858657, 4510.458744950627, 4520.909581808345, 4541.795619197144, 4586.816527338936, 4080.3063479208604, 4104.0, 4114.115465174942, 4145.357469592218, 4146.212219678251, 5556.777728890799, 5669.262995810601, 5713.857153571194, 5730.34101078373, 5735.541156707537, 5917.881642367129, 5953.910691339634, 5973.731182096816, 5979.850503737354, 6005.609635373687, 5625.493705566437, 5629.662220266715, 5649.858753531113, 5700.515456186187, 5717.171010203498, 5011.874703132451, 5154.742262886841, 5171.844844654666, 5202.765875535534, 5272.604554658416, 6029.758809647565, 6044.486218671374, 6047.78832740852, 6110.170335690841, 6141.324454310112, 6013.609115407485, 6079.05774604937, 6085.939140608537, 6087.178230938944, 6094.085887116968, 5936.851578710567, 6258.311585725658, 6260.812175634738, 6289.96855015722, 6294.905576416266, 5784.4504772046585, 5787.160861675117, 5815.912761308668, 5889.469947704727, 5927.2590926134235, 5910.586258961831, 5912.497437717842, 5914.260717410324, 5919.881602368015, 6034.909476357946, 5655.179998900054, 5764.596478246483, 5765.308163020464, 5767.596268261182, 5770.884582308414, 5735.770569177186, 5739.8565035874435, 5761.07822748375, 5864.794732184524, 5873.765049397976, 5717.7141142941855, 5743.7989670363, 5748.540116790563, 5749.683767392834, 5762.8847423050465, 5670.092785154356, 5858.677772722541, 5878.706064696663, 5900.380460051632, 5913.29040515141, 5689.601727879174, 5719.942800572107, 5771.855703607275, 5791.739371728198, 5824.126381042877], "mootools.html": [1311.377095879458, 1672.3059930128995, 1689.2736123466912, 1709.1795937949792, 1720.6750801882547, 6573.244076931154, 7525.51084179528, 7757.10793258774, 7768.4562080654305, 7768.650410731517, 7529.510581812192, 7631.275028872262, 7665.731699390522, 7671.50135241209, 7692.692292308301, 1993.5913137806788, 2028.310374472679, 2033.593281343737, 2212.5132470856424, 2235.2958817972367, 2023.989880050605, 2228.8632797273426, 2291.4271432141963, 2299.1608063056947, 2300.539892021594, 2200.8129309008673, 2223.399682085836, 2231.364061242546, 2265.535565209128, 2270.545890821834, 1981.0688976181243, 2021.6259991901545, 2257.074599414232, 2269.4439862233694, 2303.8963246653857, 2283.931482055541, 2290.03818396274, 2295.3802473332275, 2296.9310920672406, 2297.1156104899733, 7399.4450416219, 7517.097948246191, 7523.059617547807, 7525.548467091992, 7526.24737526243, 4512.638988880882, 4585.266357382803, 4605.102005109005, 4621.37611422457, 4630.374899388573, 2986.910392688223, 3060.1890499017777, 3084.5064789633775, 3095.9845200773852, 3104.3170502489415, 993.7813680990171, 1006.8489726541004, 1019.2253887045824, 1031.102940441813, 1054.8997845204694, 10625.203109766799, 10680.732981675521, 10690.358578485315, 10701.999999999922, 10708.78582428347, 4265.3601959705675, 4328.04782947751, 4343.500497442835, 4385.51759306476, 4387.341898715218, 8765.07966663491, 8853.73438796837, 8855.955720221358, 8867.645294188289, 8870.246029087471, 4706.788194531255, 4712.835050773207, 4735.337052812609, 4741.051789642085, 4746.288056791509, 4252.447181866338, 4284.807183676679, 4292.334688123346, 4303.397524346594, 4305.052888364555, 3639.94540081899, 3665.9450108248398, 3688.686461650736, 3699.963000370016, 3700.481932529448, 1169.8888605582626, 1181.8640856301636, 1192.5647138794277, 1198.4307453959475, 1198.6463993121877, 1308.8952883769275, 1311.895048396126, 1312.4312814364048, 1328.880400763936, 1351.716139610673, 7020.438364930793, 7107.324804143598, 7137.89293160603, 7139.036230108973, 7139.928600713926, 488.95599396053814, 490.19363147622676, 491.6632107006712, 496.58783209935666, 510.16842546648724, 5206.843794686166, 5296.814611488579, 5654.773809047674, 5770.682612456355, 5936.910946335808, 8430.578471076422, 8677.262432693291, 8804.383693141419, 8830.823383532294, 8878.600462979182, 8733.519656418957, 8767.676565710091, 8890.06654301289, 8901.866472002925, 8962.910370896208, 6892.862142757217, 6904.13698287714, 6962.930370696329, 6998.440124790106, 7000.9649951750935, 6833.453323734188, 7014.824629384306, 7016.5790052597, 7043.436525078084, 7048.083749112582, 7910.8813367798375, 8059.798505037421, 8168.3465322772845, 8364.958175209085, 8367.790805229917, 8135.75592732219, 8355.248027677539, 8522.062573116827, 8536.274416674652, 8543.530105843989, 6921.446284297345, 6999.615021173884, 7068.974998625068, 7091.503594748318, 7097.964510177416, 7252.87580425035, 7441.1070671519765, 7451.254874512505, 7451.701931922662, 7466.0, 6947.0, 7071.116110486189, 7155.998160257464, 7222.458315626244, 7264.164621068433, 7039.395423693266, 7048.823779405556, 7053.753118640823, 7142.5714457132735, 7182.281771822776, 6740.359665831738, 6789.660516974231, 6811.761588344384, 6821.488388370793, 6824.454043676593, 6456.031595260749, 6495.675216239264, 6501.44737697301, 6503.577267477599, 6509.088727578048, 6499.480041596756, 6521.608703477807, 6533.836654083496, 6539.738410463528, 6585.670716464253], "ext.html": [583.1107560969521, 585.5871610514588, 587.4125874125874, 590.2503820148413, 602.0337358539547, 30481.39037219254, 40166.0, 40993.795031024805, 40998.38502422466, 41066.178676426454, 44305.77847110768, 44822.32766508505, 44854.77572612133, 44860.55139448604, 44900.77549612247, 7660.080790305144, 7820.296173344398, 8723.214910658055, 8899.065598112202, 8899.466032038066, 10494.790104197911, 10721.0, 10786.137109031299, 10808.243422960357, 10827.78344433111, 10383.532741026635, 10505.474726263694, 10508.684739457829, 10514.579416823319, 10527.368357898513, 7737.9226207737765, 7975.920240797575, 7977.641006154737, 8012.959935200345, 10399.636012739556, 10493.895061049368, 10793.83809242862, 10794.73013174669, 10797.46012699362, 10799.136069114453, 41034.38448423276, 41290.0, 41374.37938430926, 41421.79289103566, 41482.792586037176, 3206.9679303206904, 3255.2675647979254, 3300.3399320135827, 3423.726101911841, 3616.914925522333, 30505.69494305051, 31064.22339441532, 31145.688543114506, 31172.220694482592, 31522.684773152432, 3461.5326930864517, 3674.0998455378603, 3709.462127991453, 3718.4236443351324, 3760.417135344026, 284652.0, 284836.0, 285236.0, 285964.0, 286513.9999999979, 57515.0, 58842.41157588369, 60348.0, 60806.39193608096, 61207.387926120166, 55767.0, 55820.85970543237, 56067.71966140143, 56105.43894561084, 56220.43779562234, 13473.663158421117, 13711.725765484634, 13737.450501979809, 13786.724265514633, 13865.23741194244, 10641.148708103334, 10692.251542391958, 10728.088112510368, 10856.294340867818, 10914.508847101899, 18932.81067189338, 19198.232070717015, 19620.0, 19686.0, 19850.0, 7543.547387156788, 7738.574378409129, 7840.0, 7852.293293603603, 7884.84230315402, 875.6891303587262, 891.7057371067532, 1124.2242852431796, 1138.8177891537314, 1157.1032449851432, 28641.28396790097, 28927.0, 29001.419971600873, 29327.706722932926, 29598.0, 989.5349185882624, 1042.1454407386022, 1047.1361127070197, 1102.079763397556, 1104.7900898829196, 15161.166135862633, 15216.239188040554, 15390.3074361654, 15446.691066178613, 15713.528594142193, 353290.0, 357472.0, 358309.0, 358596.0, 360412.0, 53770.7311463448, 53901.1914821278, 54015.45984540183, 54019.18971215435, 54102.966614339886, 1341.8658134186503, 1352.9052966292265, 1371.9725605487833, 1375.3742047368623, 1377.2975782351073, 22285.428904373344, 28080.578791318556, 28649.570256445753, 29167.124986250445, 29620.555691665075, 43703.78148109239, 44043.35739855619, 44177.55822441863, 44179.0, 44262.778686106365, 233954.0, 233986.0, 234260.0, 235005.0, 391682.0, 27357.72642273552, 31100.222494436915, 31278.843605781825, 31336.21659458532, 31833.36333273368, 37822.243555128196, 37975.430368543944, 38391.42412863753, 38973.0, 39054.4141837867, 34102.48846267258, 40256.3961540583, 45157.32264016108, 45695.54304456913, 45859.0, 38482.61517384902, 39269.2146157081, 40871.0, 41421.0, 42326.15347693091, 37476.812615936746, 37571.0, 37769.62230377771, 40638.187236255704, 40662.59337406588, 38036.0, 38530.80734596309, 39287.01782455347, 39670.80164599159, 40285.79857100813, 26668.19995400141, 27030.1890943272, 27191.320216994733, 27249.455010900067, 27260.0], "prototype.html": [324.20731311942296, 328.01922252465107, 328.34495182111687, 328.4793602140607, 334.59179800643216, 5957.225560677111, 6001.189839371678, 6010.549208809341, 6036.788712395067, 6093.78671746489, 5721.199032135494, 5803.303603567567, 5862.472377486026, 5959.672218028007, 6006.4293892080295, 4608.5161058088925, 4637.675362724611, 4638.814447422107, 4647.14027904837, 4648.1865673507, 4433.4901486329, 4638.0, 4645.047765208141, 4645.210314246569, 4653.86038418848, 4431.534688857671, 4443.977885086432, 4533.977330113345, 4550.226461501553, 4555.088982203556, 4553.726776393411, 4557.609928971662, 4566.589006989387, 4578.313253012058, 4583.72497650142, 4019.2966230909765, 4021.3565829467143, 4027.134166154291, 4028.395740638898, 4033.3748269018347, 5533.114701647757, 5637.80267690633, 5640.492355687967, 5644.887102257973, 5660.3490598581275, 5339.893202135974, 5349.277847490578, 5352.464753524617, 5359.249705041298, 5363.9463605363835, 6296.937030629727, 6330.9683451582905, 6335.334789847046, 6343.46080583151, 6350.079238510436, 4455.240180128863, 4457.309117086825, 4467.084247729208, 4469.262571675669, 4470.329450582439, 6419.069234960904, 6583.0, 6601.900971485384, 6621.33786621334, 6629.7348106075215, 4423.159599676052, 4424.668149888771, 4431.711938723973, 4441.733495990251, 4442.622377097919, 4486.304622783474, 4490.887727806831, 4495.056038232008, 4500.504944456107, 4501.324801279834, 5245.501677340647, 5248.685078895279, 5249.658772179872, 5252.264682944391, 5260.842174734764, 6211.875762484725, 6438.645874476855, 6452.064450654629, 6456.225252969673, 6465.224173099165, 1575.4170956745847, 1593.80874295083, 1596.0822527046994, 1597.6884507521154, 1598.3846219205457, 1030.835066389374, 1035.425338936882, 1040.2977989856815, 1064.0, 1078.5146683992234, 6202.100695399142, 6206.689665516707, 6213.1922850029205, 6213.937860621426, 6214.098955651405, 6601.108850305243, 6602.471802255808, 6611.173603299588, 6618.768343107968, 6618.933810661928, 6029.186059881948, 6145.661988590581, 6159.722812473449, 6173.135760993465, 6181.412765787243, 3509.964560454672, 3555.2356243407276, 3569.37535931211, 3573.874914377984, 3578.9642103579154, 6814.931850681529, 6833.555818871758, 6844.726210951506, 6887.965560172167, 6913.343232392915, 6668.366505182, 6789.626570538569, 6842.589444633338, 6847.965760171267, 6851.2806155353965, 6862.142232221072, 6905.343992320722, 6910.827229319308, 6916.861662766817, 6921.377076063179, 6487.870242595216, 6658.234303055017, 6669.333066693292, 6670.966645166744, 6673.199216093905, 6534.803955881332, 6584.209894812653, 6616.437602803623, 6622.933770662232, 6627.37039981201, 6861.862762744817, 6885.554033652989, 6901.206361268519, 6936.098307220029, 6936.375726184668, 4512.0, 4521.79651915658, 4525.954740452553, 4526.411566496467, 4527.366168736446, 6562.310957349409, 6639.867202655823, 6663.333666633298, 6669.699863506251, 6677.432418244503, 6418.0693799397895, 6455.419012288917, 6457.0, 6464.547481676237, 6487.059376390492, 6405.103285540122, 6421.646809425526, 6436.452901503425, 6440.6135631862235, 6448.484121270193, 6188.319284878749, 6361.427471527585, 6364.0, 6366.745330186741, 6385.169927909342, 6509.381608747161, 6514.348565143448, 6529.053287273414, 6531.150950376421, 6537.70580323877, 6205.100260462117, 6348.5238607105575, 6353.4599559038, 6356.046593011085, 6360.332165122595], "yui.html": [731.9085114360705, 743.591024936285, 745.8060904164917, 775.848709501647, 829.2743849132007, 12763.872361276384, 13182.472701091945, 13197.076204665676, 13241.867581324195, 13242.933785331072, 13519.12125711828, 13796.0, 13927.0, 13927.164370137798, 13931.512397066104, 681.4616453002122, 688.0, 812.4881324765404, 826.0582935453588, 827.3711978896052, 805.3838813307824, 810.1291112054536, 814.5072231300067, 815.5066184958104, 815.9836803263961, 842.9072801991807, 844.0504432513422, 844.0757370679097, 847.6524624903791, 848.6987119572556, 711.1466240511381, 719.4172720096713, 835.778518692547, 845.8773477845708, 846.5259454705384, 604.3714536881638, 609.430182779103, 610.856448734547, 611.9755209791603, 613.0865011133424, 12821.294828784414, 12945.805812912813, 12961.546345877849, 12966.87033129666, 12968.805467917895, 9907.207423406111, 9975.152112070482, 10234.181265498817, 10296.639617613348, 10986.725331866768, 9134.680286190018, 9497.5726092326, 9514.90485095154, 9580.425174489483, 10147.847782283197, 3012.9397412051853, 3062.8162310261455, 3079.7844150909445, 3091.0, 3109.051739219537, 42378.364324535156, 42627.786861065804, 42747.78626106881, 42793.57206427958, 43438.565614343766, 7121.67952442131, 7787.260210280015, 7800.375969922393, 7819.296263336327, 7821.0, 12354.75290494203, 12387.07096967713, 12398.25610463375, 12403.193792403645, 12566.874331256753, 6528.412442880069, 6771.93228067713, 6797.082393876863, 6853.691583878737, 6920.100386949664, 3960.8019599019935, 4084.101497670508, 4261.31818908973, 4276.57234276576, 4308.74147551148, 2694.5688689809535, 2736.493748656505, 2740.369714965529, 2741.150243424545, 2742.903998360088, 407.43163287214765, 422.2231094785609, 427.56388483747025, 429.0988923261189, 431.87043886834454, 540.5081375947947, 595.6128516464333, 614.6926536731634, 639.728115550889, 640.7084776426808, 8197.631106600218, 8360.498370097814, 8397.70608028716, 8459.873101903477, 8616.741497755078, 489.9167141585939, 517.0950836036935, 538.3082738680777, 627.6202648736496, 642.2549842183046, 3169.6830316968117, 3248.4964830451318, 3260.190594220183, 3346.314005628889, 3390.0168951004425, 56883.0, 58427.41572584305, 58516.70741646265, 58903.41096589065, 59031.70484147638, 51677.0, 52402.0, 53220.46779532233, 53796.0, 54470.0, 47305.58083257508, 47424.5257547427, 47548.76225618919, 47607.28589071236, 48279.0, 8470.915290847013, 8589.785255368415, 8874.64501419936, 9177.77055573616, 9180.586873590571, 32510.349793003534, 32780.34439311248, 34329.0, 34414.0, 34538.0, 43789.78105109454, 45204.0, 45445.09109817851, 45633.08733825371, 45922.54077459183, 8423.789405264672, 8659.523726194868, 8721.781955451164, 8770.517621530877, 8830.470171789713, 11877.821832672344, 12749.362531873183, 12802.231866088065, 12843.614691559269, 13019.609411717664, 11322.60370887015, 11542.94228528852, 12156.088293378209, 12545.498180072695, 12566.748665026465, 11278.09775217997, 11533.365664888175, 11553.595624153115, 11628.0, 11938.58214962472, 12108.878911211128, 12211.877881221075, 12219.877801221874, 12239.938800305941, 12518.749625007267, 10010.699679009642, 10012.949935250568, 10145.9492702536, 10259.281850270409, 10793.460326983777, 9134.451932884049, 9740.220782337254, 9976.152027077489, 10072.949635251776, 10183.032611901857]}, "summary": {"lowerIsBetter": false, "suite": 6700.923593515681, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7019.544103636313, "unit": "ms", "value": 7019.544103636313}, "dojo.html": {"lowerIsBetter": false, "filtered": 5480.628327988139, "unit": "ms", "value": 5480.628327988139}, "mootools.html": {"lowerIsBetter": false, "filtered": 4349.9693136701935, "unit": "ms", "value": 4349.9693136701935}, "ext.html": {"lowerIsBetter": false, "filtered": 18968.3373509451, "unit": "ms", "value": 18968.3373509451}, "prototype.html": {"lowerIsBetter": false, "filtered": 4812.096450923831, "unit": "ms", "value": 4812.096450923831}, "yui.html": {"lowerIsBetter": false, "filtered": 5926.256627141006, "unit": "ms", "value": 5926.256627141006}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447731744, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173008", "branch": "B2G-Inbound", "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0], "ai-astar": [111.0, 111.0, 106.0, 109.0, 114.0, 113.0, 102.0, 110.0, 111.0, 108.0], "imaging-gaussian-blur": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [152.0, 127.0, 148.0, 162.0, 127.0, 170.0, 148.0, 126.0, 159.0, 129.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 70.0], "stanford-crypto-pbkdf2": [139.0, 148.0, 150.0, 153.0, 149.0, 140.0, 151.0, 149.0, 148.0, 143.0], "json-parse-financial": [57.0, 57.0, 58.0, 57.0, 58.0, 57.0, 58.0, 66.0, 56.0, 55.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 67.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0], "audio-fft": [73.0, 74.0, 84.0, 90.0, 72.0, 71.0, 73.0, 113.0, 89.0, 71.0], "imaging-darkroom": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0, 146.0, 145.0], "stanford-crypto-ccm": [120.0, 115.0, 122.0, 122.0, 117.0, 120.0, 118.0, 123.0, 127.0, 115.0], "audio-oscillator": [91.0, 91.0, 132.0, 89.0, 90.0, 90.0, 132.0, 90.0, 90.0, 141.0], "stanford-crypto-aes": [86.0, 86.0, 85.0, 88.0, 83.0, 85.0, 89.0, 85.0, 88.0, 87.0], "imaging-desaturate": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.0, "unit": "ms", "value": 81.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.8, "unit": "ms", "value": 144.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.9, "unit": "ms", "value": 119.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.9, "unit": "ms", "value": 57.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.6, "unit": "ms", "value": 103.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.2, "unit": "ms", "value": 161.2}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.9, "unit": "ms", "value": 65.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.5, "unit": "ms", "value": 69.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.2, "unit": "ms", "value": 86.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447731744, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173008", "branch": "B2G-Inbound", "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.4012441679627], "Encrypt": [281.45229383619477], "NavierStokes": [4830.917874396136], "Decrypt": [5050.50505050505], "Splay": [640.5353728489483], "Richards": [163.5322976287817], "RegExp": [26051.28205128205], "Earley": [801.2820512820513], "Boyer": [11929.411764705883], "RayTrace": [1964.6365422396857]}, "summary": {"lowerIsBetter": false, "suite": 19763.300051157465, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.110992, "unit": "score", "value": 340.110992}, "Encrypt": {"lowerIsBetter": false, "filtered": 945.7410929999998, "unit": "score", "value": 945.7410929999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.70383799999996, "unit": "score", "value": 52.70383799999996}, "Splay": {"lowerIsBetter": false, "filtered": 127.22326268656717, "unit": "score", "value": 127.22326268656717}, "RegExp": {"lowerIsBetter": false, "filtered": 34.96891240157479, "unit": "score", "value": 34.96891240157479}, "Richards": {"lowerIsBetter": false, "filtered": 215.87172999999993, "unit": "score", "value": 215.87172999999993}, "Earley": {"lowerIsBetter": false, "filtered": 831.745824, "unit": "score", "value": 831.745824}, "Boyer": {"lowerIsBetter": false, "filtered": 55.867214003944795, "unit": "score", "value": 55.867214003944795}, "RayTrace": {"lowerIsBetter": false, "filtered": 376.654401, "unit": "score", "value": 376.654401}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-068"}, "testrun": {"date": 1447731744, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116173008", "branch": "B2G-Inbound", "revision": "d1a8f65dbf479db6960b5c56ca9102839d0d561e"}}] 20:02:35 INFO - RETURN: dromaeo_css: 6700.93 20:02:35 INFO - RETURN: kraken: 1498.30 20:02:35 INFO - RETURN: v8_7: 19763.30 20:02:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19763.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1498.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6700.93"}}} 20:02:35 INFO - Return code: 0 20:02:35 INFO - # TBPL SUCCESS # 20:02:35 INFO - Running post-action listener: _resource_record_post_action 20:02:35 INFO - Running post-run listener: _resource_record_post_run 20:02:36 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516792320; Read time: 60; Write time: 617128 20:02:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 175177728; Read time: 0; Write time: 242612 20:02:36 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271003648; Read time: 60; Write time: 230040 20:02:36 INFO - Running post-run listener: _upload_blobber_files 20:02:36 INFO - Blob upload gear active. 20:02:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:02:36 INFO - Copying logs to upload dir... 20:02:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.424972 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-16 20:02:35.662087) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:02:35.667271) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'https://queue.taskcluster.net/v1/task/-QMREWb2SieqOApEEtIy4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:02:35.718935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:02:35.719466) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447729716.835659-1962284529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:02:35.768592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:02:35.768909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:02:35.769189) ========= ========= Total master_lag: 0.22 =========