builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1448290358.51 results: success (0) buildid: 20151123043002 builduid: e3df8d49af62420fa3b191818a6ad8b8 revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.510188) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.510666) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.510945) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006691 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.533086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.533373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.564481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.564883) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.623010) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.623524) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.624078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.624550) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 06:52:39-- 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% 215M=0s 2015-11-23 06:52:39 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.847568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.847923) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017605 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.897896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:38.898226) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 06:52:39,481 truncating revision to first 12 chars 2015-11-23 06:52:39,482 Setting DEBUG logging. 2015-11-23 06:52:39,482 attempt 1/10 2015-11-23 06:52:39,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 06:52:39,714 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:39.414720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:39.415019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:39.425594) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:39.425950) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:52:39.426393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-23 06:52:39.426691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:52:40 INFO - MultiFileLogger online at 20151123 06:52:40 in /builds/slave/test-pgo 06:52:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:52:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:52:40 INFO - {'append_to_log': False, 06:52:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:52:40 INFO - 'blob_upload_branch': 'Firefox', 06:52:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:52:40 INFO - 'branch': 'Firefox', 06:52:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:52:40 INFO - 'config_files': ('talos/linux_config.py',), 06:52:40 INFO - 'default_actions': ('clobber', 06:52:40 INFO - 'read-buildbot-config', 06:52:40 INFO - 'download-and-extract', 06:52:40 INFO - 'populate-webroot', 06:52:40 INFO - 'create-virtualenv', 06:52:40 INFO - 'install', 06:52:40 INFO - 'run-tests'), 06:52:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:52:40 INFO - 'download_minidump_stackwalk': True, 06:52:40 INFO - 'download_symbols': 'ondemand', 06:52:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:52:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:52:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:52:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:52:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:52:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:52:40 INFO - 'installer_path': 'installer.exe', 06:52:40 INFO - 'log_level': 'info', 06:52:40 INFO - 'log_name': 'talos', 06:52:40 INFO - 'log_to_console': True, 06:52:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:52:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:52:40 INFO - 'opt_config_files': (), 06:52:40 INFO - 'pip_index': False, 06:52:40 INFO - 'sps_profile': False, 06:52:40 INFO - 'sps_profile_interval': 0, 06:52:40 INFO - 'suite': 'dromaeojs-e10s', 06:52:40 INFO - 'system_bits': '64', 06:52:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:52:40 INFO - 'title': 'talos-linux64-ix-017', 06:52:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:52:40 INFO - 'use_talos_json': True, 06:52:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:52:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:52:40 INFO - 'work_dir': 'build'} 06:52:40 INFO - ##### 06:52:40 INFO - ##### Running clobber step. 06:52:40 INFO - ##### 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: clobber 06:52:40 INFO - rmtree: /builds/slave/test-pgo/build 06:52:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:52:40 INFO - Running post-action listener: _resource_record_post_action 06:52:40 INFO - ##### 06:52:40 INFO - ##### Running read-buildbot-config step. 06:52:40 INFO - ##### 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: read_buildbot_config 06:52:40 INFO - Using buildbot properties: 06:52:40 INFO - { 06:52:40 INFO - "properties": { 06:52:40 INFO - "buildnumber": 558, 06:52:40 INFO - "product": "firefox", 06:52:40 INFO - "script_repo_revision": "production", 06:52:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:52:40 INFO - "repository": "", 06:52:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:52:40 INFO - "buildid": "20151123043002", 06:52:40 INFO - "slavename": "talos-linux64-ix-017", 06:52:40 INFO - "pgo_build": "True", 06:52:40 INFO - "basedir": "/builds/slave/test-pgo", 06:52:40 INFO - "project": "", 06:52:40 INFO - "platform": "ubuntu64_hw", 06:52:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:52:40 INFO - "slavebuilddir": "test", 06:52:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:52:40 INFO - "branch": "mozilla-central", 06:52:40 INFO - "repo_path": "mozilla-central", 06:52:40 INFO - "stage_platform": "linux64-pgo", 06:52:40 INFO - "builduid": "e3df8d49af62420fa3b191818a6ad8b8", 06:52:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:52:40 INFO - }, 06:52:40 INFO - "sourcestamp": { 06:52:40 INFO - "repository": "", 06:52:40 INFO - "hasPatch": false, 06:52:40 INFO - "project": "", 06:52:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:52:40 INFO - "changes": [ 06:52:40 INFO - { 06:52:40 INFO - "category": null, 06:52:40 INFO - "files": [ 06:52:40 INFO - { 06:52:40 INFO - "url": null, 06:52:40 INFO - "name": "https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:52:40 INFO - } 06:52:40 INFO - ], 06:52:40 INFO - "repository": "", 06:52:40 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 06:52:40 INFO - "who": "sendchange", 06:52:40 INFO - "when": 1448290335, 06:52:40 INFO - "number": 6695063, 06:52:40 INFO - "comments": "", 06:52:40 INFO - "project": "", 06:52:40 INFO - "at": "Mon 23 Nov 2015 06:52:15", 06:52:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:52:40 INFO - "revlink": "", 06:52:40 INFO - "properties": [ 06:52:40 INFO - [ 06:52:40 INFO - "buildid", 06:52:40 INFO - "20151123043002", 06:52:40 INFO - "Change" 06:52:40 INFO - ], 06:52:40 INFO - [ 06:52:40 INFO - "builduid", 06:52:40 INFO - "e3df8d49af62420fa3b191818a6ad8b8", 06:52:40 INFO - "Change" 06:52:40 INFO - ], 06:52:40 INFO - [ 06:52:40 INFO - "pgo_build", 06:52:40 INFO - "True", 06:52:40 INFO - "Change" 06:52:40 INFO - ] 06:52:40 INFO - ], 06:52:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:52:40 INFO - } 06:52:40 INFO - ], 06:52:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 06:52:40 INFO - } 06:52:40 INFO - } 06:52:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:52:40 INFO - Running post-action listener: _resource_record_post_action 06:52:40 INFO - ##### 06:52:40 INFO - ##### Running download-and-extract step. 06:52:40 INFO - ##### 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: download_and_extract 06:52:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:40 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:52:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json 06:52:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json 06:52:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:52:44 INFO - Downloaded 1302 bytes. 06:52:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:52:44 INFO - Using the following test package requirements: 06:52:44 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:52:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'jsshell-linux-x86_64.zip'], 06:52:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:52:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:52:44 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:52:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:52:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:52:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:52:44 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:52:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:44 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:49 INFO - Downloaded 22524477 bytes. 06:52:49 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 06:52:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:49 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 06:52:50 INFO - Return code: 0 06:52:50 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 06:52: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')]} 06:52:50 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:51 INFO - Downloaded 22524477 bytes. 06:52:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:52:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:52:53 INFO - Return code: 0 06:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:53 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:54 INFO - Downloaded 11130997 bytes. 06:52:54 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 06:52:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:52:54 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 06:52:54 INFO - Return code: 0 06:52: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')]} 06:52:54 INFO - https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:52:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:52:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:52:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/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 06:52:55 INFO - Downloaded 57450217 bytes. 06:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:52:55 INFO - mkdir: /builds/slave/test-pgo/properties 06:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:52:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:52:55 INFO - Contents: 06:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:52:55 INFO - Running post-action listener: _resource_record_post_action 06:52:55 INFO - Running post-action listener: set_extra_try_arguments 06:52:55 INFO - ##### 06:52:55 INFO - ##### Running populate-webroot step. 06:52:55 INFO - ##### 06:52:55 INFO - Running pre-action listener: _resource_record_pre_action 06:52:55 INFO - Running main action method: populate_webroot 06:52:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:52:55 INFO - '../fennec_ids.txt'], 06:52:55 INFO - 'tests': ['tcheck2']}, 06:52:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:55 INFO - '--tppagecycles', 06:52:55 INFO - '7'], 06:52:55 INFO - 'tests': ['tsvgm']}}, 06:52:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:52:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:52:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'tests': ['damp', 'tps']}, 06:52:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['damp', 'tps']}, 06:52:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:52:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:55 INFO - 'other': {'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'other_l64': {'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'other_nol64': {'tests': ['a11yr', 06:52:55 INFO - 'ts_paint', 06:52:55 INFO - 'tpaint', 06:52:55 INFO - 'sessionrestore', 06:52:55 INFO - 'sessionrestore_no_auto_restore']}, 06:52:55 INFO - 'svgr': {'tests': ['tsvgx', 06:52:55 INFO - 'tsvgr_opacity', 06:52:55 INFO - 'tart', 06:52:55 INFO - 'tscrollx', 06:52:55 INFO - 'cart']}, 06:52:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['tsvgx', 06:52:55 INFO - 'tsvgr_opacity', 06:52:55 INFO - 'tart', 06:52:55 INFO - 'tscrollx', 06:52:55 INFO - 'cart']}, 06:52:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'tests': ['tp5o']}, 06:52:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'talos_options': ['--e10s'], 06:52:55 INFO - 'tests': ['tp5o']}, 06:52:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'talos_options': ['--xperf_path', 06:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:55 INFO - 'tests': ['tp5n']}, 06:52:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:55 INFO - 'talos_options': ['--e10s', 06:52:55 INFO - '--xperf_path', 06:52:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:55 INFO - 'tests': ['tp5n']}}, 06:52:55 INFO - 'talos.zip': {'path': '', 06:52:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:55 INFO - Running post-action listener: _resource_record_post_action 06:52:55 INFO - ##### 06:52:55 INFO - ##### Running create-virtualenv step. 06:52:55 INFO - ##### 06:52:55 INFO - Running pre-action listener: _resource_record_pre_action 06:52:55 INFO - Running main action method: create_virtualenv 06:52:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:52:55 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 06:52:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:52:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:55 INFO - Using real prefix '/usr' 06:52:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:52:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:58 INFO - Installing pip.................done. 06:52:58 INFO - Return code: 0 06:52:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:52: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:52: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 pip>=1.5 06:52:58 INFO - Using env: {'DISPLAY': ':0', 06:52:58 INFO - 'HOME': '/home/cltbld', 06:52:58 INFO - 'LANG': 'en_US.UTF-8', 06:52:58 INFO - 'LANGUAGE': 'en_US:en', 06:52:58 INFO - 'LOGNAME': 'cltbld', 06:52:58 INFO - 'MAIL': '/var/mail/cltbld', 06:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:58 INFO - 'MOZ_NO_REMOTE': '1', 06:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:58 INFO - 'NO_EM_RESTART': '1', 06:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:58 INFO - 'SHELL': '/bin/bash', 06:52:58 INFO - 'SHLVL': '1', 06:52:58 INFO - 'TERM': 'linux', 06:52:58 INFO - 'TMOUT': '86400', 06:52:58 INFO - 'USER': 'cltbld', 06:52:58 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:58 INFO - '_': '/tools/buildbot/bin/python'} 06:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:58 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 06:52:58 INFO - Cleaning up... 06:52:58 INFO - Return code: 0 06:52:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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', '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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:52: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:52: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 psutil>=0.7.1 06:52:58 INFO - Using env: {'DISPLAY': ':0', 06:52:58 INFO - 'HOME': '/home/cltbld', 06:52:58 INFO - 'LANG': 'en_US.UTF-8', 06:52:58 INFO - 'LANGUAGE': 'en_US:en', 06:52:58 INFO - 'LOGNAME': 'cltbld', 06:52:58 INFO - 'MAIL': '/var/mail/cltbld', 06:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:58 INFO - 'MOZ_NO_REMOTE': '1', 06:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:58 INFO - 'NO_EM_RESTART': '1', 06:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:58 INFO - 'SHELL': '/bin/bash', 06:52:58 INFO - 'SHLVL': '1', 06:52:58 INFO - 'TERM': 'linux', 06:52:58 INFO - 'TMOUT': '86400', 06:52:58 INFO - 'USER': 'cltbld', 06:52:58 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:58 INFO - '_': '/tools/buildbot/bin/python'} 06:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:58 INFO - Downloading/unpacking psutil>=0.7.1 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:00 INFO - Installing collected packages: psutil 06:53:00 INFO - Running setup.py install for psutil 06:53:00 INFO - building 'psutil._psutil_linux' extension 06:53:00 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 06:53:00 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 06:53:00 INFO - building 'psutil._psutil_posix' extension 06:53:00 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 06:53:00 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 06:53:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:53:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:53:00 INFO - Successfully installed psutil 06:53:00 INFO - Cleaning up... 06:53:00 INFO - Return code: 0 06:53:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:00 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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:53:00 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 06:53:00 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 06:53:00 INFO - Using env: {'DISPLAY': ':0', 06:53:00 INFO - 'HOME': '/home/cltbld', 06:53:00 INFO - 'LANG': 'en_US.UTF-8', 06:53:00 INFO - 'LANGUAGE': 'en_US:en', 06:53:00 INFO - 'LOGNAME': 'cltbld', 06:53:00 INFO - 'MAIL': '/var/mail/cltbld', 06:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:00 INFO - 'MOZ_NO_REMOTE': '1', 06:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:00 INFO - 'NO_EM_RESTART': '1', 06:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:00 INFO - 'SHELL': '/bin/bash', 06:53:00 INFO - 'SHLVL': '1', 06:53:00 INFO - 'TERM': 'linux', 06:53:00 INFO - 'TMOUT': '86400', 06:53:00 INFO - 'USER': 'cltbld', 06:53:00 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:00 INFO - '_': '/tools/buildbot/bin/python'} 06:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53: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 06:53:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:53:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:53:02 INFO - Installing collected packages: mozsystemmonitor 06:53:02 INFO - Running setup.py install for mozsystemmonitor 06:53:02 INFO - Successfully installed mozsystemmonitor 06:53:02 INFO - Cleaning up... 06:53:03 INFO - Return code: 0 06:53:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:03 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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:53:03 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 06:53:03 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 06:53:03 INFO - Using env: {'DISPLAY': ':0', 06:53:03 INFO - 'HOME': '/home/cltbld', 06:53:03 INFO - 'LANG': 'en_US.UTF-8', 06:53:03 INFO - 'LANGUAGE': 'en_US:en', 06:53:03 INFO - 'LOGNAME': 'cltbld', 06:53:03 INFO - 'MAIL': '/var/mail/cltbld', 06:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:03 INFO - 'MOZ_NO_REMOTE': '1', 06:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:03 INFO - 'NO_EM_RESTART': '1', 06:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:03 INFO - 'SHELL': '/bin/bash', 06:53:03 INFO - 'SHLVL': '1', 06:53:03 INFO - 'TERM': 'linux', 06:53:03 INFO - 'TMOUT': '86400', 06:53:03 INFO - 'USER': 'cltbld', 06:53:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:03 INFO - '_': '/tools/buildbot/bin/python'} 06:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:03 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 06:53:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:53:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:53:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:53:05 INFO - Downloading docopt-0.6.1.tar.gz 06:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:53:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:53:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:53:05 INFO - Running setup.py install for blobuploader 06:53:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:53:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:53:05 INFO - Running setup.py install for requests 06:53:06 INFO - Running setup.py install for docopt 06:53:06 INFO - Successfully installed blobuploader requests docopt 06:53:06 INFO - Cleaning up... 06:53:06 INFO - Return code: 0 06:53:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:06 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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:53:06 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 06:53:06 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 06:53:06 INFO - Using env: {'DISPLAY': ':0', 06:53:06 INFO - 'HOME': '/home/cltbld', 06:53:06 INFO - 'LANG': 'en_US.UTF-8', 06:53:06 INFO - 'LANGUAGE': 'en_US:en', 06:53:06 INFO - 'LOGNAME': 'cltbld', 06:53:06 INFO - 'MAIL': '/var/mail/cltbld', 06:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:06 INFO - 'MOZ_NO_REMOTE': '1', 06:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:06 INFO - 'NO_EM_RESTART': '1', 06:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:06 INFO - 'SHELL': '/bin/bash', 06:53:06 INFO - 'SHLVL': '1', 06:53:06 INFO - 'TERM': 'linux', 06:53:06 INFO - 'TMOUT': '86400', 06:53:06 INFO - 'USER': 'cltbld', 06:53:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:06 INFO - '_': '/tools/buildbot/bin/python'} 06:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:06 INFO - Running setup.py (path:/tmp/pip-kkVQRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:06 INFO - Running setup.py (path:/tmp/pip-irRboN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:06 INFO - Running setup.py (path:/tmp/pip-vffDbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:06 INFO - Running setup.py (path:/tmp/pip-Ne04Ah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:06 INFO - Running setup.py (path:/tmp/pip-53Wiz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:06 INFO - Running setup.py (path:/tmp/pip-1yaxMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:06 INFO - Running setup.py (path:/tmp/pip-kUNAXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:06 INFO - Running setup.py (path:/tmp/pip-ObOfJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:07 INFO - Running setup.py (path:/tmp/pip-18sfL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:07 INFO - Running setup.py (path:/tmp/pip-Rgu_TZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:07 INFO - Running setup.py (path:/tmp/pip-7nmtMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:07 INFO - Running setup.py (path:/tmp/pip-E_N44H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:07 INFO - Running setup.py (path:/tmp/pip-WO_mUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:07 INFO - Running setup.py (path:/tmp/pip-1vGrbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:07 INFO - Running setup.py (path:/tmp/pip-IR6iup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:07 INFO - Running setup.py (path:/tmp/pip-KsnMXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:07 INFO - Running setup.py (path:/tmp/pip-7W53Mx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:53:07 INFO - Running setup.py install for manifestparser 06:53:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:53:07 INFO - Running setup.py install for mozcrash 06:53:07 INFO - Running setup.py install for mozdebug 06:53:08 INFO - Running setup.py install for mozdevice 06:53:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for mozfile 06:53:08 INFO - Running setup.py install for mozhttpd 06:53:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for mozinfo 06:53:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for mozInstall 06:53:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for mozleak 06:53:08 INFO - Running setup.py install for mozlog 06:53:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for moznetwork 06:53:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:53:08 INFO - Running setup.py install for mozprocess 06:53:08 INFO - Running setup.py install for mozprofile 06:53:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:53:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:53:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:53:09 INFO - Running setup.py install for mozrunner 06:53:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:53:09 INFO - Running setup.py install for mozscreenshot 06:53:09 INFO - Running setup.py install for moztest 06:53:09 INFO - Running setup.py install for mozversion 06:53:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:53:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:53:09 INFO - Cleaning up... 06:53:09 INFO - Return code: 0 06:53:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:53:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 06:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 06:53:09 INFO - Using env: {'DISPLAY': ':0', 06:53:09 INFO - 'HOME': '/home/cltbld', 06:53:09 INFO - 'LANG': 'en_US.UTF-8', 06:53:09 INFO - 'LANGUAGE': 'en_US:en', 06:53:09 INFO - 'LOGNAME': 'cltbld', 06:53:09 INFO - 'MAIL': '/var/mail/cltbld', 06:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:09 INFO - 'MOZ_NO_REMOTE': '1', 06:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:09 INFO - 'NO_EM_RESTART': '1', 06:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:09 INFO - 'SHELL': '/bin/bash', 06:53:09 INFO - 'SHLVL': '1', 06:53:09 INFO - 'TERM': 'linux', 06:53:09 INFO - 'TMOUT': '86400', 06:53:09 INFO - 'USER': 'cltbld', 06:53:09 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:09 INFO - '_': '/tools/buildbot/bin/python'} 06:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:09 INFO - Running setup.py (path:/tmp/pip-GuPDcd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:53:09 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)) 06:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:09 INFO - Running setup.py (path:/tmp/pip-sTAWMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:53:09 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)) 06:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:09 INFO - Running setup.py (path:/tmp/pip-AVezth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:53:09 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)) 06:53:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:09 INFO - Running setup.py (path:/tmp/pip-UpmsXg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:10 INFO - Running setup.py (path:/tmp/pip-NRYMaF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:10 INFO - Running setup.py (path:/tmp/pip-L6mmk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:10 INFO - Running setup.py (path:/tmp/pip-F6DebS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:10 INFO - Running setup.py (path:/tmp/pip-OXJgbL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:10 INFO - Running setup.py (path:/tmp/pip-Oowpe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:10 INFO - Running setup.py (path:/tmp/pip-RUaEdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:10 INFO - Running setup.py (path:/tmp/pip-pY82PN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:10 INFO - Running setup.py (path:/tmp/pip-5pPwQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:10 INFO - Running setup.py (path:/tmp/pip-V0EPGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:10 INFO - Running setup.py (path:/tmp/pip-_eKv0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:10 INFO - Running setup.py (path:/tmp/pip-LvYIR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:10 INFO - Running setup.py (path:/tmp/pip-dAzC_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:53:10 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)) 06:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:10 INFO - Running setup.py (path:/tmp/pip-yNW1gP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:53:10 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)) 06:53:10 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)) 06:53:10 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)) 06:53:10 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)) 06:53:10 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)) 06:53:10 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)) 06:53:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:53:10 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 06:53:10 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 06:53:10 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 06:53:10 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 06:53:10 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 06:53:10 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 06:53:12 INFO - Downloading blessings-1.5.1.tar.gz 06:53:12 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 06:53:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:53:12 INFO - Installing collected packages: blessings 06:53:12 INFO - Running setup.py install for blessings 06:53:12 INFO - Successfully installed blessings 06:53:12 INFO - Cleaning up... 06:53:12 INFO - Return code: 0 06:53:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:53:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:13 INFO - Reading from file tmpfile_stdout 06:53:13 INFO - Current package versions: 06:53:13 INFO - argparse == 1.2.1 06:53:13 INFO - blessings == 1.5.1 06:53:13 INFO - blobuploader == 1.2.4 06:53:13 INFO - docopt == 0.6.1 06:53:13 INFO - manifestparser == 1.1 06:53:13 INFO - mozInstall == 1.12 06:53:13 INFO - mozcrash == 0.16 06:53:13 INFO - mozdebug == 0.1 06:53:13 INFO - mozdevice == 0.47 06:53:13 INFO - mozfile == 1.2 06:53:13 INFO - mozhttpd == 0.7 06:53:13 INFO - mozinfo == 0.9 06:53:13 INFO - mozleak == 0.1 06:53:13 INFO - mozlog == 3.0 06:53:13 INFO - moznetwork == 0.27 06:53:13 INFO - mozprocess == 0.22 06:53:13 INFO - mozprofile == 0.27 06:53:13 INFO - mozrunner == 6.11 06:53:13 INFO - mozscreenshot == 0.1 06:53:13 INFO - mozsystemmonitor == 0.0 06:53:13 INFO - moztest == 0.7 06:53:13 INFO - mozversion == 1.4 06:53:13 INFO - psutil == 3.1.1 06:53:13 INFO - requests == 1.2.3 06:53:13 INFO - wsgiref == 0.1.2 06:53:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:53:13 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')]} 06:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:13 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')]} 06:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:13 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 0x7f9064c84c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18366c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f76e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, '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': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', '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 06:53:13 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 06:53:13 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 06:53:13 INFO - Using env: {'DISPLAY': ':0', 06:53:13 INFO - 'HOME': '/home/cltbld', 06:53:13 INFO - 'LANG': 'en_US.UTF-8', 06:53:13 INFO - 'LANGUAGE': 'en_US:en', 06:53:13 INFO - 'LOGNAME': 'cltbld', 06:53:13 INFO - 'MAIL': '/var/mail/cltbld', 06:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:13 INFO - 'MOZ_NO_REMOTE': '1', 06:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:13 INFO - 'NO_EM_RESTART': '1', 06:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:13 INFO - 'SHELL': '/bin/bash', 06:53:13 INFO - 'SHLVL': '1', 06:53:13 INFO - 'TERM': 'linux', 06:53:13 INFO - 'TMOUT': '86400', 06:53:13 INFO - 'USER': 'cltbld', 06:53:13 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:13 INFO - '_': '/tools/buildbot/bin/python'} 06:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 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)) 06:53:13 INFO - Cleaning up... 06:53:13 INFO - Return code: 0 06:53:13 INFO - Running post-action listener: _resource_record_post_action 06:53:13 INFO - Running post-action listener: _start_resource_monitoring 06:53:13 INFO - Starting resource monitoring. 06:53:13 INFO - ##### 06:53:13 INFO - ##### Running install step. 06:53:13 INFO - ##### 06:53:13 INFO - Running pre-action listener: _resource_record_pre_action 06:53:13 INFO - Running main action method: install 06:53:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:53:13 INFO - Reading from file tmpfile_stdout 06:53:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:53:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:53:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:53:13 INFO - Reading from file tmpfile_stdout 06:53:13 INFO - Output received: 06:53:13 INFO - Usage: mozinstall [options] installer 06:53:13 INFO - Options: 06:53:13 INFO - -h, --help show this help message and exit 06:53:13 INFO - -d DEST, --destination=DEST 06:53:13 INFO - Directory to install application into. [default: 06:53:13 INFO - "/builds/slave/test-pgo"] 06:53:13 INFO - --app=APP Application being installed. [default: firefox] 06:53:13 INFO - mkdir: /builds/slave/test-pgo/build/application 06:53:13 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'] 06:53:13 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 06:53:28 INFO - Reading from file tmpfile_stdout 06:53:28 INFO - Output received: 06:53:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:53:28 INFO - Running post-action listener: _resource_record_post_action 06:53:28 INFO - ##### 06:53:28 INFO - ##### Running run-tests step. 06:53:28 INFO - ##### 06:53:28 INFO - Running pre-action listener: _resource_record_pre_action 06:53:28 INFO - Running main action method: run_tests 06:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:53:28 INFO - Python 2.7.3 06:53:28 INFO - Return code: 0 06:53:28 INFO - grabbing minidump binary from tooltool 06:53:28 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')]} 06:53:28 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 0x192da90>, '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 0x197ff70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19802e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:53:28 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 06:53:28 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 06:53:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:28 INFO - Return code: 0 06:53:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:53:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:53:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:53:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:53:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:53:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 06:53:28 INFO - Using env: {'DISPLAY': ':0', 06:53:28 INFO - 'HOME': '/home/cltbld', 06:53:28 INFO - 'LANG': 'en_US.UTF-8', 06:53:28 INFO - 'LANGUAGE': 'en_US:en', 06:53:28 INFO - 'LOGNAME': 'cltbld', 06:53:28 INFO - 'MAIL': '/var/mail/cltbld', 06:53:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:28 INFO - 'MOZ_NO_REMOTE': '1', 06:53:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:28 INFO - 'NO_EM_RESTART': '1', 06:53:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:28 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:53:28 INFO - 'SHELL': '/bin/bash', 06:53:28 INFO - 'SHLVL': '1', 06:53:28 INFO - 'TERM': 'linux', 06:53:28 INFO - 'TMOUT': '86400', 06:53:28 INFO - 'USER': 'cltbld', 06:53:28 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942', 06:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:28 INFO - '_': '/tools/buildbot/bin/python'} 06:53:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 06:53:28 INFO - mozversion INFO | application_buildid: 20151123043002 06:53:28 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 06:53:28 INFO - mozversion INFO | application_display_name: Nightly 06:53:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:28 INFO - mozversion INFO | application_name: Firefox 06:53:28 INFO - mozversion INFO | application_remotingname: firefox 06:53:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:53:28 INFO - mozversion INFO | application_vendor: Mozilla 06:53:28 INFO - mozversion INFO | application_version: 45.0a1 06:53:28 INFO - mozversion INFO | platform_buildid: 20151123043002 06:53:28 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 06:53:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:53:28 INFO - mozversion INFO | platform_version: 45.0a1 06:53:28 INFO - 2015-11-23 06:53:28,311 DEBUG : using testdate: 1448290408 06:53:28 INFO - 2015-11-23 06:53:28,311 DEBUG : actual date: 1448290408 06:53:28 INFO - 2015-11-23 06:53:28,359 INFO : starting webserver on 'localhost:57659' 06:53:28 INFO - 2015-11-23 06:53:28,360 INFO : Starting test suite talos-linux64-ix-017.e 06:53:28 INFO - 2015-11-23 06:53:28,360 INFO : Starting test dromaeo_css 06:53:28 INFO - 2015-11-23 06:53:28,360 DEBUG : operating with platform_type : linux_ 06:53:28 INFO - 2015-11-23 06:53:28,361 INFO : Initialising browser for dromaeo_css test... 06:53:28 INFO - 2015-11-23 06:53:28,375 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxYSMi/profile http://localhost:57659/getInfo.html 06:53:32 INFO - 2015-11-23 06:53:32,754 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:53:32 INFO - 2015-11-23 06:53:32,754 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:53:32 INFO - 2015-11-23 06:53:32,755 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:53:32 INFO - 2015-11-23 06:53:32,755 DEBUG : BROWSER_OUTPUT: __metrics 06:53:33 INFO - 2015-11-23 06:53:33,745 INFO : Browser initialized. 06:53:33 INFO - 2015-11-23 06:53:33,746 INFO : Running cycle 1/1 for dromaeo_css test... 06:53:33 INFO - 2015-11-23 06:53:33,746 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxYSMi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:53:45 INFO - 2015-11-23 06:53:45,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 141893632 06:53:45 INFO - 2015-11-23 06:53:45,556 DEBUG : BROWSER_OUTPUT: 06:54:35 INFO - 2015-11-23 06:54:35,165 DEBUG : BROWSER_OUTPUT: 1448290475163 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] 06:56:44 INFO - 2015-11-23 06:56:44,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57659/tests/dromaeo/cssquery-ext.html) 06:56:45 INFO - 2015-11-23 06:56:45,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 146657280 06:56:45 INFO - 2015-11-23 06:56:45,297 DEBUG : BROWSER_OUTPUT: 06:59:47 INFO - 2015-11-23 06:59:47,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-ext.html (next: http://localhost:57659/tests/dromaeo/cssquery-jquery.html) 06:59:47 INFO - 2015-11-23 06:59:47,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 06:59:47 INFO - 2015-11-23 06:59:47,837 DEBUG : BROWSER_OUTPUT: 07:02:49 INFO - 2015-11-23 07:02:49,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57659/tests/dromaeo/cssquery-mootools.html) 07:02:50 INFO - 2015-11-23 07:02:50,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 141832192 07:02:50 INFO - 2015-11-23 07:02:50,052 DEBUG : BROWSER_OUTPUT: 07:05:51 INFO - 2015-11-23 07:05:51,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57659/tests/dromaeo/cssquery-prototype.html) 07:05:52 INFO - 2015-11-23 07:05:52,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 140935168 07:05:52 INFO - 2015-11-23 07:05:52,303 DEBUG : BROWSER_OUTPUT: 07:08:54 INFO - 2015-11-23 07:08:54,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57659/tests/dromaeo/cssquery-yui.html) 07:08:55 INFO - 2015-11-23 07:08:55,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 07:08:55 INFO - 2015-11-23 07:08:55,216 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/dromaeo/cssquery-yui.html (next: http://localhost:57659/tests/dromaeo/cssquery-dojo.html) 07:11:57 INFO - 2015-11-23 07:11:57,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 144711680 07:11:57 INFO - 2015-11-23 07:11:57,807 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3150.7164355208033;3224.065021143867;3244.5782048333713;3274.999999999999;3281.097698133013;5262.500062494057;5309.256704061435;5367.329083864517;5367.543758780504;5414.269073675053;5366.302380690505;5375.274337964373;5383.865403364918;5387.649802762818;5449.754761035753;4897.657163998504;4974.427940786802;4979.352684151056;4991.475895031024;4997.575206107485;4893.266010098496;5033.6728112672745;5070.923936140943;5074.8731281718065;5123.513266239701;4810.639202059842;4861.2222044473065;4917.975410122962;4947.084789313988;5046.142155833517;4958.479359667219;4960.404751429815;4970.850874473772;4973.52751488608;5013.849584512471;4892.21724524078;4899.314096026559;4901.411830580318;4959.330490383788;5010.023045506127;5175.585953123741;5192.844214673566;5207.036698210805;5208.5312321891215;5272.367315922075;5834.562407819388;5876.647401155944;5880.117982302646;5882.882342353172;5915.231019967419;5758.021136406821;5942.7920022799;5945.791897283618;5956.047032474827;5971.104334349839;5443.101888188444;5467.316585426862;5480.835574932758;5483.917741233885;5560.165975103767;5891.587588868738;5906.291245050621;5921.644701317935;5958.523318134538;5960.4635582797755;5630.746616402272;5730.570207234474;5750.942490575125;5790.565707571949;5790.971045144747;5828.067509198508;5928.940710592925;5944.167816505693;5957.046872500379;5957.285125784847;5881.147233651182;5897.498712609477;5907.4683278505145;5924.911126333109;5928.584999050111;5531.7234138293725;5756.1653560233535;5756.510696590753;5758.654480731169;5898.292204935436;4428.6678499112695;4504.662150338738;4507.301368287921;4549.3176023596725;4551.135284295973;4033.9193216135513;4061.147159096564;4063.512378514538;4113.218488487178;4124.8143833527565;5397.649152805055;5643.971780141073;5651.321841379061;5671.773129074873;5678.4605462480995;5679.772809087673;5708.571857110734;5757.395473475309;5760.539156867524;5842.707864606753;5585.413531579125;5655.406182350876;5659.8019069333195;5670.347909990404;5694.345150307685;4911.607071434277;4973.751312434364;4980.601551875841;5010.5240002199735;5052.494750524992;5859.150423188614;5944.078667806497;6006.789762358297;6092.390760923872;6144.047672610842;5819.476247137609;5835.241418615553;5836.824895253149;5858.091995740497;5906.320773111147;5916.408359164049;5987.6108052976415;5989.341172471112;5993.3706960768495;5997.370276121119;5637.943620563742;5723.370429252695;5746.166805813217;5750.367459579526;5886.23478947734;5801.129830525455;5813.215215945962;5825.883482330414;5845.1232315153065;5919.556033297434;5636.520895723909;5647.322321321303;5669.3480249770155;5704.058830293121;5704.572157088152;5568.9443105568425;5582.106862901916;5636.943630563642;5678.716064196857;5769.653820770767;5548.167774833807;5651.547876169814;5673.517750991212;5691.345495268097;5694;5498.3127109111365;5718.914216286842;5731;5743.827685169452;5753.539716822728;5440.891182176413;5513;5522.447755224445;5530.838523909863;5582.246396736388 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.2085560998802;601.2844714789401;605.4974371271845;611.6605284067343;612.2836281550585;36457.088572785695;37355.43966840499;37402.251954960884;37433.25133497328;37659.43510847333;40724.18551628965;41246;41263.17473650532;41333;41404.17191656165;8622;8815.823683526325;8819.823603527926;8826.691065812698;8850.645974161025;8593.871091933595;8658.134186581323;8688.218060374566;8691.304695624367;8703.216710496054;8659.437136586102;8721.084286149926;8736.388452808305;8741.213290803826;8764.386492945465;8636.827263454727;8729.301655867579;8737.868931966026;8767.167119123706;8767.254783343424;8497.405181637288;8610.483370997761;8625.69810056645;8633.481991080555;8635.136486351315;38342;38504.80747596244;38775.22449550993;38814.805925970475;38832;3119.9844000780076;3120.9063728088195;3131.5928929239053;3269.75476839238;3482.95511346595;29044.27389315263;29586.852065739535;29634.25914352137;29762.702372976426;30811.537826932614;3895.357266051098;3897.395903634941;3970.4441378207075;3999.1002024544537;4107.8973025674295;259141;260994;263194;263370;267282.9999999981;54439.72780136074;54602.453975459735;54813.451865480834;54966.725166374716;55723.72138139283;65644;66418.33581664122;66924.6653766728;66944.6652766733;67079.32920670828;15475.226238688245;15724.60688482797;15823;15824.68350632981;15871.603209919613;11881.584144555072;11893.70265743346;11901.821472677917;11979.28124312544;12004.819927701092;18921.24315027411;19198.328058517884;19223.807761922482;19290.22839086449;19355.61288774245;7583.696652133853;7731.420143489261;7773.92226077732;7786.688532458638;7863.803404914808;938.5964035464816;956.3305686019675;961.7932144588947;1041.3699711674478;1072.6460268111505;27704;27826.652004399006;28266.85866570654;28269.01058462985;28430.71569284322;999.1856636841096;1005.7988402319419;1063.4948399510326;1099.8350247462783;1142.714321419645;14644.633884152981;14679.192644404447;14820.184889831164;14913.776293355608;15024.17367044823;308962;314731;314964;314989;315078;50774.74612626987;51042.48957510452;51072.233916491285;51240.23139652908;51345.743271283405;1272.41699350319;1357.5723647051148;1365.474292397434;1368.103891950774;1370.280602683599;27076.45847083087;27620.30949226205;27848;27892.860535697193;28120.43759124765;44156.55843441653;44303.33544996892;44496.77751611221;44659.33011004903;44914;285940;286883;287600;289418;289702;31201.84399078081;31635;31732.365352692355;31823.363532728752;32484;39135;40922.386164208154;42041.15917681568;42395;42476.15047699091;35184.64815351814;35309.823450882584;35545.82227088848;35679.46480802842;35942.640573594974;34612.82693586516;35444;35593;35609;35725.821370892976;34975.12562185864;35018.4981501858;35152.296954060264;35179.120521987155;35395.93812185639;29372;30555;30904.845475772476;31405.371892562478;33072.834635826664;24563.263102106965;24743.752562474863;25273.241802745946;25401.237962861145;25408.74591254064 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.10494630735235;363.81809095452275;366.6205477330963;366.63519797801194;367.75360508459363;16472.423465178723;16961.491155265332;17455.214515346823;17760.111994400293;18422.723659145122;10928.125749940005;11971.940140299308;15287.235638218073;15324.846751532481;15328.693426131471;4769.236922092466;5143;5265.842024739264;5267.078261304276;5267.815626453075;5376.784928602851;5390.245365648812;5415.0523658359825;5425.26758887551;5649.378568357477;3643.198496330803;3791.791451470168;5331.360236771573;5940;6025;5418.972905135449;5442.074847275972;5447.237386765856;5458.235846981426;5471.534919531845;5186.7147306898105;5242.895142097175;5274.472552744734;5348.973255133699;5357.598180136466;12296.569620063256;12482.937585312106;12536.059795515373;16496.917515412348;20104.69842952357;1925.3165126380213;1940.0590713503939;1948.1038722187811;1992.1135094882784;2032.7459067616549;9375.578098985561;9400.482973436527;9428.905710942872;9583.281253905985;9595.28035397341;1832.230463205457;1857.9535511612182;1894.393793985925;1909.8472122230328;1910.9331173409003;56467.43532564663;59789.40210597882;59954.400455995754;60411.697941510014;61251;9971.700848974542;10215.438150901624;10384.273100882865;10389.272750907516;10394.22043346752;13403.93298033523;13430.93284533571;13437.865621343857;13460.865391346157;13465.932670336586;7710.730124445729;7730.613469326511;7731.922680773233;7736.032995875516;7772.18392068836;7544.471886967969;7559.28186822251;7566.772996810105;7595.696172153052;7620.542767433972;4349.586789255016;4350.934735978963;4369.497507786582;4381.605655491021;4396.978015109904;1689.7887764029497;1708.863290936722;1817.1459414075364;1853.8238867307584;1857.2570971611194;909.5952301226023;911.8996910339857;933.9766505837408;989.9257555683208;999.160705007797;16948;17028.33393278162;17034.82965170357;17143.914280428766;17381.739273910902;912.3112050401904;924.5977999570208;936.4100616611491;944.2587568758491;984.2913102566141;9958.900410995942;9988.800223995479;10007.14939230159;10043;10079.193664506822;529813;536079;538747;539890;544684;71157.28842711507;73726;73980.26019739841;74644;75107.62446187733;1092.1481244629201;1102.189890430549;1121.7083558274744;1125.7579620381657;1132.394169119517;15191;15363;15387.846121538641;15480.225988700295;15832.762508562151;33791.4931276036;33857;34330;34759.652403475644;34946.126346841535;44101.77949110234;44396.55603444053;44827;45094.77452612716;47798.76100619475;9471;9532.761680958032;9610.615575376907;9618.711438656852;9622.951885240529;16084.839151608334;16695.833041669426;17323.393681221096;17396;17447.214875330894;13349.733005340033;13514.391852366864;13759.38082786257;14182.716345673236;14259.572212833631;14200;14255.572332830032;14471.204083775494;14515;15024.624384390041;14108;14210.786838197642;14661.70676586441;15024.7980161589;15144.621384465476;9213.953930230306;9611.663591774255;9630.951845240728;9967.50162491887;9969.601215951281;10088.69733907984;12572.685682858002;14255.928720356333;14423.78364324515;15007.399704011717 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1470.2207829850179;1522.9771553426697;1595.840415958405;1657.1548510259772;1759.296281487404;7724.652390642421;7760;7838.764837054883;8025.117237103914;8040.155783642721;7708.498947568404;7720.4209684273765;7725.266099720531;7727;7791.688332466694;2197.63738983068;2237.0827960536185;2242.573910956913;2245.079517397867;2245.438640339915;2201.3175915466177;2246.9101235950543;2249.5051088760447;2262.3552287598036;2266.6939963104933;2092.937211883646;2095.9790402096014;2229.4314949687805;2265.7394399644004;2277.146070223666;2149.2692484555328;2173.9456513587206;2251.1558165687866;2251.594712951668;2255.2783109404995;2282.7831356021316;2284.223364056212;2298.5517824024323;2302.033146078634;2309.2956648222284;7693.692252309901;7738.187490313492;7763.417743669191;7764.340031097364;7821.960890195513;4777.737224452654;4834.468208497063;4869.780859861315;4873.537013983701;4876.341693871317;3127.718505334508;3134.5298205269164;3193.425183466975;3228.951565726516;3255.039763269841;1003.1924300937742;1006.788574399377;1934.8935808530666;1955.9119839607251;1961.9215231390726;10528.526216320284;10601.31091479059;10611.893881061167;10617;10619.628313009085;4137.91724165515;4182.644475219579;4279.40088387626;4306.095719898856;4313.137372525507;8665.870011949826;8723.956380218058;8729.127087291221;8737.694180703646;8747.256483198998;4731.503192164842;4735.384400027974;4741.099191153669;4752.881177970578;4756.904861902743;4370.431843860341;4375.584319489643;4389.4513185851765;4406.162829062468;4411.867643970686;3495.4407294832704;3556.28874225156;3561.1097225693575;3568.6966607838103;3580.1407662160896;1098.752780624369;1100.2463312630873;1106.2919731371928;1123.7920984617872;1124.0670243697875;915.6383228624655;946.5125460387906;1085.5820509103894;1143.8512993310817;1346.0577595683062;7279.563226206445;7379.3358597726465;7399.223081576464;7425.591592462466;7445.329920307198;578.780063575847;598.7784519727728;599.4005994005994;602.3614968133704;752.2815710995985;5659.434056594308;5736.1682556029145;5737.942620573825;5751.884962300815;5759.164921086419;9126.13301736334;9264.073592640816;9358.391704539183;9484.57319420614;9595.328327017181;9295.67465138717;9364.297677674065;9382.718518444457;9386.20217281525;9479.573419196153;7278.344948954514;7302.452316076316;7366.189719130892;7406.777796666109;7414.480986330905;6835.58986460814;6862.176538815374;6877.449804015767;6886.2769409213315;6894.551854129466;8025.678972841021;8276.627551760306;8324.125966773401;8326.168242986534;8455.577221138796;8520.062793092879;8581.056083830648;8588.312934965314;8590.65637374523;8602;6526.9347306528225;6554.14796076507;6555.639439830855;6559.0817285581015;6570.408663220333;7448.8882666758955;7499.550026998398;7527.924720752722;7530.397568194422;7539.170691224071;6922.619255940972;6942.479314051568;7090.822729431806;7171.4621403395995;7251.709931602888;6962.3037696231995;6973.965130174317;6976.19773726028;6996.685149168198;7022.12223472066;7088.0785497884945;7107.040549525955;7121.67952442131;7124.928750712426;7138.143422789299;6512.153420055362;6548.1487406638735;6552;6561.639109849004;6562.967185164234;6414.839629009125;6423.743050277936;6458.773942911976;6483.578567393104;6545.967270163619 07:11:57 INFO - 2015-11-23 07:11:57,808 DEBUG : BROWSER_OUTPUT: |4;prototype.html;321.8181727324062;324.8343344894103;327.8196991654589;330.35580617795307;334.01299160979306;6343.587666801661;6351.9682401587925;6352.587081839677;6363.109164716943;6376.776812811552;6195.783147589824;6303.149074874902;6321.6207027578375;6326.367363263671;6339.049142628596;4777.832775852838;4801.8079276828885;4805.663603547753;4806.4712881583;4809.7835597398025;4760.285957106445;4787.425508938914;4793.472718001034;4801.687890287138;4816.614670826343;4685.672002959795;4755.644641277237;4762.85691434055;4763.26169443735;4775.379200703904;4729.196036673757;4740.099381117611;4756.738379389132;4758.310045043484;4758.690685105475;4101.077257617012;4111.60939710727;4111.958880411187;4121.5466298707115;4124.896877578055;5971.641701497924;5984.461398474158;5986.2517185351835;5990.281166260033;6007.699615019232;5402.78388864445;5531.0873705838485;5540.972295138498;5543.944560554383;5548.389677135512;6699;6701.1623547056615;6705.094812200339;6707.3628005339415;6733.192016957947;4581.129585378767;4585.931211031804;4590.563896429867;4593.701409408378;4605.861824145281;6823;6980.220043888827;6991.965040174818;6996.510244282902;6996.7201311947465;4663.48701642819;4681.95318046822;4687.718736875799;4694.131585656664;4698.083873644607;4747.8100875965265;4753.6910100844025;4758.024604956045;4760.666753327234;4793.784279707422;5555.555555555546;5557.194206840067;5557.44425557441;5557.972210139004;5571.526420254243;6662.800115996528;6740.797776066725;6770.086038384854;6772.69522871472;6782.525223234326;1608.5978505373657;1629.299401257447;1631.0702899347496;1634.534157765055;1693.6866679664302;1080.783843231341;1097.5938902605926;1111.8999290063932;1117.580907159815;1121.6130434999911;6379.96810015947;6381.457576106083;6444.967775161094;6465.612063276219;6500.382463665944;6825.2833452486775;6845.281245469254;6881.449484041264;6890.069840571458;6913.446924246149;6353.052887706386;6386.36136386367;6415.775447859302;6471.579347342407;6479.5788273762055;3740.625937406292;3774.735768496179;3779.3952967525065;3782.127846715838;3784.7729136251914;7132.1441427029085;7162.641867906584;7169.89245161323;7199.820004499929;7205.639718014078;6998.75504357345;7085.610291433917;7110.857782844314;7126.714931402789;7146.785596432115;7123.857522849617;7145.785626431215;7161.248068952789;7164.104486939133;7190.964045179845;6872.381485666314;6906.102206713095;6909.136357955255;6915.377616014583;6933.37599616037;6696.899546506709;6812.455003599799;6823.4882383822405;6826.249112597709;6834.521583489108;7098.893516597358;7120.8219794503475;7140.571565705866;7156.033935418652;7159.069320988447;4566;4574.199515084781;4591.449026116754;4596.034832685174;4596.540345965377;6787.287334829772;6888.931110688829;6889.965550172217;6906.205786334636;6917.654117294216;6710.731570737116;6716.227633821977;6718.865622687421;6722.495812813961;6722.563033402813;6637.203535575762;6669.633170175687;6669.933300666931;6686.866262674816;6709.698063587052;6457.192850893638;6548.705308261045;6596.274409815012;6599.4390476808085;6604.075429439787;6679;6705.362990515893;6730.360615741497;6738.090357801634;6739.0902228198565;6520.934790652223;6522.771702990372;6564.934350656432;6578.8355291118105;6586.341365863375 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: |5;yui.html;840.3613253927016;848.3340577646541;848.65205265841;854.4574195385928;877.140402405642;13400.061995660295;13642.522511712092;13718.451261949522;13736.725265494684;13823.101498402597;12516.186447880882;12641.747165056693;14643.341049652765;15076.170810605412;15079;790.490133863659;807.2371608829658;807.9030516338019;808.8463191993532;811.0105671081271;804.5454318310166;806.6853926968457;811.5130921447144;814.9062857771373;815.2581151152452;847.1189962439056;847.1401527449643;851.1403482482706;854.3293514591047;855.1234984141242;839.4333824668386;843.241083025276;844.4089137603702;848.1476116502876;850.2262940723912;616.8457885528618;621.183144165421;622.7820262907991;624.4286477872741;625.7278084033414;13390.129641573267;13530.661733456644;13598.93200533991;13713.588592342247;13748.106373085717;11641.41792910351;11738.765224695459;11856.288622682667;12228.388580570936;12618.55835045769;10345.275830691855;10378;10402.167826573932;10542.209334299958;10713.678589642323;3532.6467353264725;3554.5023696682483;3560.6439356064448;3630.001749518877;3639.9272014559824;48444.75777621125;48639;48808.511914881106;48974.51025489735;49387.01225975496;9483.66807161746;9619.374740641835;9710.765479717655;9838.606455741834;9862.112409883144;17502.124893755517;17512.29950801979;17523.561910952074;17541.122943852755;17550.122493875257;7290.198078211392;7319.121705395387;7335;7382.040334756447;7557.4331925105835;4209.91580168401;4225.471816022997;4248.4477017987465;4291.957080429156;4309.956900430955;3074.8923787667322;3099.1632259289863;3100.90697279082;3105;3110.6578276389578;533.1522878622931;547.6495043172373;550.070381056022;552.078029690418;559.9468050535193;609.9512039036866;620.2990620598695;626.6177631644694;634.8539835837784;640.6600980824877;7097.361237488651;7179.928200717926;7229.638518074075;7336.082989626297;7500.812479687942;544.1375419959409;589.0137005382754;613.8557439001831;630.7508534128993;652.8792173447928;3500.387432199406;3763.9435408468894;3765.0963768695315;3788.962110378916;3863.671587915059;58027.41972580305;59153;59488.10767838486;59585.106223406685;59730.70134649299;41278.79360603178;49587.752061240186;50285.24572131421;50675.7466212674;50734.492655073715;42058.369124463155;45242;45421.31868021916;45833;46124.30813537799;7957;8067.273945344947;8363.581820909052;8439.367047471342;8455.534945578052;34737.47893781646;34865.47701784526;35094.82452587721;35264.64735352614;35291.823540882135;42471;42558.78720606501;46462;46748.29877551908;48220.7588962053;10107.848382274418;10145.797084058426;10462.529186186792;10783.514741836792;11140.944295278472;11641.6507504775;11915.2255103418;11952.342621155572;12913.289769062792;12943.417546210632;10651.89348106509;11048.558057677603;11526.308421494738;11600;11930.76138477243;11583.6524904253;11671;11836.408179591159;12348.320842353398;12352.691182720504;11219.1024718024;11290.830637540279;11410.94294528522;11622.053535756957;11742.354170520703;8922.509261990654;9007.909920900707;9117.225035872025;9287.582058807506;9314.673986410444;8474.61864216124;8966.68616598416;8989;10009.799804004026;10054.798904021733 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,303 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291517800__endTimestamp 07:11:57 INFO - 2015-11-23 07:11:57,810 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5415.84 Median:5647.32 stddev:599.36 (10.6%) stddev-sans-first:574.26 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: Values: 3150.7 3224.1 3244.6 3275.0 3281.1 5262.5 5309.3 5367.3 5367.5 5414.3 5366.3 5375.3 5383.9 5387.6 5449.8 4897.7 4974.4 4979.4 4991.5 4997.6 4893.3 5033.7 5070.9 5074.9 5123.5 4810.6 4861.2 4918.0 4947.1 5046.1 4958.5 4960.4 4970.9 4973.5 5013.8 4892.2 4899.3 4901.4 4959.3 5010.0 5175.6 5192.8 5207.0 5208.5 5272.4 5834.6 5876.6 5880.1 5882.9 5915.2 5758.0 5942.8 5945.8 5956.0 5971.1 5443.1 5467.3 5480.8 5483.9 5560.2 5891.6 5906.3 5921.6 5958.5 5960.5 5630.7 5730.6 5750.9 5790.6 5791.0 5828.1 5928.9 5944.2 5957.0 5957.3 5881.1 5897.5 5907.5 5924.9 5928.6 5531.7 5756.2 5756.5 5758.7 5898.3 4428.7 4504.7 4507.3 4549.3 4551.1 4033.9 4061.1 4063.5 4113.2 4124.8 5397.6 5644.0 5651.3 5671.8 5678.5 5679.8 5708.6 5757.4 5760.5 5842.7 5585.4 5655.4 5659.8 5670.3 5694.3 4911.6 4973.8 4980.6 5010.5 5052.5 5859.2 5944.1 6006.8 6092.4 6144.0 5819.5 5835.2 5836.8 5858.1 5906.3 5916.4 5987.6 5989.3 5993.4 5997.4 5637.9 5723.4 5746.2 5750.4 5886.2 5801.1 5813.2 5825.9 5845.1 5919.6 5636.5 5647.3 5669.3 5704.1 5704.6 5568.9 5582.1 5636.9 5678.7 5769.7 5548.2 5651.5 5673.5 5691.3 5694.0 5498.3 5718.9 5731.0 5743.8 5753.5 5440.9 5513.0 5522.4 5530.8 5582.2 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,811 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45660.53 Median:35569.41 stddev:75475.05 (212.2%) stddev-sans-first:75610.82 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: Values: 561.2 601.3 605.5 611.7 612.3 36457.1 37355.4 37402.3 37433.3 37659.4 40724.2 41246.0 41263.2 41333.0 41404.2 8622.0 8815.8 8819.8 8826.7 8850.6 8593.9 8658.1 8688.2 8691.3 8703.2 8659.4 8721.1 8736.4 8741.2 8764.4 8636.8 8729.3 8737.9 8767.2 8767.3 8497.4 8610.5 8625.7 8633.5 8635.1 38342.0 38504.8 38775.2 38814.8 38832.0 3120.0 3120.9 3131.6 3269.8 3483.0 29044.3 29586.9 29634.3 29762.7 30811.5 3895.4 3897.4 3970.4 3999.1 4107.9 259141.0 260994.0 263194.0 263370.0 267283.0 54439.7 54602.5 54813.5 54966.7 55723.7 65644.0 66418.3 66924.7 66944.7 67079.3 15475.2 15724.6 15823.0 15824.7 15871.6 11881.6 11893.7 11901.8 11979.3 12004.8 18921.2 19198.3 19223.8 19290.2 19355.6 7583.7 7731.4 7773.9 7786.7 7863.8 938.6 956.3 961.8 1041.4 1072.6 27704.0 27826.7 28266.9 28269.0 28430.7 999.2 1005.8 1063.5 1099.8 1142.7 14644.6 14679.2 14820.2 14913.8 15024.2 308962.0 314731.0 314964.0 314989.0 315078.0 50774.7 51042.5 51072.2 51240.2 51345.7 1272.4 1357.6 1365.5 1368.1 1370.3 27076.5 27620.3 27848.0 27892.9 28120.4 44156.6 44303.3 44496.8 44659.3 44914.0 285940.0 286883.0 287600.0 289418.0 289702.0 31201.8 31635.0 31732.4 31823.4 32484.0 39135.0 40922.4 42041.2 42395.0 42476.2 35184.6 35309.8 35545.8 35679.5 35942.6 34612.8 35444.0 35593.0 35609.0 35725.8 34975.1 35018.5 35152.3 35179.1 35395.9 29372.0 30555.0 30904.8 31405.4 33072.8 24563.3 24743.8 25273.2 25401.2 25408.7 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28329.20 Median:366.63 stddev:87790.20 (23945.3%) stddev-sans-first:88011.36 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: Values: 363.1 363.8 366.6 366.6 367.8 16472.4 16961.5 17455.2 17760.1 18422.7 10928.1 11971.9 15287.2 15324.8 15328.7 4769.2 5143.0 5265.8 5267.1 5267.8 5376.8 5390.2 5415.1 5425.3 5649.4 3643.2 3791.8 5331.4 5940.0 6025.0 5419.0 5442.1 5447.2 5458.2 5471.5 5186.7 5242.9 5274.5 5349.0 5357.6 12296.6 12482.9 12536.1 16496.9 20104.7 1925.3 1940.1 1948.1 1992.1 2032.7 9375.6 9400.5 9428.9 9583.3 9595.3 1832.2 1858.0 1894.4 1909.8 1910.9 56467.4 59789.4 59954.4 60411.7 61251.0 9971.7 10215.4 10384.3 10389.3 10394.2 13403.9 13430.9 13437.9 13460.9 13465.9 7710.7 7730.6 7731.9 7736.0 7772.2 7544.5 7559.3 7566.8 7595.7 7620.5 4349.6 4350.9 4369.5 4381.6 4397.0 1689.8 1708.9 1817.1 1853.8 1857.3 909.6 911.9 934.0 989.9 999.2 16948.0 17028.3 17034.8 17143.9 17381.7 912.3 924.6 936.4 944.3 984.3 9958.9 9988.8 10007.1 10043.0 10079.2 529813.0 536079.0 538747.0 539890.0 544684.0 71157.3 73726.0 73980.3 74644.0 75107.6 1092.1 1102.2 1121.7 1125.8 1132.4 15191.0 15363.0 15387.8 15480.2 15832.8 33791.5 33857.0 34330.0 34759.7 34946.1 44101.8 44396.6 44827.0 45094.8 47798.8 9471.0 9532.8 9610.6 9618.7 9623.0 16084.8 16695.8 17323.4 17396.0 17447.2 13349.7 13514.4 13759.4 14182.7 14259.6 14200.0 14255.6 14471.2 14515.0 15024.6 14108.0 14210.8 14661.7 15024.8 15144.6 9214.0 9611.7 9631.0 9967.5 9969.6 10088.7 12572.7 14255.9 14423.8 15007.4 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5445.25 Median:6497.87 stddev:2808.01 (43.2%) stddev-sans-first:2799.99 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: Values: 1470.2 1523.0 1595.8 1657.2 1759.3 7724.7 7760.0 7838.8 8025.1 8040.2 7708.5 7720.4 7725.3 7727.0 7791.7 2197.6 2237.1 2242.6 2245.1 2245.4 2201.3 2246.9 2249.5 2262.4 2266.7 2092.9 2096.0 2229.4 2265.7 2277.1 2149.3 2173.9 2251.2 2251.6 2255.3 2282.8 2284.2 2298.6 2302.0 2309.3 7693.7 7738.2 7763.4 7764.3 7822.0 4777.7 4834.5 4869.8 4873.5 4876.3 3127.7 3134.5 3193.4 3229.0 3255.0 1003.2 1006.8 1934.9 1955.9 1961.9 10528.5 10601.3 10611.9 10617.0 10619.6 4137.9 4182.6 4279.4 4306.1 4313.1 8665.9 8724.0 8729.1 8737.7 8747.3 4731.5 4735.4 4741.1 4752.9 4756.9 4370.4 4375.6 4389.5 4406.2 4411.9 3495.4 3556.3 3561.1 3568.7 3580.1 1098.8 1100.2 1106.3 1123.8 1124.1 915.6 946.5 1085.6 1143.9 1346.1 7279.6 7379.3 7399.2 7425.6 7445.3 578.8 598.8 599.4 602.4 752.3 5659.4 5736.2 5737.9 5751.9 5759.2 9126.1 9264.1 9358.4 9484.6 9595.3 9295.7 9364.3 9382.7 9386.2 9479.6 7278.3 7302.5 7366.2 7406.8 7414.5 6835.6 6862.2 6877.4 6886.3 6894.6 8025.7 8276.6 8324.1 8326.2 8455.6 8520.1 8581.1 8588.3 8590.7 8602.0 6526.9 6554.1 6555.6 6559.1 6570.4 7448.9 7499.6 7527.9 7530.4 7539.2 6922.6 6942.5 7090.8 7171.5 7251.7 6962.3 6974.0 6976.2 6996.7 7022.1 7088.1 7107.0 7121.7 7124.9 7138.1 6512.2 6548.1 6552.0 6561.6 6563.0 6414.8 6423.7 6458.8 6483.6 6546.0 07:11:57 INFO - 2015-11-23 07:11:57,813 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5580.56 Median:6378.37 stddev:1703.86 (26.7%) stddev-sans-first:1662.29 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: Values: 321.8 324.8 327.8 330.4 334.0 6343.6 6352.0 6352.6 6363.1 6376.8 6195.8 6303.1 6321.6 6326.4 6339.0 4777.8 4801.8 4805.7 4806.5 4809.8 4760.3 4787.4 4793.5 4801.7 4816.6 4685.7 4755.6 4762.9 4763.3 4775.4 4729.2 4740.1 4756.7 4758.3 4758.7 4101.1 4111.6 4112.0 4121.5 4124.9 5971.6 5984.5 5986.3 5990.3 6007.7 5402.8 5531.1 5541.0 5543.9 5548.4 6699.0 6701.2 6705.1 6707.4 6733.2 4581.1 4585.9 4590.6 4593.7 4605.9 6823.0 6980.2 6992.0 6996.5 6996.7 4663.5 4682.0 4687.7 4694.1 4698.1 4747.8 4753.7 4758.0 4760.7 4793.8 5555.6 5557.2 5557.4 5558.0 5571.5 6662.8 6740.8 6770.1 6772.7 6782.5 1608.6 1629.3 1631.1 1634.5 1693.7 1080.8 1097.6 1111.9 1117.6 1121.6 6380.0 6381.5 6445.0 6465.6 6500.4 6825.3 6845.3 6881.4 6890.1 6913.4 6353.1 6386.4 6415.8 6471.6 6479.6 3740.6 3774.7 3779.4 3782.1 3784.8 7132.1 7162.6 7169.9 7199.8 7205.6 6998.8 7085.6 7110.9 7126.7 7146.8 7123.9 7145.8 7161.2 7164.1 7191.0 6872.4 6906.1 6909.1 6915.4 6933.4 6696.9 6812.5 6823.5 6826.2 6834.5 7098.9 7120.8 7140.6 7156.0 7159.1 4566.0 4574.2 4591.4 4596.0 4596.5 6787.3 6888.9 6890.0 6906.2 6917.7 6710.7 6716.2 6718.9 6722.5 6722.6 6637.2 6669.6 6669.9 6686.9 6709.7 6457.2 6548.7 6596.3 6599.4 6604.1 6679.0 6705.4 6730.4 6738.1 6739.1 6520.9 6522.8 6564.9 6578.8 6586.3 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13693.22 Median:46605.15 stddev:15951.67 (34.2%) stddev-sans-first:15967.22 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: Values: 840.4 848.3 848.7 854.5 877.1 13400.1 13642.5 13718.5 13736.7 13823.1 12516.2 12641.7 14643.3 15076.2 15079.0 790.5 807.2 807.9 808.8 811.0 804.5 806.7 811.5 814.9 815.3 847.1 847.1 851.1 854.3 855.1 839.4 843.2 844.4 848.1 850.2 616.8 621.2 622.8 624.4 625.7 13390.1 13530.7 13598.9 13713.6 13748.1 11641.4 11738.8 11856.3 12228.4 12618.6 10345.3 10378.0 10402.2 10542.2 10713.7 3532.6 3554.5 3560.6 3630.0 3639.9 48444.8 48639.0 48808.5 48974.5 49387.0 9483.7 9619.4 9710.8 9838.6 9862.1 17502.1 17512.3 17523.6 17541.1 17550.1 7290.2 7319.1 7335.0 7382.0 7557.4 4209.9 4225.5 4248.4 4292.0 4310.0 3074.9 3099.2 3100.9 3105.0 3110.7 533.2 547.6 550.1 552.1 559.9 610.0 620.3 626.6 634.9 640.7 7097.4 7179.9 7229.6 7336.1 7500.8 544.1 589.0 613.9 630.8 652.9 3500.4 3763.9 3765.1 3789.0 3863.7 58027.4 59153.0 59488.1 59585.1 59730.7 41278.8 49587.8 50285.2 50675.7 50734.5 42058.4 45242.0 45421.3 45833.0 46124.3 7957.0 8067.3 8363.6 8439.4 8455.5 34737.5 34865.5 35094.8 35264.6 35291.8 42471.0 42558.8 46462.0 46748.3 48220.8 10107.8 10145.8 10462.5 10783.5 11140.9 11641.7 11915.2 11952.3 12913.3 12943.4 10651.9 11048.6 11526.3 11600.0 11930.8 11583.7 11671.0 11836.4 12348.3 12352.7 11219.1 11290.8 11410.9 11622.1 11742.4 8922.5 9007.9 9117.2 9287.6 9314.7 8474.6 8966.7 8989.0 10009.8 10054.8 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:11:57 INFO - 2015-11-23 07:11:57,815 DEBUG : BROWSER_OUTPUT: 07:11:58 INFO - 2015-11-23 07:11:58,469 INFO : Browser exited with error code: 0 07:11:58 INFO - 2015-11-23 07:11:58,486 INFO : Completed test dromaeo_css (00:18:30) 07:11:58 INFO - 2015-11-23 07:11:58,486 INFO : Starting test kraken 07:11:58 INFO - 2015-11-23 07:11:58,486 DEBUG : operating with platform_type : linux_ 07:11:58 INFO - 2015-11-23 07:11:58,486 INFO : Initialising browser for kraken test... 07:11:58 INFO - 2015-11-23 07:11:58,492 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaoOg6w/profile http://localhost:57659/getInfo.html 07:12:02 INFO - 2015-11-23 07:12:02,539 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:12:02 INFO - 2015-11-23 07:12:02,540 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:12:02 INFO - 2015-11-23 07:12:02,540 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:12:02 INFO - 2015-11-23 07:12:02,540 DEBUG : BROWSER_OUTPUT: __metrics 07:12:03 INFO - 2015-11-23 07:12:03,517 INFO : Browser initialized. 07:12:03 INFO - 2015-11-23 07:12:03,518 INFO : Running cycle 1/1 for kraken test... 07:12:03 INFO - 2015-11-23 07:12:03,518 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaoOg6w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:12:15 INFO - 2015-11-23 07:12:15,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141914112 07:12:15 INFO - 2015-11-23 07:12:15,390 DEBUG : BROWSER_OUTPUT: 07:12:17 INFO - 2015-11-23 07:12:17,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57659/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:18 INFO - 2015-11-23 07:12:18,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 07:12:18 INFO - 2015-11-23 07:12:18,465 DEBUG : BROWSER_OUTPUT: 07:12:21 INFO - 2015-11-23 07:12:21,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57659/tests/kraken/driver.html?testName=audio-dft) 07:12:21 INFO - 2015-11-23 07:12:21,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 142667776 07:12:21 INFO - 2015-11-23 07:12:21,675 DEBUG : BROWSER_OUTPUT: 07:12:24 INFO - 2015-11-23 07:12:24,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57659/tests/kraken/driver.html?testName=audio-fft) 07:12:25 INFO - 2015-11-23 07:12:25,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 137957376 07:12:25 INFO - 2015-11-23 07:12:25,100 DEBUG : BROWSER_OUTPUT: 07:12:27 INFO - 2015-11-23 07:12:27,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57659/tests/kraken/driver.html?testName=audio-oscillator) 07:12:27 INFO - 2015-11-23 07:12:27,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 137207808 07:12:27 INFO - 2015-11-23 07:12:27,735 DEBUG : BROWSER_OUTPUT: 07:12:29 INFO - 2015-11-23 07:12:29,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:30 INFO - 2015-11-23 07:12:30,489 DEBUG : BROWSER_OUTPUT: RSS: Main: 138014720 07:12:30 INFO - 2015-11-23 07:12:30,489 DEBUG : BROWSER_OUTPUT: 07:12:33 INFO - 2015-11-23 07:12:33,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57659/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:34 INFO - 2015-11-23 07:12:34,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 07:12:34 INFO - 2015-11-23 07:12:34,083 DEBUG : BROWSER_OUTPUT: 07:12:37 INFO - 2015-11-23 07:12:37,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57659/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:38 INFO - 2015-11-23 07:12:38,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 07:12:38 INFO - 2015-11-23 07:12:38,046 DEBUG : BROWSER_OUTPUT: 07:12:40 INFO - 2015-11-23 07:12:40,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57659/tests/kraken/driver.html?testName=json-parse-financial) 07:12:41 INFO - 2015-11-23 07:12:41,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 139956224 07:12:41 INFO - 2015-11-23 07:12:41,491 DEBUG : BROWSER_OUTPUT: 07:12:43 INFO - 2015-11-23 07:12:43,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:43 INFO - 2015-11-23 07:12:43,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 139075584 07:12:43 INFO - 2015-11-23 07:12:43,644 DEBUG : BROWSER_OUTPUT: 07:12:45 INFO - 2015-11-23 07:12:45,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:46 INFO - 2015-11-23 07:12:46,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 140419072 07:12:46 INFO - 2015-11-23 07:12:46,105 DEBUG : BROWSER_OUTPUT: 07:12:48 INFO - 2015-11-23 07:12:48,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:48 INFO - 2015-11-23 07:12:48,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 140804096 07:12:48 INFO - 2015-11-23 07:12:48,783 DEBUG : BROWSER_OUTPUT: 07:12:51 INFO - 2015-11-23 07:12:51,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:51 INFO - 2015-11-23 07:12:51,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 07:12:51 INFO - 2015-11-23 07:12:51,872 DEBUG : BROWSER_OUTPUT: 07:12:54 INFO - 2015-11-23 07:12:54,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:55 INFO - 2015-11-23 07:12:55,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 138870784 07:12:55 INFO - 2015-11-23 07:12:55,043 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57659/tests/kraken/driver.html?testName=ai-astar) 07:12:56 INFO - 2015-11-23 07:12:56,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 07:12:56 INFO - 2015-11-23 07:12:56,983 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,984 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:12:56 INFO - 2015-11-23 07:12:56,984 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:12:56 INFO - 2015-11-23 07:12:56,984 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:12:56 INFO - 2015-11-23 07:12:56,984 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;105;112;109;112;125;111;110;110;110 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;150;157;125;151;155;126;169;126 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;162;162;174;163;161;165;169;160 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;77;72;73;71;153;73;72;74 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;134;91;90;92;148;90;90;130 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;111;110;109;110;111;111;110 07:12:56 INFO - 2015-11-23 07:12:56,985 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;149;146;145;147;147 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;95;96;96;98;97;96;96;97 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;63;65;60;64;60;60;60;59;59 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;70;70;70;69;72;71 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;86;86;84;85;85;85;86;86 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;118;128;116;138;133;119;122;131 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;149;159;151;151;141;148;149;150;152 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;74;69;67;70;67;69;67;67 07:12:56 INFO - 2015-11-23 07:12:56,986 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:12:56 INFO - 2015-11-23 07:12:56,987 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:12:56 INFO - 2015-11-23 07:12:56,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,720 07:12:56 INFO - 2015-11-23 07:12:56,987 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:12:56 INFO - 2015-11-23 07:12:56,987 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291576982__endTimestamp 07:12:56 INFO - 2015-11-23 07:12:56,987 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:5.17 (4.6%) stddev-sans-first:5.46 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: Values: 113.0 105.0 112.0 109.0 112.0 125.0 111.0 110.0 110.0 110.0 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:152.00 stddev:16.76 (11.0%) stddev-sans-first:17.42 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 150.0 157.0 125.0 151.0 155.0 126.0 169.0 126.0 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.28 (2.6%) stddev-sans-first:4.47 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 162.0 162.0 174.0 163.0 161.0 165.0 169.0 160.0 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.20 Median:73.00 stddev:25.28 (34.6%) stddev-sans-first:26.64 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 77.0 72.0 73.0 71.0 153.0 73.0 72.0 74.0 07:12:56 INFO - 2015-11-23 07:12:56,991 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.00 stddev:23.10 (25.7%) stddev-sans-first:23.90 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 134.0 91.0 90.0 92.0 148.0 90.0 90.0 130.0 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 111.0 110.0 109.0 110.0 111.0 111.0 110.0 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 149.0 146.0 145.0 147.0 147.0 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:0.88 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 95.0 96.0 96.0 98.0 97.0 96.0 96.0 97.0 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:2.13 (3.5%) stddev-sans-first:2.26 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 65.0 60.0 64.0 60.0 60.0 60.0 59.0 59.0 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,992 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 70.0 70.0 70.0 69.0 72.0 71.0 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:0.71 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 86.0 86.0 84.0 85.0 85.0 85.0 86.0 86.0 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:7.23 (5.7%) stddev-sans-first:7.52 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 118.0 128.0 116.0 138.0 133.0 119.0 122.0 131.0 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.50 stddev:4.58 (3.0%) stddev-sans-first:4.66 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: Values: 146.0 149.0 159.0 151.0 151.0 141.0 148.0 149.0 150.0 152.0 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.22 (3.2%) stddev-sans-first:2.35 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 74.0 69.0 67.0 70.0 67.0 69.0 67.0 67.0 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:12:56 INFO - 2015-11-23 07:12:56,993 DEBUG : BROWSER_OUTPUT: 07:12:57 INFO - 2015-11-23 07:12:57,842 INFO : Browser exited with error code: 0 07:12:57 INFO - 2015-11-23 07:12:57,892 INFO : Completed test kraken (00:00:59) 07:12:57 INFO - 2015-11-23 07:12:57,892 INFO : Starting test v8_7 07:12:57 INFO - 2015-11-23 07:12:57,892 DEBUG : operating with platform_type : linux_ 07:12:57 INFO - 2015-11-23 07:12:57,892 INFO : Initialising browser for v8_7 test... 07:12:57 INFO - 2015-11-23 07:12:57,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWrubC/profile http://localhost:57659/getInfo.html 07:13:01 INFO - 2015-11-23 07:13:01,942 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:01 INFO - 2015-11-23 07:13:01,942 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:01 INFO - 2015-11-23 07:13:01,942 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:01 INFO - 2015-11-23 07:13:01,942 DEBUG : BROWSER_OUTPUT: __metrics 07:13:02 INFO - 2015-11-23 07:13:02,901 INFO : Browser initialized. 07:13:02 INFO - 2015-11-23 07:13:02,902 INFO : Running cycle 1/1 for v8_7 test... 07:13:02 INFO - 2015-11-23 07:13:02,902 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWrubC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:14 INFO - 2015-11-23 07:13:14,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 139591680 07:13:14 INFO - 2015-11-23 07:13:14,619 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,022 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57659/tests/v8_7/run.html (next: http://localhost:57659/tests/v8_7/run.html) 07:13:36 INFO - 2015-11-23 07:13:36,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 07:13:36 INFO - 2015-11-23 07:13:36,272 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: |0;Richards;166.9727834362999 07:13:36 INFO - 2015-11-23 07:13:36,274 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.82870022539444 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.3476310625175 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1070.6638115631692 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |5;Earley;710.2272727272727 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |7;RegExp;27702.702702702703 07:13:36 INFO - 2015-11-23 07:13:36,275 DEBUG : BROWSER_OUTPUT: |8;Splay;568.1818181818181 07:13:36 INFO - 2015-11-23 07:13:36,276 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 07:13:36 INFO - 2015-11-23 07:13:36,276 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:13:36 INFO - 2015-11-23 07:13:36,276 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291616273__endTimestamp 07:13:36 INFO - 2015-11-23 07:13:36,276 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,276 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: Values: 167.0 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.83 Median:187.83 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: Values: 187.8 07:13:36 INFO - 2015-11-23 07:13:36,277 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,278 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.35 Median:280.35 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,278 DEBUG : BROWSER_OUTPUT: Values: 280.3 07:13:36 INFO - 2015-11-23 07:13:36,278 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: Values: 5040.2 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1070.66 Median:1070.66 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: Values: 1070.7 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,279 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:710.23 Median:710.23 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: Values: 710.2 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: Values: 12192.8 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27702.70 Median:27702.70 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: Values: 27702.7 07:13:36 INFO - 2015-11-23 07:13:36,280 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:568.18 Median:568.18 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: Values: 568.2 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: Values: 4826.9 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:13:36 INFO - 2015-11-23 07:13:36,281 DEBUG : BROWSER_OUTPUT: 07:13:37 INFO - 2015-11-23 07:13:37,141 INFO : Browser exited with error code: 0 07:13:37 INFO - 2015-11-23 07:13:37,156 INFO : Completed test v8_7 (00:00:39) 07:13:37 INFO - 2015-11-23 07:13:37,258 INFO : Completed test suite (00:20:08) 07:13:37 INFO - 2015-11-23 07:13:37,258 DEBUG : Working with test: dromaeo_css 07:13:37 INFO - 2015-11-23 07:13:37,258 DEBUG : Generating results file: dromaeo_css 07:13:37 INFO - 2015-11-23 07:13:37,259 DEBUG : Working with test: kraken 07:13:37 INFO - 2015-11-23 07:13:37,259 DEBUG : Generating results file: kraken 07:13:37 INFO - 2015-11-23 07:13:37,260 INFO : javascript benchmark 07:13:37 INFO - 2015-11-23 07:13:37,260 DEBUG : Working with test: v8_7 07:13:37 INFO - 2015-11-23 07:13:37,260 DEBUG : Generating results file: v8_7 07:13:37 INFO - 2015-11-23 07:13:37,260 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:37 INFO - 2015-11-23 07:13:37,348 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:13:37 INFO - 2015-11-23 07:13:37,348 DEBUG : process_Request line: dromaeo_css 7013.43 graph.html#tests=[[72,1,43]] 07:13:37 INFO - 2015-11-23 07:13:37,348 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:37 INFO - 2015-11-23 07:13:37,386 DEBUG : process_Request line: kraken 1517.20 graph.html#tests=[[232,1,43]] 07:13:37 INFO - 2015-11-23 07:13:37,386 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:13:37 INFO - 2015-11-23 07:13:37,419 DEBUG : process_Request line: v8_7 21384.27 graph.html#tests=[[230,1,43]] 07:13:37 INFO - 2015-11-23 07:13:37,421 INFO : javascript benchmark 07:13:37 INFO - 2015-11-23 07:13:37,424 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.7164355208033, 3224.065021143867, 3244.5782048333713, 3274.999999999999, 3281.097698133013, 5262.500062494057, 5309.256704061435, 5367.329083864517, 5367.543758780504, 5414.269073675053, 5366.302380690505, 5375.274337964373, 5383.865403364918, 5387.649802762818, 5449.754761035753, 4897.657163998504, 4974.427940786802, 4979.352684151056, 4991.475895031024, 4997.575206107485, 4893.266010098496, 5033.6728112672745, 5070.923936140943, 5074.8731281718065, 5123.513266239701, 4810.639202059842, 4861.2222044473065, 4917.975410122962, 4947.084789313988, 5046.142155833517, 4958.479359667219, 4960.404751429815, 4970.850874473772, 4973.52751488608, 5013.849584512471, 4892.21724524078, 4899.314096026559, 4901.411830580318, 4959.330490383788, 5010.023045506127, 5175.585953123741, 5192.844214673566, 5207.036698210805, 5208.5312321891215, 5272.367315922075, 5834.562407819388, 5876.647401155944, 5880.117982302646, 5882.882342353172, 5915.231019967419, 5758.021136406821, 5942.7920022799, 5945.791897283618, 5956.047032474827, 5971.104334349839, 5443.101888188444, 5467.316585426862, 5480.835574932758, 5483.917741233885, 5560.165975103767, 5891.587588868738, 5906.291245050621, 5921.644701317935, 5958.523318134538, 5960.4635582797755, 5630.746616402272, 5730.570207234474, 5750.942490575125, 5790.565707571949, 5790.971045144747, 5828.067509198508, 5928.940710592925, 5944.167816505693, 5957.046872500379, 5957.285125784847, 5881.147233651182, 5897.498712609477, 5907.4683278505145, 5924.911126333109, 5928.584999050111, 5531.7234138293725, 5756.1653560233535, 5756.510696590753, 5758.654480731169, 5898.292204935436, 4428.6678499112695, 4504.662150338738, 4507.301368287921, 4549.3176023596725, 4551.135284295973, 4033.9193216135513, 4061.147159096564, 4063.512378514538, 4113.218488487178, 4124.8143833527565, 5397.649152805055, 5643.971780141073, 5651.321841379061, 5671.773129074873, 5678.4605462480995, 5679.772809087673, 5708.571857110734, 5757.395473475309, 5760.539156867524, 5842.707864606753, 5585.413531579125, 5655.406182350876, 5659.8019069333195, 5670.347909990404, 5694.345150307685, 4911.607071434277, 4973.751312434364, 4980.601551875841, 5010.5240002199735, 5052.494750524992, 5859.150423188614, 5944.078667806497, 6006.789762358297, 6092.390760923872, 6144.047672610842, 5819.476247137609, 5835.241418615553, 5836.824895253149, 5858.091995740497, 5906.320773111147, 5916.408359164049, 5987.6108052976415, 5989.341172471112, 5993.3706960768495, 5997.370276121119, 5637.943620563742, 5723.370429252695, 5746.166805813217, 5750.367459579526, 5886.23478947734, 5801.129830525455, 5813.215215945962, 5825.883482330414, 5845.1232315153065, 5919.556033297434, 5636.520895723909, 5647.322321321303, 5669.3480249770155, 5704.058830293121, 5704.572157088152, 5568.9443105568425, 5582.106862901916, 5636.943630563642, 5678.716064196857, 5769.653820770767, 5548.167774833807, 5651.547876169814, 5673.517750991212, 5691.345495268097, 5694.0, 5498.3127109111365, 5718.914216286842, 5731.0, 5743.827685169452, 5753.539716822728, 5440.891182176413, 5513.0, 5522.447755224445, 5530.838523909863, 5582.246396736388], "unit": "ms", "name": "dojo.html", "value": 5377.100267343945}, {"lowerIsBetter": false, "replicates": [561.2085560998802, 601.2844714789401, 605.4974371271845, 611.6605284067343, 612.2836281550585, 36457.088572785695, 37355.43966840499, 37402.251954960884, 37433.25133497328, 37659.43510847333, 40724.18551628965, 41246.0, 41263.17473650532, 41333.0, 41404.17191656165, 8622.0, 8815.823683526325, 8819.823603527926, 8826.691065812698, 8850.645974161025, 8593.871091933595, 8658.134186581323, 8688.218060374566, 8691.304695624367, 8703.216710496054, 8659.437136586102, 8721.084286149926, 8736.388452808305, 8741.213290803826, 8764.386492945465, 8636.827263454727, 8729.301655867579, 8737.868931966026, 8767.167119123706, 8767.254783343424, 8497.405181637288, 8610.483370997761, 8625.69810056645, 8633.481991080555, 8635.136486351315, 38342.0, 38504.80747596244, 38775.22449550993, 38814.805925970475, 38832.0, 3119.9844000780076, 3120.9063728088195, 3131.5928929239053, 3269.75476839238, 3482.95511346595, 29044.27389315263, 29586.852065739535, 29634.25914352137, 29762.702372976426, 30811.537826932614, 3895.357266051098, 3897.395903634941, 3970.4441378207075, 3999.1002024544537, 4107.8973025674295, 259141.0, 260994.0, 263194.0, 263370.0, 267282.9999999981, 54439.72780136074, 54602.453975459735, 54813.451865480834, 54966.725166374716, 55723.72138139283, 65644.0, 66418.33581664122, 66924.6653766728, 66944.6652766733, 67079.32920670828, 15475.226238688245, 15724.60688482797, 15823.0, 15824.68350632981, 15871.603209919613, 11881.584144555072, 11893.70265743346, 11901.821472677917, 11979.28124312544, 12004.819927701092, 18921.24315027411, 19198.328058517884, 19223.807761922482, 19290.22839086449, 19355.61288774245, 7583.696652133853, 7731.420143489261, 7773.92226077732, 7786.688532458638, 7863.803404914808, 938.5964035464816, 956.3305686019675, 961.7932144588947, 1041.3699711674478, 1072.6460268111505, 27704.0, 27826.652004399006, 28266.85866570654, 28269.01058462985, 28430.71569284322, 999.1856636841096, 1005.7988402319419, 1063.4948399510326, 1099.8350247462783, 1142.714321419645, 14644.633884152981, 14679.192644404447, 14820.184889831164, 14913.776293355608, 15024.17367044823, 308962.0, 314731.0, 314964.0, 314989.0, 315078.0, 50774.74612626987, 51042.48957510452, 51072.233916491285, 51240.23139652908, 51345.743271283405, 1272.41699350319, 1357.5723647051148, 1365.474292397434, 1368.103891950774, 1370.280602683599, 27076.45847083087, 27620.30949226205, 27848.0, 27892.860535697193, 28120.43759124765, 44156.55843441653, 44303.33544996892, 44496.77751611221, 44659.33011004903, 44914.0, 285940.0, 286883.0, 287600.0, 289418.0, 289702.0, 31201.84399078081, 31635.0, 31732.365352692355, 31823.363532728752, 32484.0, 39135.0, 40922.386164208154, 42041.15917681568, 42395.0, 42476.15047699091, 35184.64815351814, 35309.823450882584, 35545.82227088848, 35679.46480802842, 35942.640573594974, 34612.82693586516, 35444.0, 35593.0, 35609.0, 35725.821370892976, 34975.12562185864, 35018.4981501858, 35152.296954060264, 35179.120521987155, 35395.93812185639, 29372.0, 30555.0, 30904.845475772476, 31405.371892562478, 33072.834635826664, 24563.263102106965, 24743.752562474863, 25273.241802745946, 25401.237962861145, 25408.74591254064], "unit": "ms", "name": "ext.html", "value": 18295.348752126567}, {"lowerIsBetter": false, "replicates": [363.10494630735235, 363.81809095452275, 366.6205477330963, 366.63519797801194, 367.75360508459363, 16472.423465178723, 16961.491155265332, 17455.214515346823, 17760.111994400293, 18422.723659145122, 10928.125749940005, 11971.940140299308, 15287.235638218073, 15324.846751532481, 15328.693426131471, 4769.236922092466, 5143.0, 5265.842024739264, 5267.078261304276, 5267.815626453075, 5376.784928602851, 5390.245365648812, 5415.0523658359825, 5425.26758887551, 5649.378568357477, 3643.198496330803, 3791.791451470168, 5331.360236771573, 5940.0, 6025.0, 5418.972905135449, 5442.074847275972, 5447.237386765856, 5458.235846981426, 5471.534919531845, 5186.7147306898105, 5242.895142097175, 5274.472552744734, 5348.973255133699, 5357.598180136466, 12296.569620063256, 12482.937585312106, 12536.059795515373, 16496.917515412348, 20104.69842952357, 1925.3165126380213, 1940.0590713503939, 1948.1038722187811, 1992.1135094882784, 2032.7459067616549, 9375.578098985561, 9400.482973436527, 9428.905710942872, 9583.281253905985, 9595.28035397341, 1832.230463205457, 1857.9535511612182, 1894.393793985925, 1909.8472122230328, 1910.9331173409003, 56467.43532564663, 59789.40210597882, 59954.400455995754, 60411.697941510014, 61251.0, 9971.700848974542, 10215.438150901624, 10384.273100882865, 10389.272750907516, 10394.22043346752, 13403.93298033523, 13430.93284533571, 13437.865621343857, 13460.865391346157, 13465.932670336586, 7710.730124445729, 7730.613469326511, 7731.922680773233, 7736.032995875516, 7772.18392068836, 7544.471886967969, 7559.28186822251, 7566.772996810105, 7595.696172153052, 7620.542767433972, 4349.586789255016, 4350.934735978963, 4369.497507786582, 4381.605655491021, 4396.978015109904, 1689.7887764029497, 1708.863290936722, 1817.1459414075364, 1853.8238867307584, 1857.2570971611194, 909.5952301226023, 911.8996910339857, 933.9766505837408, 989.9257555683208, 999.160705007797, 16948.0, 17028.33393278162, 17034.82965170357, 17143.914280428766, 17381.739273910902, 912.3112050401904, 924.5977999570208, 936.4100616611491, 944.2587568758491, 984.2913102566141, 9958.900410995942, 9988.800223995479, 10007.14939230159, 10043.0, 10079.193664506822, 529813.0, 536079.0, 538747.0, 539890.0, 544684.0, 71157.28842711507, 73726.0, 73980.26019739841, 74644.0, 75107.62446187733, 1092.1481244629201, 1102.189890430549, 1121.7083558274744, 1125.7579620381657, 1132.394169119517, 15191.0, 15363.0, 15387.846121538641, 15480.225988700295, 15832.762508562151, 33791.4931276036, 33857.0, 34330.0, 34759.652403475644, 34946.126346841535, 44101.77949110234, 44396.55603444053, 44827.0, 45094.77452612716, 47798.76100619475, 9471.0, 9532.761680958032, 9610.615575376907, 9618.711438656852, 9622.951885240529, 16084.839151608334, 16695.833041669426, 17323.393681221096, 17396.0, 17447.214875330894, 13349.733005340033, 13514.391852366864, 13759.38082786257, 14182.716345673236, 14259.572212833631, 14200.0, 14255.572332830032, 14471.204083775494, 14515.0, 15024.624384390041, 14108.0, 14210.786838197642, 14661.70676586441, 15024.7980161589, 15144.621384465476, 9213.953930230306, 9611.663591774255, 9630.951845240728, 9967.50162491887, 9969.601215951281, 10088.69733907984, 12572.685682858002, 14255.928720356333, 14423.78364324515, 15007.399704011717], "unit": "ms", "name": "jquery.html", "value": 8705.793329442959}, {"lowerIsBetter": false, "replicates": [1470.2207829850179, 1522.9771553426697, 1595.840415958405, 1657.1548510259772, 1759.296281487404, 7724.652390642421, 7760.0, 7838.764837054883, 8025.117237103914, 8040.155783642721, 7708.498947568404, 7720.4209684273765, 7725.266099720531, 7727.0, 7791.688332466694, 2197.63738983068, 2237.0827960536185, 2242.573910956913, 2245.079517397867, 2245.438640339915, 2201.3175915466177, 2246.9101235950543, 2249.5051088760447, 2262.3552287598036, 2266.6939963104933, 2092.937211883646, 2095.9790402096014, 2229.4314949687805, 2265.7394399644004, 2277.146070223666, 2149.2692484555328, 2173.9456513587206, 2251.1558165687866, 2251.594712951668, 2255.2783109404995, 2282.7831356021316, 2284.223364056212, 2298.5517824024323, 2302.033146078634, 2309.2956648222284, 7693.692252309901, 7738.187490313492, 7763.417743669191, 7764.340031097364, 7821.960890195513, 4777.737224452654, 4834.468208497063, 4869.780859861315, 4873.537013983701, 4876.341693871317, 3127.718505334508, 3134.5298205269164, 3193.425183466975, 3228.951565726516, 3255.039763269841, 1003.1924300937742, 1006.788574399377, 1934.8935808530666, 1955.9119839607251, 1961.9215231390726, 10528.526216320284, 10601.31091479059, 10611.893881061167, 10617.0, 10619.628313009085, 4137.91724165515, 4182.644475219579, 4279.40088387626, 4306.095719898856, 4313.137372525507, 8665.870011949826, 8723.956380218058, 8729.127087291221, 8737.694180703646, 8747.256483198998, 4731.503192164842, 4735.384400027974, 4741.099191153669, 4752.881177970578, 4756.904861902743, 4370.431843860341, 4375.584319489643, 4389.4513185851765, 4406.162829062468, 4411.867643970686, 3495.4407294832704, 3556.28874225156, 3561.1097225693575, 3568.6966607838103, 3580.1407662160896, 1098.752780624369, 1100.2463312630873, 1106.2919731371928, 1123.7920984617872, 1124.0670243697875, 915.6383228624655, 946.5125460387906, 1085.5820509103894, 1143.8512993310817, 1346.0577595683062, 7279.563226206445, 7379.3358597726465, 7399.223081576464, 7425.591592462466, 7445.329920307198, 578.780063575847, 598.7784519727728, 599.4005994005994, 602.3614968133704, 752.2815710995985, 5659.434056594308, 5736.1682556029145, 5737.942620573825, 5751.884962300815, 5759.164921086419, 9126.13301736334, 9264.073592640816, 9358.391704539183, 9484.57319420614, 9595.328327017181, 9295.67465138717, 9364.297677674065, 9382.718518444457, 9386.20217281525, 9479.573419196153, 7278.344948954514, 7302.452316076316, 7366.189719130892, 7406.777796666109, 7414.480986330905, 6835.58986460814, 6862.176538815374, 6877.449804015767, 6886.2769409213315, 6894.551854129466, 8025.678972841021, 8276.627551760306, 8324.125966773401, 8326.168242986534, 8455.577221138796, 8520.062793092879, 8581.056083830648, 8588.312934965314, 8590.65637374523, 8602.0, 6526.9347306528225, 6554.14796076507, 6555.639439830855, 6559.0817285581015, 6570.408663220333, 7448.8882666758955, 7499.550026998398, 7527.924720752722, 7530.397568194422, 7539.170691224071, 6922.619255940972, 6942.479314051568, 7090.822729431806, 7171.4621403395995, 7251.709931602888, 6962.3037696231995, 6973.965130174317, 6976.19773726028, 6996.685149168198, 7022.12223472066, 7088.0785497884945, 7107.040549525955, 7121.67952442131, 7124.928750712426, 7138.143422789299, 6512.153420055362, 6548.1487406638735, 6552.0, 6561.639109849004, 6562.967185164234, 6414.839629009125, 6423.743050277936, 6458.773942911976, 6483.578567393104, 6545.967270163619], "unit": "ms", "name": "mootools.html", "value": 4451.145736500893}, {"lowerIsBetter": false, "replicates": [321.8181727324062, 324.8343344894103, 327.8196991654589, 330.35580617795307, 334.01299160979306, 6343.587666801661, 6351.9682401587925, 6352.587081839677, 6363.109164716943, 6376.776812811552, 6195.783147589824, 6303.149074874902, 6321.6207027578375, 6326.367363263671, 6339.049142628596, 4777.832775852838, 4801.8079276828885, 4805.663603547753, 4806.4712881583, 4809.7835597398025, 4760.285957106445, 4787.425508938914, 4793.472718001034, 4801.687890287138, 4816.614670826343, 4685.672002959795, 4755.644641277237, 4762.85691434055, 4763.26169443735, 4775.379200703904, 4729.196036673757, 4740.099381117611, 4756.738379389132, 4758.310045043484, 4758.690685105475, 4101.077257617012, 4111.60939710727, 4111.958880411187, 4121.5466298707115, 4124.896877578055, 5971.641701497924, 5984.461398474158, 5986.2517185351835, 5990.281166260033, 6007.699615019232, 5402.78388864445, 5531.0873705838485, 5540.972295138498, 5543.944560554383, 5548.389677135512, 6699.0, 6701.1623547056615, 6705.094812200339, 6707.3628005339415, 6733.192016957947, 4581.129585378767, 4585.931211031804, 4590.563896429867, 4593.701409408378, 4605.861824145281, 6823.0, 6980.220043888827, 6991.965040174818, 6996.510244282902, 6996.7201311947465, 4663.48701642819, 4681.95318046822, 4687.718736875799, 4694.131585656664, 4698.083873644607, 4747.8100875965265, 4753.6910100844025, 4758.024604956045, 4760.666753327234, 4793.784279707422, 5555.555555555546, 5557.194206840067, 5557.44425557441, 5557.972210139004, 5571.526420254243, 6662.800115996528, 6740.797776066725, 6770.086038384854, 6772.69522871472, 6782.525223234326, 1608.5978505373657, 1629.299401257447, 1631.0702899347496, 1634.534157765055, 1693.6866679664302, 1080.783843231341, 1097.5938902605926, 1111.8999290063932, 1117.580907159815, 1121.6130434999911, 6379.96810015947, 6381.457576106083, 6444.967775161094, 6465.612063276219, 6500.382463665944, 6825.2833452486775, 6845.281245469254, 6881.449484041264, 6890.069840571458, 6913.446924246149, 6353.052887706386, 6386.36136386367, 6415.775447859302, 6471.579347342407, 6479.5788273762055, 3740.625937406292, 3774.735768496179, 3779.3952967525065, 3782.127846715838, 3784.7729136251914, 7132.1441427029085, 7162.641867906584, 7169.89245161323, 7199.820004499929, 7205.639718014078, 6998.75504357345, 7085.610291433917, 7110.857782844314, 7126.714931402789, 7146.785596432115, 7123.857522849617, 7145.785626431215, 7161.248068952789, 7164.104486939133, 7190.964045179845, 6872.381485666314, 6906.102206713095, 6909.136357955255, 6915.377616014583, 6933.37599616037, 6696.899546506709, 6812.455003599799, 6823.4882383822405, 6826.249112597709, 6834.521583489108, 7098.893516597358, 7120.8219794503475, 7140.571565705866, 7156.033935418652, 7159.069320988447, 4566.0, 4574.199515084781, 4591.449026116754, 4596.034832685174, 4596.540345965377, 6787.287334829772, 6888.931110688829, 6889.965550172217, 6906.205786334636, 6917.654117294216, 6710.731570737116, 6716.227633821977, 6718.865622687421, 6722.495812813961, 6722.563033402813, 6637.203535575762, 6669.633170175687, 6669.933300666931, 6686.866262674816, 6709.698063587052, 6457.192850893638, 6548.705308261045, 6596.274409815012, 6599.4390476808085, 6604.075429439787, 6679.0, 6705.362990515893, 6730.360615741497, 6738.090357801634, 6739.0902228198565, 6520.934790652223, 6522.771702990372, 6564.934350656432, 6578.8355291118105, 6586.341365863375], "unit": "ms", "name": "prototype.html", "value": 5014.107358793333}, {"lowerIsBetter": false, "replicates": [840.3613253927016, 848.3340577646541, 848.65205265841, 854.4574195385928, 877.140402405642, 13400.061995660295, 13642.522511712092, 13718.451261949522, 13736.725265494684, 13823.101498402597, 12516.186447880882, 12641.747165056693, 14643.341049652765, 15076.170810605412, 15079.0, 790.490133863659, 807.2371608829658, 807.9030516338019, 808.8463191993532, 811.0105671081271, 804.5454318310166, 806.6853926968457, 811.5130921447144, 814.9062857771373, 815.2581151152452, 847.1189962439056, 847.1401527449643, 851.1403482482706, 854.3293514591047, 855.1234984141242, 839.4333824668386, 843.241083025276, 844.4089137603702, 848.1476116502876, 850.2262940723912, 616.8457885528618, 621.183144165421, 622.7820262907991, 624.4286477872741, 625.7278084033414, 13390.129641573267, 13530.661733456644, 13598.93200533991, 13713.588592342247, 13748.106373085717, 11641.41792910351, 11738.765224695459, 11856.288622682667, 12228.388580570936, 12618.55835045769, 10345.275830691855, 10378.0, 10402.167826573932, 10542.209334299958, 10713.678589642323, 3532.6467353264725, 3554.5023696682483, 3560.6439356064448, 3630.001749518877, 3639.9272014559824, 48444.75777621125, 48639.0, 48808.511914881106, 48974.51025489735, 49387.01225975496, 9483.66807161746, 9619.374740641835, 9710.765479717655, 9838.606455741834, 9862.112409883144, 17502.124893755517, 17512.29950801979, 17523.561910952074, 17541.122943852755, 17550.122493875257, 7290.198078211392, 7319.121705395387, 7335.0, 7382.040334756447, 7557.4331925105835, 4209.91580168401, 4225.471816022997, 4248.4477017987465, 4291.957080429156, 4309.956900430955, 3074.8923787667322, 3099.1632259289863, 3100.90697279082, 3105.0, 3110.6578276389578, 533.1522878622931, 547.6495043172373, 550.070381056022, 552.078029690418, 559.9468050535193, 609.9512039036866, 620.2990620598695, 626.6177631644694, 634.8539835837784, 640.6600980824877, 7097.361237488651, 7179.928200717926, 7229.638518074075, 7336.082989626297, 7500.812479687942, 544.1375419959409, 589.0137005382754, 613.8557439001831, 630.7508534128993, 652.8792173447928, 3500.387432199406, 3763.9435408468894, 3765.0963768695315, 3788.962110378916, 3863.671587915059, 58027.41972580305, 59153.0, 59488.10767838486, 59585.106223406685, 59730.70134649299, 41278.79360603178, 49587.752061240186, 50285.24572131421, 50675.7466212674, 50734.492655073715, 42058.369124463155, 45242.0, 45421.31868021916, 45833.0, 46124.30813537799, 7957.0, 8067.273945344947, 8363.581820909052, 8439.367047471342, 8455.534945578052, 34737.47893781646, 34865.47701784526, 35094.82452587721, 35264.64735352614, 35291.823540882135, 42471.0, 42558.78720606501, 46462.0, 46748.29877551908, 48220.7588962053, 10107.848382274418, 10145.797084058426, 10462.529186186792, 10783.514741836792, 11140.944295278472, 11641.6507504775, 11915.2255103418, 11952.342621155572, 12913.289769062792, 12943.417546210632, 10651.89348106509, 11048.558057677603, 11526.308421494738, 11600.0, 11930.76138477243, 11583.6524904253, 11671.0, 11836.408179591159, 12348.320842353398, 12352.691182720504, 11219.1024718024, 11290.830637540279, 11410.94294528522, 11622.053535756957, 11742.354170520703, 8922.509261990654, 9007.909920900707, 9117.225035872025, 9287.582058807506, 9314.673986410444, 8474.61864216124, 8966.68616598416, 8989.0, 10009.799804004026, 10054.798904021733], "unit": "ms", "name": "yui.html", "value": 6225.617244216471}], "name": "dromaeo_css", "value": 7013.427371961799}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 112.0, 109.0, 112.0, 125.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 150.0, 157.0, 125.0, 151.0, 155.0, 126.0, 169.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 174.0, 163.0, 161.0, 165.0, 169.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 72.0, 73.0, 71.0, 153.0, 73.0, 72.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 134.0, 91.0, 90.0, 92.0, 148.0, 90.0, 90.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 110.0, 109.0, 110.0, 111.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 149.0, 146.0, 145.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 65.0, 60.0, 64.0, 60.0, 60.0, 60.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 72.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 86.0, 86.0, 84.0, 85.0, 85.0, 85.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 118.0, 128.0, 116.0, 138.0, 133.0, 119.0, 122.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 159.0, 151.0, 151.0, 141.0, 148.0, 149.0, 150.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 74.0, 69.0, 67.0, 70.0, 67.0, 69.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1517.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [187.82870022539444], "unit": "score", "name": "DeltaBlue", "value": 352.01223200000004}, {"lowerIsBetter": false, "replicates": [280.3476310625175], "unit": "score", "name": "Encrypt", "value": 949.4676269999999}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1070.6638115631692], "unit": "score", "name": "RayTrace", "value": 691.1497260000002}, {"lowerIsBetter": false, "replicates": [710.2272727272727], "unit": "score", "name": "Earley", "value": 938.3799039999997}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [27702.702702702703], "unit": "score", "name": "RegExp", "value": 32.88433658536587}, {"lowerIsBetter": false, "replicates": [568.1818181818181], "unit": "score", "name": "Splay", "value": 143.42415999999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21384.274379327402}]} 07:13:37 INFO - RETURN: dromaeo_css: 7013.43 07:13:37 INFO - RETURN: kraken: 1517.20 07:13:37 INFO - RETURN: v8_7: 21384.27 07:13:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21384.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1517.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7013.43"}}} 07:13:37 INFO - Return code: 0 07:13:37 INFO - # TBPL SUCCESS # 07:13:37 INFO - Running post-action listener: _resource_record_post_action 07:13:37 INFO - Running post-run listener: _resource_record_post_run 07:13:38 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 523616256; Read time: 0; Write time: 448560 07:13:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 228675584; Read time: 0; Write time: 266540 07:13:38 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 290988032; Read time: 0; Write time: 181216 07:13:38 INFO - Running post-run listener: _upload_blobber_files 07:13:38 INFO - Blob upload gear active. 07:13:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:13:38 INFO - Copying logs to upload dir... 07:13:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.656174 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-23 07:13:38.073801) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:38.077649) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009983 build_url: 'https://queue.taskcluster.net/v1/task/tN1Vpl1qTAWhMzTte2gNJQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:38.129240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:38.129692) ========= 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=6587686cb2da90a5f91b3170000001be-1448289230.620244-181992942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:13:38.180420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:13:38.180778) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:13:38.181126) ========= ========= Total master_lag: 0.21 =========