builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1453403617.5 results: success (0) buildid: 20160121084622 builduid: ee8132ddca664ba6ae16769ae49bcf78 revision: 737f3b6e93c64099d651f7805dc61121250c73c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.503050) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.503553) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.503885) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005670 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.595773) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.596245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.610187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.610504) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.660480) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.660818) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.661311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.661623) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:13:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 152M=0s 2016-01-21 11:13:38 (152 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153662 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.828295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:37.828697) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014182 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.045588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.045994) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 737f3b6e93c64099d651f7805dc61121250c73c0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 737f3b6e93c64099d651f7805dc61121250c73c0 --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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:13:38,941 truncating revision to first 12 chars 2016-01-21 11:13:38,941 Setting DEBUG logging. 2016-01-21 11:13:38,941 attempt 1/10 2016-01-21 11:13:38,941 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/737f3b6e93c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:13:39,481 unpacking tar archive at: mozilla-aurora-737f3b6e93c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.848863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.911164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.911981) ========= echo 737f3b6e93c64099d651f7805dc61121250c73c0 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'737f3b6e93c64099d651f7805dc61121250c73c0'] 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 737f3b6e93c64099d651f7805dc61121250c73c0 program finished with exit code 0 elapsedTime=0.004651 script_repo_revision: '737f3b6e93c64099d651f7805dc61121250c73c0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.964416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.964785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:13:38.975514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-21 11:13:38.975831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:39 INFO - MultiFileLogger online at 20160121 11:13:39 in /builds/slave/test-pgo 11:13:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:13:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:13:39 INFO - {'append_to_log': False, 11:13:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:13:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:13:39 INFO - 'branch': 'Mozilla-Aurora', 11:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:39 INFO - 'config_files': ('talos/linux_config.py',), 11:13:39 INFO - 'default_actions': ('clobber', 11:13:39 INFO - 'read-buildbot-config', 11:13:39 INFO - 'download-and-extract', 11:13:39 INFO - 'populate-webroot', 11:13:39 INFO - 'create-virtualenv', 11:13:39 INFO - 'install', 11:13:39 INFO - 'run-tests'), 11:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:39 INFO - 'download_minidump_stackwalk': True, 11:13:39 INFO - 'download_symbols': 'ondemand', 11:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:39 INFO - 'installer_path': 'installer.exe', 11:13:39 INFO - 'log_level': 'info', 11:13:39 INFO - 'log_name': 'talos', 11:13:39 INFO - 'log_to_console': True, 11:13:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:39 INFO - 'opt_config_files': (), 11:13:39 INFO - 'pip_index': False, 11:13:39 INFO - 'sps_profile': False, 11:13:39 INFO - 'sps_profile_interval': 0, 11:13:39 INFO - 'suite': 'dromaeojs-e10s', 11:13:39 INFO - 'system_bits': '32', 11:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:39 INFO - 'title': 'talos-linux64-ix-049', 11:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:39 INFO - 'use_talos_json': True, 11:13:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:39 INFO - 'work_dir': 'build'} 11:13:39 INFO - ##### 11:13:39 INFO - ##### Running clobber step. 11:13:39 INFO - ##### 11:13:39 INFO - Running pre-action listener: _resource_record_pre_action 11:13:39 INFO - Running main action method: clobber 11:13:39 INFO - rmtree: /builds/slave/test-pgo/build 11:13:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:13:40 INFO - Running post-action listener: _resource_record_post_action 11:13:40 INFO - ##### 11:13:40 INFO - ##### Running read-buildbot-config step. 11:13:40 INFO - ##### 11:13:40 INFO - Running pre-action listener: _resource_record_pre_action 11:13:40 INFO - Running main action method: read_buildbot_config 11:13:40 INFO - Using buildbot properties: 11:13:40 INFO - { 11:13:40 INFO - "properties": { 11:13:40 INFO - "buildnumber": 98, 11:13:40 INFO - "product": "firefox", 11:13:40 INFO - "script_repo_revision": "production", 11:13:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:13:40 INFO - "repository": "", 11:13:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:13:40 INFO - "buildid": "20160121084622", 11:13:40 INFO - "slavename": "talos-linux64-ix-049", 11:13:40 INFO - "pgo_build": "True", 11:13:40 INFO - "basedir": "/builds/slave/test-pgo", 11:13:40 INFO - "project": "", 11:13:40 INFO - "platform": "ubuntu64_hw", 11:13:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:13:40 INFO - "slavebuilddir": "test", 11:13:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:13:40 INFO - "branch": "mozilla-aurora", 11:13:40 INFO - "repo_path": "releases/mozilla-aurora", 11:13:40 INFO - "stage_platform": "linux64-pgo", 11:13:40 INFO - "builduid": "ee8132ddca664ba6ae16769ae49bcf78", 11:13:40 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:13:40 INFO - }, 11:13:40 INFO - "sourcestamp": { 11:13:40 INFO - "repository": "", 11:13:40 INFO - "hasPatch": false, 11:13:40 INFO - "project": "", 11:13:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:13:40 INFO - "changes": [ 11:13:40 INFO - { 11:13:40 INFO - "category": null, 11:13:40 INFO - "files": [ 11:13:40 INFO - { 11:13:40 INFO - "url": null, 11:13:40 INFO - "name": "https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:13:40 INFO - } 11:13:40 INFO - ], 11:13:40 INFO - "repository": "", 11:13:40 INFO - "rev": "737f3b6e93c64099d651f7805dc61121250c73c0", 11:13:40 INFO - "who": "kcambridge@mozilla.com", 11:13:40 INFO - "when": 1453403237, 11:13:40 INFO - "number": 7494755, 11:13:40 INFO - "comments": "Bug 1234054 - Only enable service worker notifications on Desktop and non-release B2G/Android. r=ehsan; a=sylvestre", 11:13:40 INFO - "project": "", 11:13:40 INFO - "at": "Thu 21 Jan 2016 11:07:17", 11:13:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:13:40 INFO - "revlink": "", 11:13:40 INFO - "properties": [ 11:13:40 INFO - [ 11:13:40 INFO - "buildid", 11:13:40 INFO - "20160121084622", 11:13:40 INFO - "Change" 11:13:40 INFO - ], 11:13:40 INFO - [ 11:13:40 INFO - "builduid", 11:13:40 INFO - "ee8132ddca664ba6ae16769ae49bcf78", 11:13:40 INFO - "Change" 11:13:40 INFO - ], 11:13:40 INFO - [ 11:13:40 INFO - "pgo_build", 11:13:40 INFO - "True", 11:13:40 INFO - "Change" 11:13:40 INFO - ] 11:13:40 INFO - ], 11:13:40 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:13:40 INFO - } 11:13:40 INFO - ], 11:13:40 INFO - "revision": "737f3b6e93c64099d651f7805dc61121250c73c0" 11:13:40 INFO - } 11:13:40 INFO - } 11:13:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:13:40 INFO - Running post-action listener: _resource_record_post_action 11:13:40 INFO - ##### 11:13:40 INFO - ##### Running download-and-extract step. 11:13:40 INFO - ##### 11:13:40 INFO - Running pre-action listener: _resource_record_pre_action 11:13:40 INFO - Running main action method: download_and_extract 11:13:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:13: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')]} 11:13:40 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json 11:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json 11:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:13:41 INFO - Downloaded 1302 bytes. 11:13:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:13:41 INFO - Using the following test package requirements: 11:13:41 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:13:41 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:13:41 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'jsshell-linux-x86_64.zip'], 11:13:41 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:13:41 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:13:41 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:13:41 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:13:41 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:13:41 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:13:41 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:13:41 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:13:41 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:41 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:13:42 INFO - Downloaded 23159508 bytes. 11:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:13:43 INFO - Return code: 0 11:13:43 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:13:43 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')]} 11:13:43 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:13:44 INFO - Downloaded 23159508 bytes. 11:13:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:13:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:13:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:13:45 INFO - Return code: 0 11:13:45 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')]} 11:13:45 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:13:46 INFO - Downloaded 11132038 bytes. 11:13:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:13:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:13:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:13:46 INFO - Return code: 0 11:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:46 INFO - https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:13:48 INFO - Downloaded 58140726 bytes. 11:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:13:48 INFO - mkdir: /builds/slave/test-pgo/properties 11:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:13:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:13:48 INFO - Contents: 11:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:13:48 INFO - Running post-action listener: _resource_record_post_action 11:13:48 INFO - Running post-action listener: set_extra_try_arguments 11:13:48 INFO - ##### 11:13:48 INFO - ##### Running populate-webroot step. 11:13:48 INFO - ##### 11:13:48 INFO - Running pre-action listener: _resource_record_pre_action 11:13:48 INFO - Running main action method: populate_webroot 11:13:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:48 INFO - '--tppagecycles', 11:13:48 INFO - '7'], 11:13:48 INFO - 'tests': ['tsvgm']}}, 11:13:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:13:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:13:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:13:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'tests': ['damp', 'tps']}, 11:13:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['damp', 'tps']}, 11:13:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:13:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:48 INFO - 'other': {'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'other_l64': {'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'other_nol64': {'tests': ['a11yr', 11:13:48 INFO - 'ts_paint', 11:13:48 INFO - 'tpaint', 11:13:48 INFO - 'sessionrestore', 11:13:48 INFO - 'sessionrestore_no_auto_restore']}, 11:13:48 INFO - 'svgr': {'tests': ['tsvgx', 11:13:48 INFO - 'tsvgr_opacity', 11:13:48 INFO - 'tart', 11:13:48 INFO - 'tscrollx', 11:13:48 INFO - 'cart']}, 11:13:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['tsvgx', 11:13:48 INFO - 'tsvgr_opacity', 11:13:48 INFO - 'tart', 11:13:48 INFO - 'tscrollx', 11:13:48 INFO - 'cart']}, 11:13:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'tests': ['tp5o']}, 11:13:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'talos_options': ['--e10s'], 11:13:48 INFO - 'tests': ['tp5o']}, 11:13:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'talos_options': ['--xperf_path', 11:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:48 INFO - 'tests': ['tp5n']}, 11:13:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:48 INFO - 'talos_options': ['--e10s', 11:13:48 INFO - '--xperf_path', 11:13:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:48 INFO - 'tests': ['tp5n']}}, 11:13:48 INFO - 'talos.zip': {'path': '', 11:13:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:48 INFO - Running post-action listener: _resource_record_post_action 11:13:48 INFO - ##### 11:13:48 INFO - ##### Running create-virtualenv step. 11:13:48 INFO - ##### 11:13:48 INFO - Running pre-action listener: _resource_record_pre_action 11:13:48 INFO - Running main action method: create_virtualenv 11:13:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:13:48 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 11:13:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:13:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:48 INFO - Using real prefix '/usr' 11:13:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:13:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:50 INFO - Installing pip.................done. 11:13:50 INFO - Return code: 0 11:13:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:13: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')]} 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:13:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:13:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:13:50 INFO - Using env: {'DISPLAY': ':0', 11:13:50 INFO - 'HOME': '/home/cltbld', 11:13:50 INFO - 'LANG': 'en_US.UTF-8', 11:13:50 INFO - 'LANGUAGE': 'en_US:en', 11:13:50 INFO - 'LOGNAME': 'cltbld', 11:13:50 INFO - 'MAIL': '/var/mail/cltbld', 11:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:50 INFO - 'MOZ_NO_REMOTE': '1', 11:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:50 INFO - 'NO_EM_RESTART': '1', 11:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:50 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:50 INFO - 'SHELL': '/bin/bash', 11:13:50 INFO - 'SHLVL': '1', 11:13:50 INFO - 'TERM': 'linux', 11:13:50 INFO - 'TMOUT': '86400', 11:13:50 INFO - 'USER': 'cltbld', 11:13:50 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:50 INFO - '_': '/tools/buildbot/bin/python'} 11:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:51 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 11:13:51 INFO - Cleaning up... 11:13:51 INFO - Return code: 0 11:13:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:13:51 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')]} 11:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:51 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')]} 11:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:13:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:13:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:13:51 INFO - Using env: {'DISPLAY': ':0', 11:13:51 INFO - 'HOME': '/home/cltbld', 11:13:51 INFO - 'LANG': 'en_US.UTF-8', 11:13:51 INFO - 'LANGUAGE': 'en_US:en', 11:13:51 INFO - 'LOGNAME': 'cltbld', 11:13:51 INFO - 'MAIL': '/var/mail/cltbld', 11:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:51 INFO - 'MOZ_NO_REMOTE': '1', 11:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:51 INFO - 'NO_EM_RESTART': '1', 11:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:51 INFO - 'SHELL': '/bin/bash', 11:13:51 INFO - 'SHLVL': '1', 11:13:51 INFO - 'TERM': 'linux', 11:13:51 INFO - 'TMOUT': '86400', 11:13:51 INFO - 'USER': 'cltbld', 11:13:51 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:51 INFO - '_': '/tools/buildbot/bin/python'} 11:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:51 INFO - Downloading/unpacking psutil>=0.7.1 11:13:51 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 11:13:51 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 11:13:51 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 11:13:51 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 11:13:51 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 11:13:51 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 11:13:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:53 INFO - Installing collected packages: psutil 11:13:53 INFO - Running setup.py install for psutil 11:13:53 INFO - building 'psutil._psutil_linux' extension 11:13:53 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 11:13:53 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 11:13:53 INFO - building 'psutil._psutil_posix' extension 11:13:53 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 11:13:53 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 11:13:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:53 INFO - Successfully installed psutil 11:13:53 INFO - Cleaning up... 11:13:53 INFO - Return code: 0 11:13:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:13: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')]} 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:13:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:13:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:13:55 INFO - Installing collected packages: mozsystemmonitor 11:13:55 INFO - Running setup.py install for mozsystemmonitor 11:13:55 INFO - Successfully installed mozsystemmonitor 11:13:55 INFO - Cleaning up... 11:13:55 INFO - Return code: 0 11:13:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:13:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:13:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:13:55 INFO - Using env: {'DISPLAY': ':0', 11:13:55 INFO - 'HOME': '/home/cltbld', 11:13:55 INFO - 'LANG': 'en_US.UTF-8', 11:13:55 INFO - 'LANGUAGE': 'en_US:en', 11:13:55 INFO - 'LOGNAME': 'cltbld', 11:13:55 INFO - 'MAIL': '/var/mail/cltbld', 11:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:55 INFO - 'MOZ_NO_REMOTE': '1', 11:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:55 INFO - 'NO_EM_RESTART': '1', 11:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:55 INFO - 'SHELL': '/bin/bash', 11:13:55 INFO - 'SHLVL': '1', 11:13:55 INFO - 'TERM': 'linux', 11:13:55 INFO - 'TMOUT': '86400', 11:13:55 INFO - 'USER': 'cltbld', 11:13:55 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:55 INFO - '_': '/tools/buildbot/bin/python'} 11:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:13:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:58 INFO - Downloading docopt-0.6.1.tar.gz 11:13:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:58 INFO - Running setup.py install for blobuploader 11:13:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:13:58 INFO - Running setup.py install for requests 11:13:58 INFO - Running setup.py install for docopt 11:13:59 INFO - Successfully installed blobuploader requests docopt 11:13:59 INFO - Cleaning up... 11:13:59 INFO - Return code: 0 11:13:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:13:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 11:13:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 11:13:59 INFO - Using env: {'DISPLAY': ':0', 11:13:59 INFO - 'HOME': '/home/cltbld', 11:13:59 INFO - 'LANG': 'en_US.UTF-8', 11:13:59 INFO - 'LANGUAGE': 'en_US:en', 11:13:59 INFO - 'LOGNAME': 'cltbld', 11:13:59 INFO - 'MAIL': '/var/mail/cltbld', 11:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:59 INFO - 'MOZ_NO_REMOTE': '1', 11:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:59 INFO - 'NO_EM_RESTART': '1', 11:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:13:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:13:59 INFO - 'SHELL': '/bin/bash', 11:13:59 INFO - 'SHLVL': '1', 11:13:59 INFO - 'TERM': 'linux', 11:13:59 INFO - 'TMOUT': '86400', 11:13:59 INFO - 'USER': 'cltbld', 11:13:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:59 INFO - '_': '/tools/buildbot/bin/python'} 11:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:13:59 INFO - Running setup.py (path:/tmp/pip-TIlbEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:13:59 INFO - Running setup.py (path:/tmp/pip-8ChtOZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:13:59 INFO - Running setup.py (path:/tmp/pip-bOM2Gc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:13:59 INFO - Running setup.py (path:/tmp/pip-W3XSxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:13:59 INFO - Running setup.py (path:/tmp/pip-NkQYtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:13:59 INFO - Running setup.py (path:/tmp/pip-rWabOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:13:59 INFO - Running setup.py (path:/tmp/pip-ZtTGBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:13:59 INFO - Running setup.py (path:/tmp/pip-Cj9i6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:13:59 INFO - Running setup.py (path:/tmp/pip-BvrTw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:13:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:13:59 INFO - Running setup.py (path:/tmp/pip-uJneOk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:00 INFO - Running setup.py (path:/tmp/pip-CYO3Tm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:00 INFO - Running setup.py (path:/tmp/pip-YU3bol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:00 INFO - Running setup.py (path:/tmp/pip-OCDu0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:00 INFO - Running setup.py (path:/tmp/pip-TrJ5Rx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:00 INFO - Running setup.py (path:/tmp/pip-WCF3v9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:00 INFO - Running setup.py (path:/tmp/pip-UeMHFK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:00 INFO - Running setup.py (path:/tmp/pip-GNkGwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:00 INFO - Running setup.py install for manifestparser 11:14:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:14:00 INFO - Running setup.py install for mozcrash 11:14:00 INFO - Running setup.py install for mozdebug 11:14:00 INFO - Running setup.py install for mozdevice 11:14:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:14:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:14:00 INFO - Running setup.py install for mozfile 11:14:01 INFO - Running setup.py install for mozhttpd 11:14:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for mozinfo 11:14:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for mozInstall 11:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for mozleak 11:14:01 INFO - Running setup.py install for mozlog 11:14:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for moznetwork 11:14:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for mozprocess 11:14:01 INFO - Running setup.py install for mozprofile 11:14:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:14:01 INFO - Running setup.py install for mozrunner 11:14:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:14:02 INFO - Running setup.py install for mozscreenshot 11:14:02 INFO - Running setup.py install for moztest 11:14:02 INFO - Running setup.py install for mozversion 11:14:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:02 INFO - Cleaning up... 11:14:02 INFO - Return code: 0 11:14:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:14:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:02 INFO - Using env: {'DISPLAY': ':0', 11:14:02 INFO - 'HOME': '/home/cltbld', 11:14:02 INFO - 'LANG': 'en_US.UTF-8', 11:14:02 INFO - 'LANGUAGE': 'en_US:en', 11:14:02 INFO - 'LOGNAME': 'cltbld', 11:14:02 INFO - 'MAIL': '/var/mail/cltbld', 11:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:02 INFO - 'MOZ_NO_REMOTE': '1', 11:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:02 INFO - 'NO_EM_RESTART': '1', 11:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:02 INFO - 'SHELL': '/bin/bash', 11:14:02 INFO - 'SHLVL': '1', 11:14:02 INFO - 'TERM': 'linux', 11:14:02 INFO - 'TMOUT': '86400', 11:14:02 INFO - 'USER': 'cltbld', 11:14:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:02 INFO - '_': '/tools/buildbot/bin/python'} 11:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:02 INFO - Running setup.py (path:/tmp/pip-gTpL8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:02 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)) 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:02 INFO - Running setup.py (path:/tmp/pip-H5eRN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:02 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)) 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:02 INFO - Running setup.py (path:/tmp/pip-i62jX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:02 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)) 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:02 INFO - Running setup.py (path:/tmp/pip-ZnjJ5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:02 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)) 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:02 INFO - Running setup.py (path:/tmp/pip-5NpnWl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:02 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)) 11:14:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:02 INFO - Running setup.py (path:/tmp/pip-1dH7kn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:03 INFO - Running setup.py (path:/tmp/pip-QyknNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:03 INFO - Running setup.py (path:/tmp/pip-8bR2Lp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:03 INFO - Running setup.py (path:/tmp/pip-f8ri2c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:03 INFO - Running setup.py (path:/tmp/pip-OtxVQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:03 INFO - Running setup.py (path:/tmp/pip-BLpb1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:03 INFO - Running setup.py (path:/tmp/pip-bQecmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:03 INFO - Running setup.py (path:/tmp/pip-rrbqxq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:03 INFO - Running setup.py (path:/tmp/pip-lXl_IG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:03 INFO - Running setup.py (path:/tmp/pip-P6ZN57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:03 INFO - Running setup.py (path:/tmp/pip-9SEJM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:03 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)) 11:14:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:03 INFO - Running setup.py (path:/tmp/pip-TaJnEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:03 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)) 11:14:03 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)) 11:14:03 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)) 11:14:03 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)) 11:14:03 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)) 11:14:03 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)) 11:14:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:05 INFO - Downloading blessings-1.6.tar.gz 11:14:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:05 INFO - Installing collected packages: blessings 11:14:05 INFO - Running setup.py install for blessings 11:14:05 INFO - Successfully installed blessings 11:14:05 INFO - Cleaning up... 11:14:05 INFO - Return code: 0 11:14:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:14:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:14:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:14:06 INFO - Reading from file tmpfile_stdout 11:14:06 INFO - Current package versions: 11:14:06 INFO - argparse == 1.2.1 11:14:06 INFO - blessings == 1.6 11:14:06 INFO - blobuploader == 1.2.4 11:14:06 INFO - docopt == 0.6.1 11:14:06 INFO - manifestparser == 1.1 11:14:06 INFO - mozInstall == 1.12 11:14:06 INFO - mozcrash == 0.16 11:14:06 INFO - mozdebug == 0.1 11:14:06 INFO - mozdevice == 0.47 11:14:06 INFO - mozfile == 1.2 11:14:06 INFO - mozhttpd == 0.7 11:14:06 INFO - mozinfo == 0.9 11:14:06 INFO - mozleak == 0.1 11:14:06 INFO - mozlog == 3.1 11:14:06 INFO - moznetwork == 0.27 11:14:06 INFO - mozprocess == 0.22 11:14:06 INFO - mozprofile == 0.27 11:14:06 INFO - mozrunner == 6.11 11:14:06 INFO - mozscreenshot == 0.1 11:14:06 INFO - mozsystemmonitor == 0.0 11:14:06 INFO - moztest == 0.7 11:14:06 INFO - mozversion == 1.4 11:14:06 INFO - psutil == 3.1.1 11:14:06 INFO - requests == 1.2.3 11:14:06 INFO - wsgiref == 0.1.2 11:14:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14: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')]} 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:14:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:06 INFO - Using env: {'DISPLAY': ':0', 11:14:06 INFO - 'HOME': '/home/cltbld', 11:14:06 INFO - 'LANG': 'en_US.UTF-8', 11:14:06 INFO - 'LANGUAGE': 'en_US:en', 11:14:06 INFO - 'LOGNAME': 'cltbld', 11:14:06 INFO - 'MAIL': '/var/mail/cltbld', 11:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:06 INFO - 'MOZ_NO_REMOTE': '1', 11:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:06 INFO - 'NO_EM_RESTART': '1', 11:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:06 INFO - 'SHELL': '/bin/bash', 11:14:06 INFO - 'SHLVL': '1', 11:14:06 INFO - 'TERM': 'linux', 11:14:06 INFO - 'TMOUT': '86400', 11:14:06 INFO - 'USER': 'cltbld', 11:14:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:06 INFO - '_': '/tools/buildbot/bin/python'} 11:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 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)) 11:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 11:14:06 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)) 11:14:06 INFO - Cleaning up... 11:14:06 INFO - Return code: 0 11:14:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:14: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')]} 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:14:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 11:14:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:06 INFO - Using env: {'DISPLAY': ':0', 11:14:06 INFO - 'HOME': '/home/cltbld', 11:14:06 INFO - 'LANG': 'en_US.UTF-8', 11:14:06 INFO - 'LANGUAGE': 'en_US:en', 11:14:06 INFO - 'LOGNAME': 'cltbld', 11:14:06 INFO - 'MAIL': '/var/mail/cltbld', 11:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:06 INFO - 'MOZ_NO_REMOTE': '1', 11:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:06 INFO - 'NO_EM_RESTART': '1', 11:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:06 INFO - 'SHELL': '/bin/bash', 11:14:06 INFO - 'SHLVL': '1', 11:14:06 INFO - 'TERM': 'linux', 11:14:06 INFO - 'TMOUT': '86400', 11:14:06 INFO - 'USER': 'cltbld', 11:14:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:06 INFO - '_': '/tools/buildbot/bin/python'} 11:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:06 INFO - Downloading/unpacking jsonschema 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:08 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:08 INFO - warning: no files found matching '*.txt' 11:14:08 INFO - no previously-included directories found matching 'build' 11:14:08 INFO - no previously-included directories found matching 'dist' 11:14:08 INFO - no previously-included directories found matching '.git*' 11:14:08 INFO - Installing collected packages: jsonschema, functools32 11:14:08 INFO - Running setup.py install for functools32 11:14:08 INFO - warning: no files found matching '*.txt' 11:14:08 INFO - no previously-included directories found matching 'build' 11:14:08 INFO - no previously-included directories found matching 'dist' 11:14:08 INFO - no previously-included directories found matching '.git*' 11:14:08 INFO - Successfully installed jsonschema functools32 11:14:08 INFO - Cleaning up... 11:14:08 INFO - Return code: 0 11:14:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8577e3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', '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 11:14:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:14:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:14:08 INFO - Using env: {'DISPLAY': ':0', 11:14:08 INFO - 'HOME': '/home/cltbld', 11:14:08 INFO - 'LANG': 'en_US.UTF-8', 11:14:08 INFO - 'LANGUAGE': 'en_US:en', 11:14:08 INFO - 'LOGNAME': 'cltbld', 11:14:08 INFO - 'MAIL': '/var/mail/cltbld', 11:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:08 INFO - 'MOZ_NO_REMOTE': '1', 11:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:08 INFO - 'NO_EM_RESTART': '1', 11:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:08 INFO - 'SHELL': '/bin/bash', 11:14:08 INFO - 'SHLVL': '1', 11:14:08 INFO - 'TERM': 'linux', 11:14:08 INFO - 'TMOUT': '86400', 11:14:08 INFO - 'USER': 'cltbld', 11:14:08 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:08 INFO - '_': '/tools/buildbot/bin/python'} 11:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:08 INFO - Downloading/unpacking flake8 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:08 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 11:14:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:11 INFO - no previously-included directories found matching 'docs/_build' 11:14:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:14:11 INFO - Running setup.py install for pep8 11:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:11 INFO - no previously-included directories found matching 'docs/_build' 11:14:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:14:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:14:11 INFO - Cleaning up... 11:14:11 INFO - Return code: 0 11:14:11 INFO - Running post-action listener: _resource_record_post_action 11:14:11 INFO - Running post-action listener: _start_resource_monitoring 11:14:11 INFO - Starting resource monitoring. 11:14:11 INFO - ##### 11:14:11 INFO - ##### Running install step. 11:14:11 INFO - ##### 11:14:11 INFO - Running pre-action listener: _resource_record_pre_action 11:14:11 INFO - Running main action method: install 11:14:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:14:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:14:11 INFO - Reading from file tmpfile_stdout 11:14:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:14:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:14:11 INFO - Reading from file tmpfile_stdout 11:14:11 INFO - Output received: 11:14:11 INFO - Usage: mozinstall [options] installer 11:14:11 INFO - Options: 11:14:11 INFO - -h, --help show this help message and exit 11:14:11 INFO - -d DEST, --destination=DEST 11:14:11 INFO - Directory to install application into. [default: 11:14:11 INFO - "/builds/slave/test-pgo"] 11:14:11 INFO - --app=APP Application being installed. [default: firefox] 11:14:11 INFO - mkdir: /builds/slave/test-pgo/build/application 11:14:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:14:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:14:26 INFO - Reading from file tmpfile_stdout 11:14:26 INFO - Output received: 11:14:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:14:26 INFO - Running post-action listener: _resource_record_post_action 11:14:26 INFO - ##### 11:14:26 INFO - ##### Running run-tests step. 11:14:26 INFO - ##### 11:14:26 INFO - Running pre-action listener: _resource_record_pre_action 11:14:26 INFO - Running main action method: run_tests 11:14:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:14:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:14:26 INFO - Python 2.7.3 11:14:26 INFO - Return code: 0 11:14:26 INFO - grabbing minidump binary from tooltool 11:14:26 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')]} 11:14:26 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 0x2259a50>, '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 0x21c5550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c59e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:14:26 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 11:14:26 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 11:14:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:26 INFO - Return code: 0 11:14:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:14:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:14:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:14:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:14:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:14:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:14:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:14:27 INFO - Return code: 0 11:14:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:14:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 11:14:27 INFO - Using env: {'DISPLAY': ':0', 11:14:27 INFO - 'HOME': '/home/cltbld', 11:14:27 INFO - 'LANG': 'en_US.UTF-8', 11:14:27 INFO - 'LANGUAGE': 'en_US:en', 11:14:27 INFO - 'LOGNAME': 'cltbld', 11:14:27 INFO - 'MAIL': '/var/mail/cltbld', 11:14:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:14:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:27 INFO - 'MOZ_NO_REMOTE': '1', 11:14:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:27 INFO - 'NO_EM_RESTART': '1', 11:14:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:27 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:14:27 INFO - 'SHELL': '/bin/bash', 11:14:27 INFO - 'SHLVL': '1', 11:14:27 INFO - 'TERM': 'linux', 11:14:27 INFO - 'TMOUT': '86400', 11:14:27 INFO - 'USER': 'cltbld', 11:14:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476', 11:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:27 INFO - '_': '/tools/buildbot/bin/python'} 11:14:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 11:14:27 INFO - mozversion INFO | application_buildid: 20160121084622 11:14:27 INFO - mozversion INFO | application_changeset: 737f3b6e93c64099d651f7805dc61121250c73c0 11:14:27 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:14:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:27 INFO - mozversion INFO | application_name: Firefox 11:14:27 INFO - mozversion INFO | application_remotingname: firefox-dev 11:14:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:14:27 INFO - mozversion INFO | application_vendor: Mozilla 11:14:27 INFO - mozversion INFO | application_version: 45.0a2 11:14:27 INFO - mozversion INFO | platform_buildid: 20160121084622 11:14:27 INFO - mozversion INFO | platform_changeset: 737f3b6e93c64099d651f7805dc61121250c73c0 11:14:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:14:27 INFO - mozversion INFO | platform_version: 45.0a2 11:14:27 INFO - 2016-01-21 11:14:27,858 DEBUG : using testdate: 1453403667 11:14:27 INFO - 2016-01-21 11:14:27,858 DEBUG : actual date: 1453403667 11:14:27 INFO - 2016-01-21 11:14:27,867 INFO : starting webserver on 'localhost:50047' 11:14:27 INFO - 2016-01-21 11:14:27,868 INFO : Starting test suite talos-linux64-ix-049.e 11:14:27 INFO - 2016-01-21 11:14:27,868 INFO : Starting test dromaeo_css 11:14:27 INFO - 2016-01-21 11:14:27,868 DEBUG : operating with platform_type : linux_ 11:14:27 INFO - 2016-01-21 11:14:27,869 INFO : Initialising browser for dromaeo_css test... 11:14:27 INFO - 2016-01-21 11:14:27,882 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDGI4Vj/profile http://localhost:50047/getInfo.html 11:14:31 INFO - 2016-01-21 11:14:31,422 DEBUG : BROWSER_OUTPUT: 11:14:31 INFO - 2016-01-21 11:14:31,422 DEBUG : BROWSER_OUTPUT: (process:32498): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:14:32 INFO - 2016-01-21 11:14:32,306 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:14:32 INFO - 2016-01-21 11:14:32,307 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:14:32 INFO - 2016-01-21 11:14:32,307 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:14:32 INFO - 2016-01-21 11:14:32,307 DEBUG : BROWSER_OUTPUT: __metrics 11:14:33 INFO - 2016-01-21 11:14:33,192 INFO : Browser initialized. 11:14:33 INFO - 2016-01-21 11:14:33,192 INFO : Running cycle 1/1 for dromaeo_css test... 11:14:33 INFO - 2016-01-21 11:14:33,192 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDGI4Vj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:14:34 INFO - 2016-01-21 11:14:34,509 DEBUG : BROWSER_OUTPUT: 11:14:34 INFO - 2016-01-21 11:14:34,510 DEBUG : BROWSER_OUTPUT: (process:32611): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:14:45 INFO - 2016-01-21 11:14:45,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 136970240 11:14:45 INFO - 2016-01-21 11:14:45,016 DEBUG : BROWSER_OUTPUT: 11:15:34 INFO - 2016-01-21 11:15:34,628 DEBUG : BROWSER_OUTPUT: 1453403734625 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] 11:17:42 INFO - 2016-01-21 11:17:42,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50047/tests/dromaeo/cssquery-ext.html) 11:17:43 INFO - 2016-01-21 11:17:43,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 11:17:43 INFO - 2016-01-21 11:17:43,968 DEBUG : BROWSER_OUTPUT: 11:20:45 INFO - 2016-01-21 11:20:45,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-ext.html (next: http://localhost:50047/tests/dromaeo/cssquery-jquery.html) 11:20:46 INFO - 2016-01-21 11:20:46,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 11:20:46 INFO - 2016-01-21 11:20:46,361 DEBUG : BROWSER_OUTPUT: 11:23:47 INFO - 2016-01-21 11:23:47,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50047/tests/dromaeo/cssquery-mootools.html) 11:23:48 INFO - 2016-01-21 11:23:48,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 11:23:48 INFO - 2016-01-21 11:23:48,534 DEBUG : BROWSER_OUTPUT: 11:26:50 INFO - 2016-01-21 11:26:50,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50047/tests/dromaeo/cssquery-prototype.html) 11:26:50 INFO - 2016-01-21 11:26:50,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 138952704 11:26:50 INFO - 2016-01-21 11:26:50,675 DEBUG : BROWSER_OUTPUT: 11:29:52 INFO - 2016-01-21 11:29:52,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50047/tests/dromaeo/cssquery-yui.html) 11:29:53 INFO - 2016-01-21 11:29:53,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 11:29:53 INFO - 2016-01-21 11:29:53,564 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/dromaeo/cssquery-yui.html (next: http://localhost:50047/tests/dromaeo/cssquery-dojo.html) 11:32:55 INFO - 2016-01-21 11:32:55,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 141529088 11:32:55 INFO - 2016-01-21 11:32:55,732 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,733 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:55 INFO - 2016-01-21 11:32:55,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:55 INFO - 2016-01-21 11:32:55,734 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:55 INFO - 2016-01-21 11:32:55,734 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:55 INFO - 2016-01-21 11:32:55,737 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3272.492763621639;3351.48052051932;3369.5114208439763;3383.272596391775;3384.8984530464086;5554.472325129116;5560.86097847554;5578.804741834037;5584.776608935637;5589.189567512708;5576.191452239423;5596.636218645795;5658;5667.149927510875;5678.176664383662;5102.285680004802;5163.612729045337;5189.247559103927;5220.947790522103;5227.5295223429885;5010.924836127443;5119.641625086246;5123.436421993578;5140.94610604827;5260.316158899338;5066.544011039005;5148.304978827867;5157.3811142662935;5166.612504062192;5172.741362931838;5103.183490641498;5170.896582068375;5182.792688292464;5204.141316682742;5217.34783152106;4934.728589927553;4966.5778408835295;5064.822731204427;5092.236164575306;5100.336956195708;5268.683878967274;5435.565154787608;5436.755346009439;5448.700321482317;5455.945440545584;5948.226730525047;5966.820995370146;6003.369646187131;6007.639541627516;6029.276486821609;5937.910931336033;6002.759889604411;6010.639361638316;6116.5183814016455;6127.2953610334935;5664.291963504562;5667.886642267132;5674.120511320711;5678.630888992244;5678.659280443187;6088.969555152285;6140.355262697352;6141.662208578571;6152.600080994721;6153.84615384619;5729.1119876419225;5809.854753631109;5810.5061069809535;5811.854703632443;5815.360310365856;5911.083782013795;5947.197128387699;5955.076963070731;6047.78832740852;6062.363451837494;5924.5852790305125;5975.193348897843;5981.491573216238;5982.252218472691;5995.550333724988;5734.426557344233;5960.225170727865;5992.161097446361;6013.9699301503215;6016.729247183887;4547.47704014036;4564.612007979293;4608.631309495232;4629.166749984967;4668.0197158597075;4125.195586860594;4125.711200216017;4131.8967025824595;4157.210130075276;4173.227952828736;5569.944300556943;5643.915341269884;5759.308882934075;5764.625299355528;5772.942270577324;5900.144479050514;5913.113033045078;5980.55145864062;5984.431479009487;6050.6974651267265;5747.166660834156;5751.367349591542;5766.163906233573;5781.756922261734;5795.652260864362;5286.577073834084;5302;5306.867328316823;5308.814191503279;5326.92009619856;5951.821445356646;6083.513318934474;6123.648682309606;6233.906491402633;6239.0953311770445;6016.789412370721;6026.517878569616;6084.908726369196;6106.938930610726;6133.233345831771;6027.517798576016;6182.319944806158;6212.236494651583;6223.408776166438;6242.250929888442;5813.505852002627;5888.3228428731245;5982.7307771149535;6015.909761353671;6053.788117415869;6056.36408177135;6062.575619706578;6062.757489700362;6077.908831367621;6128.080787881853;5751.971240143773;5870.911936320873;5949.018411962151;5952.851178720567;5958.791442299672;5847.853803654943;5900.675462849585;5905.114232865105;5923.318818335946;5927.555433342431;5788.594798364074;5801.361850196559;5805.767769289181;5806.709664516842;5826.446487583673;5673.8297851064535;5852.736626851717;5855.063189889597;5859.853503662443;5922.615030023035;5667.3482549507335;5747.339056008613;5762.971185144047;5769.451902069297;5773.93182261283 11:32:55 INFO - 2016-01-21 11:32:55,738 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.2598066629386;589.1192666962891;624.9093881387198;633.5628416392689;663.555417870027;41956.79021604892;42831.78584107075;42934.785326073405;42961;43005;40763.59236407635;40875.386869196984;41041.58958410415;41201;41248.79375603125;9006.729798106051;9115.817683646323;9147.359684822066;9188.908110918872;9257.305702072337;9096.954515227448;9171.312151588658;9173.128552787508;9181.908180918172;9182.403143795666;9128.178463938244;9134;9239.168474837263;9241.491717955543;9244.352895297332;9065.048169942127;9076.137766912167;9112.179903808623;9154.084591540826;9159.267258619295;8934.955325223398;9088.454692718458;9100.544972751335;9114.316426268057;9167.954160229223;41010.79494602538;41137;41234;41533.584664153575;41588.79205603983;3423.845926933294;3504.176518518146;3579.624139465345;3787.621237876218;4254.404383386328;31548.52677209821;31841;32226.35547289041;32292;33123.6687633123;3431.605365382988;3491.14466955595;3497.1956450016382;3508;3509.8771542995873;290821;293634;293994;294662;295278;62559;62778.372216277254;63020.369796302366;63039.36960630335;63236.367636323965;66703.33296667068;66747;67184;67313.32686673071;67319.32680673228;17741.911290443466;18254.17856196474;18314.45056648303;18338;18351.08244587765;13180.868191317964;13269.203847769164;13273;13354.799678004838;13365.866341336656;20670.276540321018;21300.893495532422;21324.573508529742;21357.718536887838;21407.357779266647;8205.138460461685;8354.665813367397;8441.198086181803;8456.40805143634;8531.872021919677;965.753732798132;1017.9972726864033;1102.063246240705;1162.3084264862393;1171.109956433117;28730.712692872803;28998.710012899603;29249.707502925125;29424.852875735483;29835.25411864677;1068.5084860964043;1088.6407485529755;1103.172620534599;1106.280917403694;1185.1526158796503;14236.359363828653;14443.711125777425;14494.34775435108;14583.92708036453;14681;518543;522889;527549;528960;838331;57145.42854571484;57986.7100664494;58131.41868581345;58307.70846145742;58387.70806145942;1466.0836976889443;1469.9926500367644;1471.1908450352478;1477.3351991603822;1489.2107183192925;29777.255568610093;29916.401671966003;30456.974240370186;31177.68822311748;31512.684873150974;48825.75587122042;49203.50796492132;49341;49485.50514494953;49575.25637115374;339503;341779;341978;343987;344040;33705.49441758425;33846.83076584601;34008.65991340154;34504.239660827574;34655.65344346524;43282;43531.12937741291;44790.3281450785;45816.312755309365;46167.76916115398;37892;38209;38473.297647205276;38848;38876;38087.238255235294;38656.6134338653;38760.224795504495;38773.41839872348;39248.80375598104;38065.23869522649;38485.4227186598;44144.7792761047;44793.32810007787;45148.54851451575;32267;33939.830300848334;34254.31491370209;34491.827540862134;38386.6161338383;25835.22494325173;26345.473090538464;26434.339141521617;26577.202683919513;26869.462610747283 11:32:55 INFO - 2016-01-21 11:32:55,741 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.1810267846009;368.3351550451437;369.30754834684967;371.737924763042;375.86656736858424;16335.83664163358;18301.35945241917;18807.62384752306;18971.33600323989;19693.50766230843;17405.390811321606;17430.302787888468;17845.286188552443;17879.82120178801;18509.814901850976;5314.282571852798;5732.197492351074;5738.282714660668;5741.483266506014;5755.338136114337;5534.612577119603;5672.886542269152;5691.4877661010505;5719.399463056381;5722.427757224286;5486.807961721341;5626.746796394152;5650.576206784487;5690.146478028288;5700.942990570083;5638.40796716345;5652.34997975234;5656.773729050854;5659.773609055654;5662.122371032497;5668.518175955049;5679.318481782213;5689.947359738461;5690.374058853564;5700.458456446631;13691.452341906312;13734.244616546086;14360.56918292453;14399.712005759826;14429.49496767608;2201.8458707890454;2208.1719355241785;2220.6335954567476;2256.0186318951146;2387.6896003519605;10464.215183861164;10553;10699.83950240747;10717.356958582432;10731.517081731263;1910.570121722615;1916.2909723402431;1936.5352315444193;1950.3856285270235;1973.6052789442026;61319.38680613181;63631.36368636301;64140.358596413906;65256.67371663159;66010;10580.57677692899;10890.61882834097;10918.07196388316;10968.396738179477;11043.447827608587;14151.221682807338;14262.286885655676;14276.143431393943;14348.139111653334;14357.56927292183;8012.759617211493;8102.513849169069;8292.709755158541;8297.95851020741;8343.582820859054;8011.799705007422;8328.583570821434;8350.206730360727;8358.871552340357;8539.14608539141;4668.743219122913;4731.526847315241;4731.858044258678;4748.833790817304;4912.778924948315;1928.3732786844332;1978.7625484941611;2036.307655397172;2054.7842476540045;2054.9622440667667;936.5925822267335;998.286225348879;1010.7624708193568;1032.3599368391494;1069.4706120470416;11999.460024298927;12111;12201.69495762613;12202.084843636763;17697;452.12513785824535;475.9928601070987;478.4712892254079;480.61310644931166;501.8444282272507;6054.878902421927;6213.347598502182;6217.316095229521;6332.936670633235;6454.451371633464;612124;613514;623650;626175;657018;86595.13404865997;90865.54567227121;91404;92634.53682731543;94505;516.7984486050443;526.6524094097877;526.7392640642983;527.2670987327617;527.9604029697788;11215.943920280673;11548.711282218012;16625.251863665922;17194.22625981809;17284.222210000327;36440;38426.61573384231;38603;38714.41928371133;39155.6084439152;42373;43069.569304306555;43941.340879886186;45013.549864502245;47968;10852.782944340912;10930.890691092987;10947.890521094687;10949.069329106796;11172.608958686407;17801.910990444965;18210;18446.26214951387;18494.630107398047;18844.246230150642;15036.924815376291;15623.218839058229;15778.211089445711;15799.289031993358;15919.920400397923;13165;13721.245331506863;15333.539993800205;15441.5367538974;15784.526464206092;14871.18208498543;15011.849881501483;15188.924055380094;15331.846681533489;15458;9230.261579073524;9315.301352398732;9454.527273636428;9507.049295070437;9561.521923903916;11183.161262905478;11228.88771112311;13629.591112266648;14583.92708036453;14766.409343626565 11:32:55 INFO - 2016-01-21 11:32:55,741 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1484.480431848853;1490.6869557392947;1655.3213182595139;1775.7957834848992;1822.407717491815;6709.932900670992;6850.1779786425695;7002.334778196069;7412.777616671495;7427;7425.183229844726;7570.5079169853925;7618.809529761758;7665.041869766279;7689.769306920802;2266.977330226697;2331.3239160643393;2338.9064437422485;2339.1462116327502;2343.5781559319316;2332.416895776056;2358.7523310052457;2390.725066617335;2397.3646983549374;2405.807535397164;2257.808086312665;2273.920412785553;2305.2162264829954;2315.235972129193;2325.5232677301115;2302.654601809742;2315.9536809263805;2320.303908827345;2347.9765202348012;2356.3402247370677;2321.605327094398;2350.74141844397;2352.6000579901456;2353.352827972304;2368.052778888441;7816.413768967293;7902.012248468942;7902.960485197537;7922.485038472539;7955.721549745789;4611.654125940568;4654.325122857201;4662.393888794469;4694.155052090622;4696.3894693689945;2918.5330347144354;2924.2981684395804;2930.194196595953;2937.911862644124;2959.7484213841635;943.3396622364372;947.4031360243072;957.1959553974694;959.3764053365298;984.4683870709808;10178.592856285739;10185.745356366077;10191.03185197405;10222.69331920051;10223.488825558692;4185.832566697359;4210.473690788652;4219.894502637459;4239.38528913312;4242.193983143255;8788.692395766118;8795.296376289882;8830.646774128963;8833.911660883437;8838.690645827364;4630.560096790799;4636.9536304637195;4653.162430762428;4673.158831410379;4687.95312046882;4223.092035212444;4226.598473145108;4308.095299987038;4311.1808756336195;4342.5657434256955;3649;3662.322470342942;3667.1015601177883;3673.3204357194004;3695.501107350527;1112.4993752811267;1123.8370436286693;1124.7806677697934;1124.9550017999188;1128.3793913347627;1382.7787553991313;1387.6600232942994;1394.8047273381533;1403.6771542545068;1418.9574312770633;7093.077899872984;7273.963630181921;7278.708851645981;7279.672414741243;7315.707371705179;485.922252439608;488.4773292576909;493.8567815333585;494.3474613510204;506.5112166759022;5781.653100813881;5802.854928626818;5843.3864444233595;5847.26909136358;5850.912236316459;9033.593488293043;9567.760805979906;9575.186109180797;9687.370320929118;9699.660511882192;9424;9441.811163776685;9476.147146756824;9526.095020972996;9601.087896649808;7447;7526.473146879666;7554.169041405331;7570.129435115033;7638.847223055619;7193.784186474414;7319.341259286477;7323.8535229296185;7334.6699398526125;7346.7061317546695;8391.58042097905;8472.788180295296;8500.14998500145;8563.657453701782;8584.270337021173;8679.652813887375;8698.91301086981;8700.173483519056;8813.42712723671;8833.955830220808;6119.571629985859;6206.503479721701;6624.668766561749;6740;6834.2482326943;7537.9623101884135;7561.962190189014;7579.204183560647;7626.923730762622;7649.732259370895;7077.115360579927;7192.172900116553;7215.639218039182;7329.450291228286;7336.413086953137;7103.50275480732;7135.6432178391915;7154.785356439315;7227.927720722725;7230.6384680764695;7141.9644151596685;7143.821404464722;7189.137303523611;7196.748113815991;7214.242504536948;6584.078229048033;6608.933910660832;6615.503837212132;6640.435562977201;6641.302663220486;6522.836929076811;6534.085228068169;6554.606723596599;6645.069690243273;6735.326467353226 11:32:55 INFO - 2016-01-21 11:32:55,745 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.20145262989865;351.8610148991149;352.74770589784254;354.36037951497536;358.7022771099987;6361.809145725624;6449.097126402302;6506.089147519351;6508.38170373815;6565.277819439863;6202.224721909762;6382.106505089279;6385.457236134934;6413.711382987765;6432.903506447407;4895.6083513318845;4922.187839006559;4935.851924442272;4941.234108713137;4948.604111671076;4923.18767403378;4955.405351357842;4959.925601115986;4960.305557221992;4968.577670897978;4699.7415142167165;4817.735024573647;4845.685030473008;4848.20004699226;4886.853394398174;4814.614830813526;4842.782074806642;4849.321095046696;4849.515048495157;4866.926996095061;4185.644220241283;4227.408162857202;4229.323308270693;4232.788360581959;4247.384129301234;6038.57729958903;6107.198376478949;6141.785037523665;6144.446999769997;6159.568830181889;5614.101743720985;5615.6630602164005;5635.09838425854;5657;5666.093425052013;6813.318668133147;6817.965910170467;6833.760818371333;6848.520603557753;6855.760048398332;4678.3216433616935;4691.62467002639;4694.29585562165;4694.389729335198;4696.154692155411;6914.204866440374;7026.016357709925;7078.221395646475;7139.89290160648;7144.178419481774;4768;4776.785044672998;4776.832810851603;4777.163996300634;4790.113828941657;4771.284307353924;4804.399450068741;4810.037992401533;4818.373611430492;4826;5536.114221724585;5624.465675760796;5628.071368224197;5631.774729010794;5666.801661941812;6916.930830691729;6923.2038315594355;6923.4807389446;6928.307169283132;6929.653517324114;1594.545554516957;1652.140886738889;1665.6585399993214;1714.8113707492166;1715.4682048564985;1098.0556721219746;1129.0967226218993;1142.4344949250174;1146.9655910322704;1150.269578817457;6622.072909792633;6640.269570347258;6655.334466553403;6658.234303055114;6670.332966703291;6978.825529361807;7011.053507776385;7030.2969703029285;7037.1555413350725;7048.577085374894;6535.411812936859;6537.542372033912;6589.242237142694;6590.769323073765;6670.466362690973;3795.6204379561823;3843.9039024024064;3874.1283211277237;3876.5154355705536;3883.0680636647003;7278.199398066208;7279;7282.815155453342;7283.417326613858;7302.05073340473;7173.748918787817;7181.533200341961;7187.425005999507;7209.567425954459;7429.554226746304;7366.079240094989;7420.5547667140145;7424.851502969802;7447.813804654818;7448.5158464699625;7213.71145154188;7215.170255420694;7249.311315425026;7250.238724934017;7254.637268136466;6913.79258622222;7071.575705457689;7116.537425067354;7117.750878719427;7121.145462544528;7413.221611730691;7423.035005449257;7427.034485516848;7435.51669141504;7441.739539116105;4779.952200477951;4809.639277054305;4816.34979277793;4824.927626085541;4825.10735513931;7019.4735394844565;7082.079329687108;7215.494915355875;7220.783376498714;7244.529105608119;6966.686499107654;6994.090768200102;7019.262977387505;7036.261192574911;7037.331453511908;7001.544899581511;7013.333733295329;7017.3684368407085;7020.543664661781;7021.368076873106;6657.866842663217;6906.274841141608;6913.827154321182;6930.306969303231;6948.478864085315;7038.542494737826;7047.859042819013;7065.611391373318;7065.788026359218;7075.610841403566;6696.5647232929705;6793.694283757144;6834.111565496453;6839.965800170968;6871 11:32:55 INFO - 2016-01-21 11:32:55,745 DEBUG : BROWSER_OUTPUT: |5;yui.html;687.5359132585504;835.3776436554767;853.1212850763716;874.0647507167331;935.7894473743406;14073.859261407382;14204.644883877909;14285.428582856674;14310.785338219908;14355.641108972268;13406.530771422978;13567.932160339209;14019.369128389222;14184.574462766133;14200.431982720678;910.7313342563959;915.7390143808999;930.2650905784423;930.6417029443645;930.8277968575801;919.6321471411422;922.3681777982071;928.0811996123823;928.7120992492349;928.9767755806125;957.2294303086013;959.0936564946094;959.1463597398321;962.2494454325637;964.2286171063156;945.6737425588161;950.2825366848055;952.4570994533119;953.50894289441;957.2724729205819;683.0607914118087;695.7425752471618;699.4544255480733;699.7690762048512;708.1608294171423;14534.491292804702;14614.853851461456;14656.193909334983;14666.926665366605;14713.55859324222;11845.526178952832;12107.757844843054;12255;12390.81413778794;12698.920591749713;9910.659456033009;10122.139618132467;10325.79348413035;10651.307665001828;11082;3503.1242189452637;3569.982150089233;3584.8386822592784;3607.134287770942;3637.836297366625;52201.2169817453;52436.737816311055;52440.47559524432;52554.474455255724;52894.20658690123;9317.72046838596;9409.858852117224;9698.496733006396;9707.514624268899;10195.490225488844;18414.81585184131;18441.446756597055;18480.537986550444;18496.537586560444;18537.073146342627;7589.43079269046;7597.126330472067;7648.311651951351;7771.72798952034;7780.949571807733;4268.914621707549;4354.608085272341;4360.520342762294;4398.186335527874;4504.144212599595;3119.688031196862;3151.7163455289133;3159.020703581851;3159.1470303018054;3164.2089477630593;581.3198557687516;591.0366103251758;593.2199158107076;596.4929809661753;598.5421152818097;637.4390536328002;676.2290988273372;677.7695583501633;683.4771399879096;689.1489011071423;8362.623681934327;8498.69112563195;8557.743267701979;8662.436941598777;8855.645774168961;548.9478499542537;559;675.3550359406755;696.9407600354027;699.867025265198;4053.959460405358;4118.217538667644;4129.607687269765;4148.481439820022;4298.935515967263;61431.69284153551;61625.383746162865;61781.382186177565;61897;62265;53563.46436535662;54506.454935450136;54861.725691371284;54939.45060549423;55140.17289740657;48961;49158.26262605992;50541.49458505442;53107.99999999923;53639.73180134074;8835.602397891982;8975.865362019444;8989.28085753125;9137.954310228406;9270.212031977087;36436.45345319769;37090.814545927096;37118.62881371152;39273.60726392814;39665.40501892532;47712.761436192595;50293;50459.74770126126;50599.699025581765;50995.2350714747;10979.231453798158;11421.543138274375;11549.769004619693;12107.455164517442;12537.435815388148;11154.330740155616;11497.137714671266;11995.280283183038;12077.27536347822;12416.937915310365;10698.251122421356;10792.190585705946;11085.833712494157;11316.94341528287;11459.656210313704;10286.022827831344;10404.843927340944;10560.102391296827;10678;10701.946490267499;10620.628278010232;10668;10786.514606842868;11220.607278745205;11743;8602.827943441222;8610.48337099751;8872.911270887209;8942.86585701228;9590.520473976412;7917.44577879566;8172.550509722022;8229.46508476947;8379.58102094905;8610.698625548075 11:32:55 INFO - 2016-01-21 11:32:55,745 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:55 INFO - 2016-01-21 11:32:55,745 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:32:55 INFO - 2016-01-21 11:32:55,745 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,292 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404775732__endTimestamp 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5583.05 Median:5781.76 stddev:610.64 (10.6%) stddev-sans-first:585.00 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: Values: 3272.5 3351.5 3369.5 3383.3 3384.9 5554.5 5560.9 5578.8 5584.8 5589.2 5576.2 5596.6 5658.0 5667.1 5678.2 5102.3 5163.6 5189.2 5220.9 5227.5 5010.9 5119.6 5123.4 5140.9 5260.3 5066.5 5148.3 5157.4 5166.6 5172.7 5103.2 5170.9 5182.8 5204.1 5217.3 4934.7 4966.6 5064.8 5092.2 5100.3 5268.7 5435.6 5436.8 5448.7 5455.9 5948.2 5966.8 6003.4 6007.6 6029.3 5937.9 6002.8 6010.6 6116.5 6127.3 5664.3 5667.9 5674.1 5678.6 5678.7 6089.0 6140.4 6141.7 6152.6 6153.8 5729.1 5809.9 5810.5 5811.9 5815.4 5911.1 5947.2 5955.1 6047.8 6062.4 5924.6 5975.2 5981.5 5982.3 5995.6 5734.4 5960.2 5992.2 6014.0 6016.7 4547.5 4564.6 4608.6 4629.2 4668.0 4125.2 4125.7 4131.9 4157.2 4173.2 5569.9 5643.9 5759.3 5764.6 5772.9 5900.1 5913.1 5980.6 5984.4 6050.7 5747.2 5751.4 5766.2 5781.8 5795.7 5286.6 5302.0 5306.9 5308.8 5326.9 5951.8 6083.5 6123.6 6233.9 6239.1 6016.8 6026.5 6084.9 6106.9 6133.2 6027.5 6182.3 6212.2 6223.4 6242.3 5813.5 5888.3 5982.7 6015.9 6053.8 6056.4 6062.6 6062.8 6077.9 6128.1 5752.0 5870.9 5949.0 5952.9 5958.8 5847.9 5900.7 5905.1 5923.3 5927.6 5788.6 5801.4 5805.8 5806.7 5826.4 5673.8 5852.7 5855.1 5859.9 5922.6 5667.3 5747.3 5763.0 5769.5 5773.9 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,746 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57486.93 Median:38766.82 stddev:115656.27 (298.3%) stddev-sans-first:115901.70 11:32:55 INFO - 2016-01-21 11:32:55,747 DEBUG : BROWSER_OUTPUT: Values: 544.3 589.1 624.9 633.6 663.6 41956.8 42831.8 42934.8 42961.0 43005.0 40763.6 40875.4 41041.6 41201.0 41248.8 9006.7 9115.8 9147.4 9188.9 9257.3 9097.0 9171.3 9173.1 9181.9 9182.4 9128.2 9134.0 9239.2 9241.5 9244.4 9065.0 9076.1 9112.2 9154.1 9159.3 8935.0 9088.5 9100.5 9114.3 9168.0 41010.8 41137.0 41234.0 41533.6 41588.8 3423.8 3504.2 3579.6 3787.6 4254.4 31548.5 31841.0 32226.4 32292.0 33123.7 3431.6 3491.1 3497.2 3508.0 3509.9 290821.0 293634.0 293994.0 294662.0 295278.0 62559.0 62778.4 63020.4 63039.4 63236.4 66703.3 66747.0 67184.0 67313.3 67319.3 17741.9 18254.2 18314.5 18338.0 18351.1 13180.9 13269.2 13273.0 13354.8 13365.9 20670.3 21300.9 21324.6 21357.7 21407.4 8205.1 8354.7 8441.2 8456.4 8531.9 965.8 1018.0 1102.1 1162.3 1171.1 28730.7 28998.7 29249.7 29424.9 29835.3 1068.5 1088.6 1103.2 1106.3 1185.2 14236.4 14443.7 14494.3 14583.9 14681.0 518543.0 522889.0 527549.0 528960.0 838331.0 57145.4 57986.7 58131.4 58307.7 58387.7 1466.1 1470.0 1471.2 1477.3 1489.2 29777.3 29916.4 30457.0 31177.7 31512.7 48825.8 49203.5 49341.0 49485.5 49575.3 339503.0 341779.0 341978.0 343987.0 344040.0 33705.5 33846.8 34008.7 34504.2 34655.7 43282.0 43531.1 44790.3 45816.3 46167.8 37892.0 38209.0 38473.3 38848.0 38876.0 38087.2 38656.6 38760.2 38773.4 39248.8 38065.2 38485.4 44144.8 44793.3 45148.5 32267.0 33939.8 34254.3 34491.8 38386.6 25835.2 26345.5 26434.3 26577.2 26869.5 11:32:55 INFO - 2016-01-21 11:32:55,747 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,748 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31678.15 Median:368.82 stddev:102482.77 (27786.6%) stddev-sans-first:102743.29 11:32:55 INFO - 2016-01-21 11:32:55,748 DEBUG : BROWSER_OUTPUT: Values: 363.2 368.3 369.3 371.7 375.9 16335.8 18301.4 18807.6 18971.3 19693.5 17405.4 17430.3 17845.3 17879.8 18509.8 5314.3 5732.2 5738.3 5741.5 5755.3 5534.6 5672.9 5691.5 5719.4 5722.4 5486.8 5626.7 5650.6 5690.1 5700.9 5638.4 5652.3 5656.8 5659.8 5662.1 5668.5 5679.3 5689.9 5690.4 5700.5 13691.5 13734.2 14360.6 14399.7 14429.5 2201.8 2208.2 2220.6 2256.0 2387.7 10464.2 10553.0 10699.8 10717.4 10731.5 1910.6 1916.3 1936.5 1950.4 1973.6 61319.4 63631.4 64140.4 65256.7 66010.0 10580.6 10890.6 10918.1 10968.4 11043.4 14151.2 14262.3 14276.1 14348.1 14357.6 8012.8 8102.5 8292.7 8298.0 8343.6 8011.8 8328.6 8350.2 8358.9 8539.1 4668.7 4731.5 4731.9 4748.8 4912.8 1928.4 1978.8 2036.3 2054.8 2055.0 936.6 998.3 1010.8 1032.4 1069.5 11999.5 12111.0 12201.7 12202.1 17697.0 452.1 476.0 478.5 480.6 501.8 6054.9 6213.3 6217.3 6332.9 6454.5 612124.0 613514.0 623650.0 626175.0 657018.0 86595.1 90865.5 91404.0 92634.5 94505.0 516.8 526.7 526.7 527.3 528.0 11215.9 11548.7 16625.3 17194.2 17284.2 36440.0 38426.6 38603.0 38714.4 39155.6 42373.0 43069.6 43941.3 45013.5 47968.0 10852.8 10930.9 10947.9 10949.1 11172.6 17801.9 18210.0 18446.3 18494.6 18844.2 15036.9 15623.2 15778.2 15799.3 15919.9 13165.0 13721.2 15333.5 15441.5 15784.5 14871.2 15011.8 15188.9 15331.8 15458.0 9230.3 9315.3 9454.5 9507.0 9561.5 11183.2 11228.9 13629.6 14583.9 14766.4 11:32:55 INFO - 2016-01-21 11:32:55,748 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5454.99 Median:6596.51 stddev:2825.07 (42.8%) stddev-sans-first:2817.23 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: Values: 1484.5 1490.7 1655.3 1775.8 1822.4 6709.9 6850.2 7002.3 7412.8 7427.0 7425.2 7570.5 7618.8 7665.0 7689.8 2267.0 2331.3 2338.9 2339.1 2343.6 2332.4 2358.8 2390.7 2397.4 2405.8 2257.8 2273.9 2305.2 2315.2 2325.5 2302.7 2316.0 2320.3 2348.0 2356.3 2321.6 2350.7 2352.6 2353.4 2368.1 7816.4 7902.0 7903.0 7922.5 7955.7 4611.7 4654.3 4662.4 4694.2 4696.4 2918.5 2924.3 2930.2 2937.9 2959.7 943.3 947.4 957.2 959.4 984.5 10178.6 10185.7 10191.0 10222.7 10223.5 4185.8 4210.5 4219.9 4239.4 4242.2 8788.7 8795.3 8830.6 8833.9 8838.7 4630.6 4637.0 4653.2 4673.2 4688.0 4223.1 4226.6 4308.1 4311.2 4342.6 3649.0 3662.3 3667.1 3673.3 3695.5 1112.5 1123.8 1124.8 1125.0 1128.4 1382.8 1387.7 1394.8 1403.7 1419.0 7093.1 7274.0 7278.7 7279.7 7315.7 485.9 488.5 493.9 494.3 506.5 5781.7 5802.9 5843.4 5847.3 5850.9 9033.6 9567.8 9575.2 9687.4 9699.7 9424.0 9441.8 9476.1 9526.1 9601.1 7447.0 7526.5 7554.2 7570.1 7638.8 7193.8 7319.3 7323.9 7334.7 7346.7 8391.6 8472.8 8500.1 8563.7 8584.3 8679.7 8698.9 8700.2 8813.4 8834.0 6119.6 6206.5 6624.7 6740.0 6834.2 7538.0 7562.0 7579.2 7626.9 7649.7 7077.1 7192.2 7215.6 7329.5 7336.4 7103.5 7135.6 7154.8 7227.9 7230.6 7142.0 7143.8 7189.1 7196.7 7214.2 6584.1 6608.9 6615.5 6640.4 6641.3 6522.8 6534.1 6554.6 6645.1 6735.3 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5743.04 Median:6551.41 stddev:1767.00 (27.0%) stddev-sans-first:1724.87 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: Values: 344.2 351.9 352.7 354.4 358.7 6361.8 6449.1 6506.1 6508.4 6565.3 6202.2 6382.1 6385.5 6413.7 6432.9 4895.6 4922.2 4935.9 4941.2 4948.6 4923.2 4955.4 4959.9 4960.3 4968.6 4699.7 4817.7 4845.7 4848.2 4886.9 4814.6 4842.8 4849.3 4849.5 4866.9 4185.6 4227.4 4229.3 4232.8 4247.4 6038.6 6107.2 6141.8 6144.4 6159.6 5614.1 5615.7 5635.1 5657.0 5666.1 6813.3 6818.0 6833.8 6848.5 6855.8 4678.3 4691.6 4694.3 4694.4 4696.2 6914.2 7026.0 7078.2 7139.9 7144.2 4768.0 4776.8 4776.8 4777.2 4790.1 4771.3 4804.4 4810.0 4818.4 4826.0 5536.1 5624.5 5628.1 5631.8 5666.8 6916.9 6923.2 6923.5 6928.3 6929.7 1594.5 1652.1 1665.7 1714.8 1715.5 1098.1 1129.1 1142.4 1147.0 1150.3 6622.1 6640.3 6655.3 6658.2 6670.3 6978.8 7011.1 7030.3 7037.2 7048.6 6535.4 6537.5 6589.2 6590.8 6670.5 3795.6 3843.9 3874.1 3876.5 3883.1 7278.2 7279.0 7282.8 7283.4 7302.1 7173.7 7181.5 7187.4 7209.6 7429.6 7366.1 7420.6 7424.9 7447.8 7448.5 7213.7 7215.2 7249.3 7250.2 7254.6 6913.8 7071.6 7116.5 7117.8 7121.1 7413.2 7423.0 7427.0 7435.5 7441.7 4780.0 4809.6 4816.3 4824.9 4825.1 7019.5 7082.1 7215.5 7220.8 7244.5 6966.7 6994.1 7019.3 7036.3 7037.3 7001.5 7013.3 7017.4 7020.5 7021.4 6657.9 6906.3 6913.8 6930.3 6948.5 7038.5 7047.9 7065.6 7065.8 7075.6 6696.6 6793.7 6834.1 6840.0 6871.0 11:32:55 INFO - 2016-01-21 11:32:55,749 DEBUG : BROWSER_OUTPUT: 11:32:55 INFO - 2016-01-21 11:32:55,750 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14516.53 Median:52497.48 stddev:17441.66 (33.2%) stddev-sans-first:17459.67 11:32:55 INFO - 2016-01-21 11:32:55,751 DEBUG : BROWSER_OUTPUT: Values: 687.5 835.4 853.1 874.1 935.8 14073.9 14204.6 14285.4 14310.8 14355.6 13406.5 13567.9 14019.4 14184.6 14200.4 910.7 915.7 930.3 930.6 930.8 919.6 922.4 928.1 928.7 929.0 957.2 959.1 959.1 962.2 964.2 945.7 950.3 952.5 953.5 957.3 683.1 695.7 699.5 699.8 708.2 14534.5 14614.9 14656.2 14666.9 14713.6 11845.5 12107.8 12255.0 12390.8 12698.9 9910.7 10122.1 10325.8 10651.3 11082.0 3503.1 3570.0 3584.8 3607.1 3637.8 52201.2 52436.7 52440.5 52554.5 52894.2 9317.7 9409.9 9698.5 9707.5 10195.5 18414.8 18441.4 18480.5 18496.5 18537.1 7589.4 7597.1 7648.3 7771.7 7780.9 4268.9 4354.6 4360.5 4398.2 4504.1 3119.7 3151.7 3159.0 3159.1 3164.2 581.3 591.0 593.2 596.5 598.5 637.4 676.2 677.8 683.5 689.1 8362.6 8498.7 8557.7 8662.4 8855.6 548.9 559.0 675.4 696.9 699.9 4054.0 4118.2 4129.6 4148.5 4298.9 61431.7 61625.4 61781.4 61897.0 62265.0 53563.5 54506.5 54861.7 54939.5 55140.2 48961.0 49158.3 50541.5 53108.0 53639.7 8835.6 8975.9 8989.3 9138.0 9270.2 36436.5 37090.8 37118.6 39273.6 39665.4 47712.8 50293.0 50459.7 50599.7 50995.2 10979.2 11421.5 11549.8 12107.5 12537.4 11154.3 11497.1 11995.3 12077.3 12416.9 10698.3 10792.2 11085.8 11316.9 11459.7 10286.0 10404.8 10560.1 10678.0 10701.9 10620.6 10668.0 10786.5 11220.6 11743.0 8602.8 8610.5 8872.9 8942.9 9590.5 7917.4 8172.6 8229.5 8379.6 8610.7 11:32:55 INFO - 2016-01-21 11:32:55,751 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:55 INFO - 2016-01-21 11:32:55,751 DEBUG : BROWSER_OUTPUT: 11:32:56 INFO - 2016-01-21 11:32:56,428 INFO : Browser exited with error code: 0 11:32:56 INFO - 2016-01-21 11:32:56,447 INFO : Completed test dromaeo_css (00:18:28) 11:32:56 INFO - 2016-01-21 11:32:56,447 INFO : Starting test kraken 11:32:56 INFO - 2016-01-21 11:32:56,447 DEBUG : operating with platform_type : linux_ 11:32:56 INFO - 2016-01-21 11:32:56,447 INFO : Initialising browser for kraken test... 11:32:56 INFO - 2016-01-21 11:32:56,453 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPuhGaI/profile http://localhost:50047/getInfo.html 11:32:59 INFO - 2016-01-21 11:32:59,876 DEBUG : BROWSER_OUTPUT: 11:32:59 INFO - 2016-01-21 11:32:59,876 DEBUG : BROWSER_OUTPUT: (process:416): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:00 INFO - 2016-01-21 11:33:00,638 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:33:00 INFO - 2016-01-21 11:33:00,639 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:33:00 INFO - 2016-01-21 11:33:00,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:33:00 INFO - 2016-01-21 11:33:00,639 DEBUG : BROWSER_OUTPUT: __metrics 11:33:01 INFO - 2016-01-21 11:33:01,612 INFO : Browser initialized. 11:33:01 INFO - 2016-01-21 11:33:01,612 INFO : Running cycle 1/1 for kraken test... 11:33:01 INFO - 2016-01-21 11:33:01,612 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPuhGaI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:33:02 INFO - 2016-01-21 11:33:02,894 DEBUG : BROWSER_OUTPUT: 11:33:02 INFO - 2016-01-21 11:33:02,895 DEBUG : BROWSER_OUTPUT: (process:532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:13 INFO - 2016-01-21 11:33:13,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 136904704 11:33:13 INFO - 2016-01-21 11:33:13,405 DEBUG : BROWSER_OUTPUT: 11:33:15 INFO - 2016-01-21 11:33:15,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50047/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:16 INFO - 2016-01-21 11:33:16,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 11:33:16 INFO - 2016-01-21 11:33:16,442 DEBUG : BROWSER_OUTPUT: 11:33:19 INFO - 2016-01-21 11:33:19,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50047/tests/kraken/driver.html?testName=audio-dft) 11:33:19 INFO - 2016-01-21 11:33:19,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 139669504 11:33:19 INFO - 2016-01-21 11:33:19,614 DEBUG : BROWSER_OUTPUT: 11:33:22 INFO - 2016-01-21 11:33:22,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50047/tests/kraken/driver.html?testName=audio-fft) 11:33:23 INFO - 2016-01-21 11:33:23,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 11:33:23 INFO - 2016-01-21 11:33:23,020 DEBUG : BROWSER_OUTPUT: 11:33:25 INFO - 2016-01-21 11:33:25,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50047/tests/kraken/driver.html?testName=audio-oscillator) 11:33:25 INFO - 2016-01-21 11:33:25,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 139616256 11:33:25 INFO - 2016-01-21 11:33:25,600 DEBUG : BROWSER_OUTPUT: 11:33:27 INFO - 2016-01-21 11:33:27,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:28 INFO - 2016-01-21 11:33:28,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 138469376 11:33:28 INFO - 2016-01-21 11:33:28,366 DEBUG : BROWSER_OUTPUT: 11:33:31 INFO - 2016-01-21 11:33:31,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50047/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:31 INFO - 2016-01-21 11:33:31,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 138309632 11:33:31 INFO - 2016-01-21 11:33:31,867 DEBUG : BROWSER_OUTPUT: 11:33:35 INFO - 2016-01-21 11:33:35,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50047/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:35 INFO - 2016-01-21 11:33:35,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 11:33:35 INFO - 2016-01-21 11:33:35,788 DEBUG : BROWSER_OUTPUT: 11:33:38 INFO - 2016-01-21 11:33:38,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50047/tests/kraken/driver.html?testName=json-parse-financial) 11:33:39 INFO - 2016-01-21 11:33:39,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 11:33:39 INFO - 2016-01-21 11:33:39,186 DEBUG : BROWSER_OUTPUT: 11:33:40 INFO - 2016-01-21 11:33:40,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:41 INFO - 2016-01-21 11:33:41,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 137871360 11:33:41 INFO - 2016-01-21 11:33:41,365 DEBUG : BROWSER_OUTPUT: 11:33:43 INFO - 2016-01-21 11:33:43,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:43 INFO - 2016-01-21 11:33:43,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 138506240 11:33:43 INFO - 2016-01-21 11:33:43,755 DEBUG : BROWSER_OUTPUT: 11:33:45 INFO - 2016-01-21 11:33:45,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:46 INFO - 2016-01-21 11:33:46,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 140234752 11:33:46 INFO - 2016-01-21 11:33:46,395 DEBUG : BROWSER_OUTPUT: 11:33:48 INFO - 2016-01-21 11:33:48,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:49 INFO - 2016-01-21 11:33:49,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 139677696 11:33:49 INFO - 2016-01-21 11:33:49,403 DEBUG : BROWSER_OUTPUT: 11:33:51 INFO - 2016-01-21 11:33:51,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:52 INFO - 2016-01-21 11:33:52,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 11:33:52 INFO - 2016-01-21 11:33:52,512 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50047/tests/kraken/driver.html?testName=ai-astar) 11:33:54 INFO - 2016-01-21 11:33:54,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 139235328 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;110;110;111;122;110;110;111;110 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;126;156;153;128;154;149;126;159;122 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;160;166;161;162;161;164;161 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;73;72;159;74;72;72;73;163;71 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;136;93;93;94;134;92;92;133 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;110;110;109;110 11:33:54 INFO - 2016-01-21 11:33:54,453 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;147;147;146;149;147;146;146 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;97;96;96;97;98;95 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;63;60;61;61;61;62;60;61;59 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;64;65;65;66;65;65;65;65;65 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;83;85;89;81;81;82;88;82 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;113;122;116;120;115;115;120;132;117 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;147;148;147;142;147;150;148;146;136 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;64;70;65;65;66;74;67;64 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,716 11:33:54 INFO - 2016-01-21 11:33:54,454 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404834447__endTimestamp 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:110.50 stddev:4.09 (3.7%) stddev-sans-first:4.34 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 110.0 110.0 111.0 122.0 110.0 110.0 111.0 110.0 11:33:54 INFO - 2016-01-21 11:33:54,455 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.90 Median:151.00 stddev:14.62 (9.7%) stddev-sans-first:15.43 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: Values: 146.0 126.0 156.0 153.0 128.0 154.0 149.0 126.0 159.0 122.0 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.87 (1.2%) stddev-sans-first:1.96 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 160.0 166.0 161.0 162.0 161.0 164.0 161.0 11:33:54 INFO - 2016-01-21 11:33:54,456 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,457 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.80 Median:72.50 stddev:37.08 (51.1%) stddev-sans-first:39.08 11:33:54 INFO - 2016-01-21 11:33:54,457 DEBUG : BROWSER_OUTPUT: Values: 79.0 73.0 72.0 159.0 74.0 72.0 72.0 73.0 163.0 71.0 11:33:54 INFO - 2016-01-21 11:33:54,457 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,457 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:92.50 stddev:20.13 (21.8%) stddev-sans-first:20.77 11:33:54 INFO - 2016-01-21 11:33:54,457 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 136.0 93.0 93.0 94.0 134.0 92.0 92.0 133.0 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 11:33:54 INFO - 2016-01-21 11:33:54,458 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 147.0 147.0 146.0 149.0 147.0 146.0 146.0 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 97.0 96.0 96.0 97.0 98.0 95.0 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: Values: 61.0 63.0 60.0 61.0 61.0 61.0 62.0 60.0 61.0 59.0 11:33:54 INFO - 2016-01-21 11:33:54,459 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.02 (3.7%) stddev-sans-first:3.09 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 83.0 85.0 89.0 81.0 81.0 82.0 88.0 82.0 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:119.50 stddev:5.38 (4.5%) stddev-sans-first:5.71 11:33:54 INFO - 2016-01-21 11:33:54,460 DEBUG : BROWSER_OUTPUT: Values: 119.0 113.0 122.0 116.0 120.0 115.0 115.0 120.0 132.0 117.0 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.00 stddev:3.99 (2.7%) stddev-sans-first:4.21 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 147.0 142.0 147.0 150.0 148.0 146.0 136.0 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:3.11 (4.6%) stddev-sans-first:3.28 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 64.0 70.0 65.0 65.0 66.0 74.0 67.0 64.0 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:33:54 INFO - 2016-01-21 11:33:54,461 DEBUG : BROWSER_OUTPUT: 11:33:55 INFO - 2016-01-21 11:33:55,280 INFO : Browser exited with error code: 0 11:33:55 INFO - 2016-01-21 11:33:55,336 INFO : Completed test kraken (00:00:58) 11:33:55 INFO - 2016-01-21 11:33:55,336 INFO : Starting test v8_7 11:33:55 INFO - 2016-01-21 11:33:55,336 DEBUG : operating with platform_type : linux_ 11:33:55 INFO - 2016-01-21 11:33:55,336 INFO : Initialising browser for v8_7 test... 11:33:55 INFO - 2016-01-21 11:33:55,342 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2E75F6/profile http://localhost:50047/getInfo.html 11:33:58 INFO - 2016-01-21 11:33:58,687 DEBUG : BROWSER_OUTPUT: 11:33:58 INFO - 2016-01-21 11:33:58,688 DEBUG : BROWSER_OUTPUT: (process:852): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:59 INFO - 2016-01-21 11:33:59,532 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:33:59 INFO - 2016-01-21 11:33:59,532 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:33:59 INFO - 2016-01-21 11:33:59,532 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:33:59 INFO - 2016-01-21 11:33:59,532 DEBUG : BROWSER_OUTPUT: __metrics 11:34:00 INFO - 2016-01-21 11:34:00,456 INFO : Browser initialized. 11:34:00 INFO - 2016-01-21 11:34:00,456 INFO : Running cycle 1/1 for v8_7 test... 11:34:00 INFO - 2016-01-21 11:34:00,456 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2E75F6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:34:01 INFO - 2016-01-21 11:34:01,730 DEBUG : BROWSER_OUTPUT: 11:34:01 INFO - 2016-01-21 11:34:01,730 DEBUG : BROWSER_OUTPUT: (process:964): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:34:12 INFO - 2016-01-21 11:34:12,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 137125888 11:34:12 INFO - 2016-01-21 11:34:12,235 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50047/tests/v8_7/run.html (next: http://localhost:50047/tests/v8_7/run.html) 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 135688192 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: |0;Richards;164.79894528675015 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.3102253032929 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 11:34:33 INFO - 2016-01-21 11:34:33,844 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |4;RayTrace;933.7068160597572 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |5;Earley;546.7468562055768 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |6;Boyer;11120.87912087912 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |7;RegExp;24214.285714285714 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |8;Splay;518.6721991701245 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: __startTimestamp1453404873840__endTimestamp 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,845 DEBUG : BROWSER_OUTPUT: Values: 164.8 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.31 Median:173.31 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: Values: 173.3 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: Values: 278.9 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: Values: 5122.4 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:933.71 Median:933.71 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: Values: 933.7 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.75 Median:546.75 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,846 DEBUG : BROWSER_OUTPUT: Values: 546.7 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11120.88 Median:11120.88 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: Values: 11120.9 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24214.29 Median:24214.29 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: Values: 24214.3 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.67 Median:518.67 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: Values: 518.7 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: 11:34:33 INFO - 2016-01-21 11:34:33,847 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 11:34:33 INFO - 2016-01-21 11:34:33,848 DEBUG : BROWSER_OUTPUT: Values: 4822.1 11:34:33 INFO - 2016-01-21 11:34:33,848 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:34:33 INFO - 2016-01-21 11:34:33,848 DEBUG : BROWSER_OUTPUT: 11:34:34 INFO - 2016-01-21 11:34:34,636 INFO : Browser exited with error code: 0 11:34:34 INFO - 2016-01-21 11:34:34,650 INFO : Completed test v8_7 (00:00:39) 11:34:34 INFO - 2016-01-21 11:34:34,880 INFO : Completed test suite (00:20:07) 11:34:34 INFO - 2016-01-21 11:34:34,880 DEBUG : Working with test: dromaeo_css 11:34:34 INFO - 2016-01-21 11:34:34,880 DEBUG : Generating results file: dromaeo_css 11:34:34 INFO - 2016-01-21 11:34:34,881 DEBUG : Working with test: kraken 11:34:34 INFO - 2016-01-21 11:34:34,882 DEBUG : Generating results file: kraken 11:34:34 INFO - 2016-01-21 11:34:34,882 INFO : javascript benchmark 11:34:34 INFO - 2016-01-21 11:34:34,882 DEBUG : Working with test: v8_7 11:34:34 INFO - 2016-01-21 11:34:34,882 DEBUG : Generating results file: v8_7 11:34:34 INFO - 2016-01-21 11:34:34,883 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:34 INFO - 2016-01-21 11:34:34,948 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:34:34 INFO - 2016-01-21 11:34:34,948 DEBUG : process_Request line: dromaeo_css 7244.22 graph.html#tests=[[72,52,43]] 11:34:34 INFO - 2016-01-21 11:34:34,948 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:34 INFO - 2016-01-21 11:34:34,983 DEBUG : process_Request line: kraken 1505.10 graph.html#tests=[[232,52,43]] 11:34:34 INFO - 2016-01-21 11:34:34,983 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:34:35 INFO - 2016-01-21 11:34:35,016 DEBUG : process_Request line: v8_7 23158.74 graph.html#tests=[[230,52,43]] 11:34:35 INFO - 2016-01-21 11:34:35,017 INFO : javascript benchmark 11:34:35 INFO - 2016-01-21 11:34:35,020 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3272.492763621639, 3351.48052051932, 3369.5114208439763, 3383.272596391775, 3384.8984530464086, 5554.472325129116, 5560.86097847554, 5578.804741834037, 5584.776608935637, 5589.189567512708, 5576.191452239423, 5596.636218645795, 5658.0, 5667.149927510875, 5678.176664383662, 5102.285680004802, 5163.612729045337, 5189.247559103927, 5220.947790522103, 5227.5295223429885, 5010.924836127443, 5119.641625086246, 5123.436421993578, 5140.94610604827, 5260.316158899338, 5066.544011039005, 5148.304978827867, 5157.3811142662935, 5166.612504062192, 5172.741362931838, 5103.183490641498, 5170.896582068375, 5182.792688292464, 5204.141316682742, 5217.34783152106, 4934.728589927553, 4966.5778408835295, 5064.822731204427, 5092.236164575306, 5100.336956195708, 5268.683878967274, 5435.565154787608, 5436.755346009439, 5448.700321482317, 5455.945440545584, 5948.226730525047, 5966.820995370146, 6003.369646187131, 6007.639541627516, 6029.276486821609, 5937.910931336033, 6002.759889604411, 6010.639361638316, 6116.5183814016455, 6127.2953610334935, 5664.291963504562, 5667.886642267132, 5674.120511320711, 5678.630888992244, 5678.659280443187, 6088.969555152285, 6140.355262697352, 6141.662208578571, 6152.600080994721, 6153.84615384619, 5729.1119876419225, 5809.854753631109, 5810.5061069809535, 5811.854703632443, 5815.360310365856, 5911.083782013795, 5947.197128387699, 5955.076963070731, 6047.78832740852, 6062.363451837494, 5924.5852790305125, 5975.193348897843, 5981.491573216238, 5982.252218472691, 5995.550333724988, 5734.426557344233, 5960.225170727865, 5992.161097446361, 6013.9699301503215, 6016.729247183887, 4547.47704014036, 4564.612007979293, 4608.631309495232, 4629.166749984967, 4668.0197158597075, 4125.195586860594, 4125.711200216017, 4131.8967025824595, 4157.210130075276, 4173.227952828736, 5569.944300556943, 5643.915341269884, 5759.308882934075, 5764.625299355528, 5772.942270577324, 5900.144479050514, 5913.113033045078, 5980.55145864062, 5984.431479009487, 6050.6974651267265, 5747.166660834156, 5751.367349591542, 5766.163906233573, 5781.756922261734, 5795.652260864362, 5286.577073834084, 5302.0, 5306.867328316823, 5308.814191503279, 5326.92009619856, 5951.821445356646, 6083.513318934474, 6123.648682309606, 6233.906491402633, 6239.0953311770445, 6016.789412370721, 6026.517878569616, 6084.908726369196, 6106.938930610726, 6133.233345831771, 6027.517798576016, 6182.319944806158, 6212.236494651583, 6223.408776166438, 6242.250929888442, 5813.505852002627, 5888.3228428731245, 5982.7307771149535, 6015.909761353671, 6053.788117415869, 6056.36408177135, 6062.575619706578, 6062.757489700362, 6077.908831367621, 6128.080787881853, 5751.971240143773, 5870.911936320873, 5949.018411962151, 5952.851178720567, 5958.791442299672, 5847.853803654943, 5900.675462849585, 5905.114232865105, 5923.318818335946, 5927.555433342431, 5788.594798364074, 5801.361850196559, 5805.767769289181, 5806.709664516842, 5826.446487583673, 5673.8297851064535, 5852.736626851717, 5855.063189889597, 5859.853503662443, 5922.615030023035, 5667.3482549507335, 5747.339056008613, 5762.971185144047, 5769.451902069297, 5773.93182261283], "unit": "ms", "name": "dojo.html", "value": 5543.768693745984}, {"lowerIsBetter": false, "replicates": [544.2598066629386, 589.1192666962891, 624.9093881387198, 633.5628416392689, 663.555417870027, 41956.79021604892, 42831.78584107075, 42934.785326073405, 42961.0, 43005.0, 40763.59236407635, 40875.386869196984, 41041.58958410415, 41201.0, 41248.79375603125, 9006.729798106051, 9115.817683646323, 9147.359684822066, 9188.908110918872, 9257.305702072337, 9096.954515227448, 9171.312151588658, 9173.128552787508, 9181.908180918172, 9182.403143795666, 9128.178463938244, 9134.0, 9239.168474837263, 9241.491717955543, 9244.352895297332, 9065.048169942127, 9076.137766912167, 9112.179903808623, 9154.084591540826, 9159.267258619295, 8934.955325223398, 9088.454692718458, 9100.544972751335, 9114.316426268057, 9167.954160229223, 41010.79494602538, 41137.0, 41234.0, 41533.584664153575, 41588.79205603983, 3423.845926933294, 3504.176518518146, 3579.624139465345, 3787.621237876218, 4254.404383386328, 31548.52677209821, 31841.0, 32226.35547289041, 32292.0, 33123.6687633123, 3431.605365382988, 3491.14466955595, 3497.1956450016382, 3508.0, 3509.8771542995873, 290821.0, 293634.0, 293994.0, 294662.0, 295278.0, 62559.0, 62778.372216277254, 63020.369796302366, 63039.36960630335, 63236.367636323965, 66703.33296667068, 66747.0, 67184.0, 67313.32686673071, 67319.32680673228, 17741.911290443466, 18254.17856196474, 18314.45056648303, 18338.0, 18351.08244587765, 13180.868191317964, 13269.203847769164, 13273.0, 13354.799678004838, 13365.866341336656, 20670.276540321018, 21300.893495532422, 21324.573508529742, 21357.718536887838, 21407.357779266647, 8205.138460461685, 8354.665813367397, 8441.198086181803, 8456.40805143634, 8531.872021919677, 965.753732798132, 1017.9972726864033, 1102.063246240705, 1162.3084264862393, 1171.109956433117, 28730.712692872803, 28998.710012899603, 29249.707502925125, 29424.852875735483, 29835.25411864677, 1068.5084860964043, 1088.6407485529755, 1103.172620534599, 1106.280917403694, 1185.1526158796503, 14236.359363828653, 14443.711125777425, 14494.34775435108, 14583.92708036453, 14681.0, 518543.0, 522889.0, 527549.0, 528960.0, 838331.0, 57145.42854571484, 57986.7100664494, 58131.41868581345, 58307.70846145742, 58387.70806145942, 1466.0836976889443, 1469.9926500367644, 1471.1908450352478, 1477.3351991603822, 1489.2107183192925, 29777.255568610093, 29916.401671966003, 30456.974240370186, 31177.68822311748, 31512.684873150974, 48825.75587122042, 49203.50796492132, 49341.0, 49485.50514494953, 49575.25637115374, 339503.0, 341779.0, 341978.0, 343987.0, 344040.0, 33705.49441758425, 33846.83076584601, 34008.65991340154, 34504.239660827574, 34655.65344346524, 43282.0, 43531.12937741291, 44790.3281450785, 45816.312755309365, 46167.76916115398, 37892.0, 38209.0, 38473.297647205276, 38848.0, 38876.0, 38087.238255235294, 38656.6134338653, 38760.224795504495, 38773.41839872348, 39248.80375598104, 38065.23869522649, 38485.4227186598, 44144.7792761047, 44793.32810007787, 45148.54851451575, 32267.0, 33939.830300848334, 34254.31491370209, 34491.827540862134, 38386.6161338383, 25835.22494325173, 26345.473090538464, 26434.339141521617, 26577.202683919513, 26869.462610747283], "unit": "ms", "name": "ext.html", "value": 20033.48837492904}, {"lowerIsBetter": false, "replicates": [363.1810267846009, 368.3351550451437, 369.30754834684967, 371.737924763042, 375.86656736858424, 16335.83664163358, 18301.35945241917, 18807.62384752306, 18971.33600323989, 19693.50766230843, 17405.390811321606, 17430.302787888468, 17845.286188552443, 17879.82120178801, 18509.814901850976, 5314.282571852798, 5732.197492351074, 5738.282714660668, 5741.483266506014, 5755.338136114337, 5534.612577119603, 5672.886542269152, 5691.4877661010505, 5719.399463056381, 5722.427757224286, 5486.807961721341, 5626.746796394152, 5650.576206784487, 5690.146478028288, 5700.942990570083, 5638.40796716345, 5652.34997975234, 5656.773729050854, 5659.773609055654, 5662.122371032497, 5668.518175955049, 5679.318481782213, 5689.947359738461, 5690.374058853564, 5700.458456446631, 13691.452341906312, 13734.244616546086, 14360.56918292453, 14399.712005759826, 14429.49496767608, 2201.8458707890454, 2208.1719355241785, 2220.6335954567476, 2256.0186318951146, 2387.6896003519605, 10464.215183861164, 10553.0, 10699.83950240747, 10717.356958582432, 10731.517081731263, 1910.570121722615, 1916.2909723402431, 1936.5352315444193, 1950.3856285270235, 1973.6052789442026, 61319.38680613181, 63631.36368636301, 64140.358596413906, 65256.67371663159, 66010.0, 10580.57677692899, 10890.61882834097, 10918.07196388316, 10968.396738179477, 11043.447827608587, 14151.221682807338, 14262.286885655676, 14276.143431393943, 14348.139111653334, 14357.56927292183, 8012.759617211493, 8102.513849169069, 8292.709755158541, 8297.95851020741, 8343.582820859054, 8011.799705007422, 8328.583570821434, 8350.206730360727, 8358.871552340357, 8539.14608539141, 4668.743219122913, 4731.526847315241, 4731.858044258678, 4748.833790817304, 4912.778924948315, 1928.3732786844332, 1978.7625484941611, 2036.307655397172, 2054.7842476540045, 2054.9622440667667, 936.5925822267335, 998.286225348879, 1010.7624708193568, 1032.3599368391494, 1069.4706120470416, 11999.460024298927, 12111.0, 12201.69495762613, 12202.084843636763, 17697.0, 452.12513785824535, 475.9928601070987, 478.4712892254079, 480.61310644931166, 501.8444282272507, 6054.878902421927, 6213.347598502182, 6217.316095229521, 6332.936670633235, 6454.451371633464, 612124.0, 613514.0, 623650.0, 626175.0, 657018.0, 86595.13404865997, 90865.54567227121, 91404.0, 92634.53682731543, 94505.0, 516.7984486050443, 526.6524094097877, 526.7392640642983, 527.2670987327617, 527.9604029697788, 11215.943920280673, 11548.711282218012, 16625.251863665922, 17194.22625981809, 17284.222210000327, 36440.0, 38426.61573384231, 38603.0, 38714.41928371133, 39155.6084439152, 42373.0, 43069.569304306555, 43941.340879886186, 45013.549864502245, 47968.0, 10852.782944340912, 10930.890691092987, 10947.890521094687, 10949.069329106796, 11172.608958686407, 17801.910990444965, 18210.0, 18446.26214951387, 18494.630107398047, 18844.246230150642, 15036.924815376291, 15623.218839058229, 15778.211089445711, 15799.289031993358, 15919.920400397923, 13165.0, 13721.245331506863, 15333.539993800205, 15441.5367538974, 15784.526464206092, 14871.18208498543, 15011.849881501483, 15188.924055380094, 15331.846681533489, 15458.0, 9230.261579073524, 9315.301352398732, 9454.527273636428, 9507.049295070437, 9561.521923903916, 11183.161262905478, 11228.88771112311, 13629.591112266648, 14583.92708036453, 14766.409343626565], "unit": "ms", "name": "jquery.html", "value": 8741.247418459572}, {"lowerIsBetter": false, "replicates": [1484.480431848853, 1490.6869557392947, 1655.3213182595139, 1775.7957834848992, 1822.407717491815, 6709.932900670992, 6850.1779786425695, 7002.334778196069, 7412.777616671495, 7427.0, 7425.183229844726, 7570.5079169853925, 7618.809529761758, 7665.041869766279, 7689.769306920802, 2266.977330226697, 2331.3239160643393, 2338.9064437422485, 2339.1462116327502, 2343.5781559319316, 2332.416895776056, 2358.7523310052457, 2390.725066617335, 2397.3646983549374, 2405.807535397164, 2257.808086312665, 2273.920412785553, 2305.2162264829954, 2315.235972129193, 2325.5232677301115, 2302.654601809742, 2315.9536809263805, 2320.303908827345, 2347.9765202348012, 2356.3402247370677, 2321.605327094398, 2350.74141844397, 2352.6000579901456, 2353.352827972304, 2368.052778888441, 7816.413768967293, 7902.012248468942, 7902.960485197537, 7922.485038472539, 7955.721549745789, 4611.654125940568, 4654.325122857201, 4662.393888794469, 4694.155052090622, 4696.3894693689945, 2918.5330347144354, 2924.2981684395804, 2930.194196595953, 2937.911862644124, 2959.7484213841635, 943.3396622364372, 947.4031360243072, 957.1959553974694, 959.3764053365298, 984.4683870709808, 10178.592856285739, 10185.745356366077, 10191.03185197405, 10222.69331920051, 10223.488825558692, 4185.832566697359, 4210.473690788652, 4219.894502637459, 4239.38528913312, 4242.193983143255, 8788.692395766118, 8795.296376289882, 8830.646774128963, 8833.911660883437, 8838.690645827364, 4630.560096790799, 4636.9536304637195, 4653.162430762428, 4673.158831410379, 4687.95312046882, 4223.092035212444, 4226.598473145108, 4308.095299987038, 4311.1808756336195, 4342.5657434256955, 3649.0, 3662.322470342942, 3667.1015601177883, 3673.3204357194004, 3695.501107350527, 1112.4993752811267, 1123.8370436286693, 1124.7806677697934, 1124.9550017999188, 1128.3793913347627, 1382.7787553991313, 1387.6600232942994, 1394.8047273381533, 1403.6771542545068, 1418.9574312770633, 7093.077899872984, 7273.963630181921, 7278.708851645981, 7279.672414741243, 7315.707371705179, 485.922252439608, 488.4773292576909, 493.8567815333585, 494.3474613510204, 506.5112166759022, 5781.653100813881, 5802.854928626818, 5843.3864444233595, 5847.26909136358, 5850.912236316459, 9033.593488293043, 9567.760805979906, 9575.186109180797, 9687.370320929118, 9699.660511882192, 9424.0, 9441.811163776685, 9476.147146756824, 9526.095020972996, 9601.087896649808, 7447.0, 7526.473146879666, 7554.169041405331, 7570.129435115033, 7638.847223055619, 7193.784186474414, 7319.341259286477, 7323.8535229296185, 7334.6699398526125, 7346.7061317546695, 8391.58042097905, 8472.788180295296, 8500.14998500145, 8563.657453701782, 8584.270337021173, 8679.652813887375, 8698.91301086981, 8700.173483519056, 8813.42712723671, 8833.955830220808, 6119.571629985859, 6206.503479721701, 6624.668766561749, 6740.0, 6834.2482326943, 7537.9623101884135, 7561.962190189014, 7579.204183560647, 7626.923730762622, 7649.732259370895, 7077.115360579927, 7192.172900116553, 7215.639218039182, 7329.450291228286, 7336.413086953137, 7103.50275480732, 7135.6432178391915, 7154.785356439315, 7227.927720722725, 7230.6384680764695, 7141.9644151596685, 7143.821404464722, 7189.137303523611, 7196.748113815991, 7214.242504536948, 6584.078229048033, 6608.933910660832, 6615.503837212132, 6640.435562977201, 6641.302663220486, 6522.836929076811, 6534.085228068169, 6554.606723596599, 6645.069690243273, 6735.326467353226], "unit": "ms", "name": "mootools.html", "value": 4420.246734397902}, {"lowerIsBetter": false, "replicates": [344.20145262989865, 351.8610148991149, 352.74770589784254, 354.36037951497536, 358.7022771099987, 6361.809145725624, 6449.097126402302, 6506.089147519351, 6508.38170373815, 6565.277819439863, 6202.224721909762, 6382.106505089279, 6385.457236134934, 6413.711382987765, 6432.903506447407, 4895.6083513318845, 4922.187839006559, 4935.851924442272, 4941.234108713137, 4948.604111671076, 4923.18767403378, 4955.405351357842, 4959.925601115986, 4960.305557221992, 4968.577670897978, 4699.7415142167165, 4817.735024573647, 4845.685030473008, 4848.20004699226, 4886.853394398174, 4814.614830813526, 4842.782074806642, 4849.321095046696, 4849.515048495157, 4866.926996095061, 4185.644220241283, 4227.408162857202, 4229.323308270693, 4232.788360581959, 4247.384129301234, 6038.57729958903, 6107.198376478949, 6141.785037523665, 6144.446999769997, 6159.568830181889, 5614.101743720985, 5615.6630602164005, 5635.09838425854, 5657.0, 5666.093425052013, 6813.318668133147, 6817.965910170467, 6833.760818371333, 6848.520603557753, 6855.760048398332, 4678.3216433616935, 4691.62467002639, 4694.29585562165, 4694.389729335198, 4696.154692155411, 6914.204866440374, 7026.016357709925, 7078.221395646475, 7139.89290160648, 7144.178419481774, 4768.0, 4776.785044672998, 4776.832810851603, 4777.163996300634, 4790.113828941657, 4771.284307353924, 4804.399450068741, 4810.037992401533, 4818.373611430492, 4826.0, 5536.114221724585, 5624.465675760796, 5628.071368224197, 5631.774729010794, 5666.801661941812, 6916.930830691729, 6923.2038315594355, 6923.4807389446, 6928.307169283132, 6929.653517324114, 1594.545554516957, 1652.140886738889, 1665.6585399993214, 1714.8113707492166, 1715.4682048564985, 1098.0556721219746, 1129.0967226218993, 1142.4344949250174, 1146.9655910322704, 1150.269578817457, 6622.072909792633, 6640.269570347258, 6655.334466553403, 6658.234303055114, 6670.332966703291, 6978.825529361807, 7011.053507776385, 7030.2969703029285, 7037.1555413350725, 7048.577085374894, 6535.411812936859, 6537.542372033912, 6589.242237142694, 6590.769323073765, 6670.466362690973, 3795.6204379561823, 3843.9039024024064, 3874.1283211277237, 3876.5154355705536, 3883.0680636647003, 7278.199398066208, 7279.0, 7282.815155453342, 7283.417326613858, 7302.05073340473, 7173.748918787817, 7181.533200341961, 7187.425005999507, 7209.567425954459, 7429.554226746304, 7366.079240094989, 7420.5547667140145, 7424.851502969802, 7447.813804654818, 7448.5158464699625, 7213.71145154188, 7215.170255420694, 7249.311315425026, 7250.238724934017, 7254.637268136466, 6913.79258622222, 7071.575705457689, 7116.537425067354, 7117.750878719427, 7121.145462544528, 7413.221611730691, 7423.035005449257, 7427.034485516848, 7435.51669141504, 7441.739539116105, 4779.952200477951, 4809.639277054305, 4816.34979277793, 4824.927626085541, 4825.10735513931, 7019.4735394844565, 7082.079329687108, 7215.494915355875, 7220.783376498714, 7244.529105608119, 6966.686499107654, 6994.090768200102, 7019.262977387505, 7036.261192574911, 7037.331453511908, 7001.544899581511, 7013.333733295329, 7017.3684368407085, 7020.543664661781, 7021.368076873106, 6657.866842663217, 6906.274841141608, 6913.827154321182, 6930.306969303231, 6948.478864085315, 7038.542494737826, 7047.859042819013, 7065.611391373318, 7065.788026359218, 7075.610841403566, 6696.5647232929705, 6793.694283757144, 6834.111565496453, 6839.965800170968, 6871.0], "unit": "ms", "name": "prototype.html", "value": 5161.037586571292}, {"lowerIsBetter": false, "replicates": [687.5359132585504, 835.3776436554767, 853.1212850763716, 874.0647507167331, 935.7894473743406, 14073.859261407382, 14204.644883877909, 14285.428582856674, 14310.785338219908, 14355.641108972268, 13406.530771422978, 13567.932160339209, 14019.369128389222, 14184.574462766133, 14200.431982720678, 910.7313342563959, 915.7390143808999, 930.2650905784423, 930.6417029443645, 930.8277968575801, 919.6321471411422, 922.3681777982071, 928.0811996123823, 928.7120992492349, 928.9767755806125, 957.2294303086013, 959.0936564946094, 959.1463597398321, 962.2494454325637, 964.2286171063156, 945.6737425588161, 950.2825366848055, 952.4570994533119, 953.50894289441, 957.2724729205819, 683.0607914118087, 695.7425752471618, 699.4544255480733, 699.7690762048512, 708.1608294171423, 14534.491292804702, 14614.853851461456, 14656.193909334983, 14666.926665366605, 14713.55859324222, 11845.526178952832, 12107.757844843054, 12255.0, 12390.81413778794, 12698.920591749713, 9910.659456033009, 10122.139618132467, 10325.79348413035, 10651.307665001828, 11082.0, 3503.1242189452637, 3569.982150089233, 3584.8386822592784, 3607.134287770942, 3637.836297366625, 52201.2169817453, 52436.737816311055, 52440.47559524432, 52554.474455255724, 52894.20658690123, 9317.72046838596, 9409.858852117224, 9698.496733006396, 9707.514624268899, 10195.490225488844, 18414.81585184131, 18441.446756597055, 18480.537986550444, 18496.537586560444, 18537.073146342627, 7589.43079269046, 7597.126330472067, 7648.311651951351, 7771.72798952034, 7780.949571807733, 4268.914621707549, 4354.608085272341, 4360.520342762294, 4398.186335527874, 4504.144212599595, 3119.688031196862, 3151.7163455289133, 3159.020703581851, 3159.1470303018054, 3164.2089477630593, 581.3198557687516, 591.0366103251758, 593.2199158107076, 596.4929809661753, 598.5421152818097, 637.4390536328002, 676.2290988273372, 677.7695583501633, 683.4771399879096, 689.1489011071423, 8362.623681934327, 8498.69112563195, 8557.743267701979, 8662.436941598777, 8855.645774168961, 548.9478499542537, 559.0, 675.3550359406755, 696.9407600354027, 699.867025265198, 4053.959460405358, 4118.217538667644, 4129.607687269765, 4148.481439820022, 4298.935515967263, 61431.69284153551, 61625.383746162865, 61781.382186177565, 61897.0, 62265.0, 53563.46436535662, 54506.454935450136, 54861.725691371284, 54939.45060549423, 55140.17289740657, 48961.0, 49158.26262605992, 50541.49458505442, 53107.99999999923, 53639.73180134074, 8835.602397891982, 8975.865362019444, 8989.28085753125, 9137.954310228406, 9270.212031977087, 36436.45345319769, 37090.814545927096, 37118.62881371152, 39273.60726392814, 39665.40501892532, 47712.761436192595, 50293.0, 50459.74770126126, 50599.699025581765, 50995.2350714747, 10979.231453798158, 11421.543138274375, 11549.769004619693, 12107.455164517442, 12537.435815388148, 11154.330740155616, 11497.137714671266, 11995.280283183038, 12077.27536347822, 12416.937915310365, 10698.251122421356, 10792.190585705946, 11085.833712494157, 11316.94341528287, 11459.656210313704, 10286.022827831344, 10404.843927340944, 10560.102391296827, 10678.0, 10701.946490267499, 10620.628278010232, 10668.0, 10786.514606842868, 11220.607278745205, 11743.0, 8602.827943441222, 8610.48337099751, 8872.911270887209, 8942.86585701228, 9590.520473976412, 7917.44577879566, 8172.550509722022, 8229.46508476947, 8379.58102094905, 8610.698625548075], "unit": "ms", "name": "yui.html", "value": 6525.185814220753}], "name": "dromaeo_css", "value": 7244.2218606195775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 110.0, 111.0, 122.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [146.0, 126.0, 156.0, 153.0, 128.0, 154.0, 149.0, 126.0, 159.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 166.0, 161.0, 162.0, 161.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 72.0, 159.0, 74.0, 72.0, 72.0, 73.0, 163.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 93.0, 93.0, 94.0, 134.0, 92.0, 92.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 149.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 98.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 63.0, 60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 85.0, 89.0, 81.0, 81.0, 82.0, 88.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [119.0, 113.0, 122.0, 116.0, 120.0, 115.0, 115.0, 120.0, 132.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 142.0, 147.0, 150.0, 148.0, 146.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 64.0, 70.0, 65.0, 65.0, 66.0, 74.0, 67.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1505.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.79894528675015], "unit": "score", "name": "Richards", "value": 214.21253599999997}, {"lowerIsBetter": false, "replicates": [173.3102253032929], "unit": "score", "name": "DeltaBlue", "value": 381.5008599999999}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [933.7068160597572], "unit": "score", "name": "RayTrace", "value": 792.5282190000003}, {"lowerIsBetter": false, "replicates": [546.7468562055768], "unit": "score", "name": "Earley", "value": 1218.960827}, {"lowerIsBetter": false, "replicates": [11120.87912087912], "unit": "score", "name": "Boyer", "value": 59.92898517786557}, {"lowerIsBetter": false, "replicates": [24214.285714285714], "unit": "score", "name": "RegExp", "value": 37.621799410029524}, {"lowerIsBetter": false, "replicates": [518.6721991701245], "unit": "score", "name": "Splay", "value": 157.114648}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23158.739614903625}]} 11:34:35 INFO - RETURN: dromaeo_css: 7244.22 11:34:35 INFO - RETURN: kraken: 1505.10 11:34:35 INFO - RETURN: v8_7: 23158.74 11:34:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23158.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1505.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7244.22"}}} 11:34:35 INFO - Return code: 0 11:34:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:34:35 INFO - # TBPL SUCCESS # 11:34:35 INFO - Running post-action listener: _resource_record_post_action 11:34:35 INFO - Running post-run listener: _resource_record_post_run 11:34:36 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 512385024; Read time: 0; Write time: 433636 11:34:36 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 247255040; Read time: 0; Write time: 254140 11:34:36 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 265129984; Read time: 0; Write time: 179496 11:34:36 INFO - Running post-run listener: _upload_blobber_files 11:34:36 INFO - Blob upload gear active. 11:34:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:34:36 INFO - Copying logs to upload dir... 11:34:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.448129 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-01-21 11:34:35.439816) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:34:35.443709) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009965 build_url: 'https://queue.taskcluster.net/v1/task/WWk93IK-RJi3LaDS4_zDMg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:34:35.496818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:34:35.497171) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1453403615.862749-1246448476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:34:35.549327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:34:35.549954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:34:35.550424) ========= ========= Total master_lag: 0.52 =========