builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1453374492.73 results: success (0) buildid: 20160121004039 builduid: 7f6ed012afb9410a9f73864a04621556 revision: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.732457) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.732856) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.733160) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006373 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.765367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.765686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.801639) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.801913) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026496 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.852801) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.853078) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.853435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.853727) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 03:08:12-- 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% 12.2M=0.001s 2016-01-21 03:08:13 (12.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.976173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:12.976464) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.123243 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.112050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.112373) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 --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 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 --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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 03:08:13,274 truncating revision to first 12 chars 2016-01-21 03:08:13,274 Setting DEBUG logging. 2016-01-21 03:08:13,274 attempt 1/10 2016-01-21 03:08:13,275 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7fc6b3d4c26f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 03:08:13,536 unpacking tar archive at: mozilla-aurora-7fc6b3d4c26f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577009 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.707969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.708282) ========= echo 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7'] 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 program finished with exit code 0 elapsedTime=0.004607 script_repo_revision: '7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.758879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.759175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.769481) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.769769) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 03:08:13.770152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-21 03:08:13.770436) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:14 INFO - MultiFileLogger online at 20160121 03:08:14 in /builds/slave/test-pgo 03:08:14 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 03:08:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:08:14 INFO - {'append_to_log': False, 03:08:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:08:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:08:14 INFO - 'branch': 'Mozilla-Aurora', 03:08:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:14 INFO - 'config_files': ('talos/linux_config.py',), 03:08:14 INFO - 'default_actions': ('clobber', 03:08:14 INFO - 'read-buildbot-config', 03:08:14 INFO - 'download-and-extract', 03:08:14 INFO - 'populate-webroot', 03:08:14 INFO - 'create-virtualenv', 03:08:14 INFO - 'install', 03:08:14 INFO - 'run-tests'), 03:08:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:14 INFO - 'download_minidump_stackwalk': True, 03:08:14 INFO - 'download_symbols': 'ondemand', 03:08:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:14 INFO - 'installer_path': 'installer.exe', 03:08:14 INFO - 'log_level': 'info', 03:08:14 INFO - 'log_name': 'talos', 03:08:14 INFO - 'log_to_console': True, 03:08:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:14 INFO - 'opt_config_files': (), 03:08:14 INFO - 'pip_index': False, 03:08:14 INFO - 'sps_profile': False, 03:08:14 INFO - 'sps_profile_interval': 0, 03:08:14 INFO - 'suite': 'dromaeojs-e10s', 03:08:14 INFO - 'system_bits': '32', 03:08:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:14 INFO - 'title': 'talos-linux64-ix-014', 03:08:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:14 INFO - 'use_talos_json': True, 03:08:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:08:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:14 INFO - 'work_dir': 'build'} 03:08:14 INFO - ##### 03:08:14 INFO - ##### Running clobber step. 03:08:14 INFO - ##### 03:08:14 INFO - Running pre-action listener: _resource_record_pre_action 03:08:14 INFO - Running main action method: clobber 03:08:14 INFO - rmtree: /builds/slave/test-pgo/build 03:08:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:08:18 INFO - Running post-action listener: _resource_record_post_action 03:08:18 INFO - ##### 03:08:18 INFO - ##### Running read-buildbot-config step. 03:08:18 INFO - ##### 03:08:18 INFO - Running pre-action listener: _resource_record_pre_action 03:08:18 INFO - Running main action method: read_buildbot_config 03:08:18 INFO - Using buildbot properties: 03:08:18 INFO - { 03:08:18 INFO - "properties": { 03:08:18 INFO - "buildnumber": 66, 03:08:18 INFO - "product": "firefox", 03:08:18 INFO - "script_repo_revision": "production", 03:08:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:08:18 INFO - "repository": "", 03:08:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:08:18 INFO - "buildid": "20160121004039", 03:08:18 INFO - "slavename": "talos-linux64-ix-014", 03:08:18 INFO - "stage_platform": "linux64-pgo", 03:08:18 INFO - "basedir": "/builds/slave/test-pgo", 03:08:18 INFO - "nightly_build": "True", 03:08:18 INFO - "project": "", 03:08:18 INFO - "platform": "ubuntu64_hw", 03:08:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:08:18 INFO - "slavebuilddir": "test", 03:08:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:18 INFO - "branch": "mozilla-aurora", 03:08:18 INFO - "repo_path": "releases/mozilla-aurora", 03:08:18 INFO - "pgo_build": "True", 03:08:18 INFO - "builduid": "7f6ed012afb9410a9f73864a04621556", 03:08:18 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 03:08:18 INFO - }, 03:08:18 INFO - "sourcestamp": { 03:08:18 INFO - "repository": "", 03:08:18 INFO - "hasPatch": false, 03:08:18 INFO - "project": "", 03:08:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:18 INFO - "changes": [ 03:08:18 INFO - { 03:08:18 INFO - "category": null, 03:08:18 INFO - "files": [ 03:08:18 INFO - { 03:08:18 INFO - "url": null, 03:08:18 INFO - "name": "https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:08:18 INFO - } 03:08:18 INFO - ], 03:08:18 INFO - "repository": "", 03:08:18 INFO - "rev": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7", 03:08:18 INFO - "who": "sendchange", 03:08:18 INFO - "when": 1453374469, 03:08:18 INFO - "number": 7491776, 03:08:18 INFO - "comments": "", 03:08:18 INFO - "project": "", 03:08:18 INFO - "at": "Thu 21 Jan 2016 03:07:49", 03:08:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:08:18 INFO - "revlink": "", 03:08:18 INFO - "properties": [ 03:08:18 INFO - [ 03:08:18 INFO - "buildid", 03:08:18 INFO - "20160121004039", 03:08:18 INFO - "Change" 03:08:18 INFO - ], 03:08:18 INFO - [ 03:08:18 INFO - "builduid", 03:08:18 INFO - "7f6ed012afb9410a9f73864a04621556", 03:08:18 INFO - "Change" 03:08:18 INFO - ], 03:08:18 INFO - [ 03:08:18 INFO - "nightly_build", 03:08:18 INFO - "True", 03:08:18 INFO - "Change" 03:08:18 INFO - ], 03:08:18 INFO - [ 03:08:18 INFO - "pgo_build", 03:08:18 INFO - "True", 03:08:18 INFO - "Change" 03:08:18 INFO - ] 03:08:18 INFO - ], 03:08:18 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 03:08:18 INFO - } 03:08:18 INFO - ], 03:08:18 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 03:08:18 INFO - } 03:08:18 INFO - } 03:08:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:08:18 INFO - Running post-action listener: _resource_record_post_action 03:08:18 INFO - ##### 03:08:18 INFO - ##### Running download-and-extract step. 03:08:18 INFO - ##### 03:08:18 INFO - Running pre-action listener: _resource_record_pre_action 03:08:18 INFO - Running main action method: download_and_extract 03:08:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:18 INFO - https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/test_packages.json 03:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/test_packages.json 03:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:08:19 INFO - Downloaded 1302 bytes. 03:08:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:08:19 INFO - Using the following test package requirements: 03:08:19 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:19 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:19 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'jsshell-linux-x86_64.zip'], 03:08:19 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:19 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:19 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:08:19 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:08:19 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:19 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:19 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:19 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:19 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:19 INFO - https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:36 INFO - Downloaded 23160820 bytes. 03:08:36 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 03:08:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:36 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 03:08:37 INFO - Return code: 0 03:08:37 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 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:39 INFO - Downloaded 23160820 bytes. 03:08:39 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 03:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:08:39 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 03:08:40 INFO - Return code: 0 03:08: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')]} 03:08:40 INFO - https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:41 INFO - Downloaded 11132038 bytes. 03:08:41 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 03:08:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:41 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 03:08:41 INFO - Return code: 0 03:08: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')]} 03:08:41 INFO - https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:08:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:08:44 INFO - Downloaded 58116804 bytes. 03:08:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:44 INFO - mkdir: /builds/slave/test-pgo/properties 03:08:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:08:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:08:44 INFO - Contents: 03:08:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:08:44 INFO - Running post-action listener: _resource_record_post_action 03:08:44 INFO - Running post-action listener: set_extra_try_arguments 03:08:44 INFO - ##### 03:08:44 INFO - ##### Running populate-webroot step. 03:08:44 INFO - ##### 03:08:44 INFO - Running pre-action listener: _resource_record_pre_action 03:08:44 INFO - Running main action method: populate_webroot 03:08:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:44 INFO - '--tppagecycles', 03:08:44 INFO - '7'], 03:08:44 INFO - 'tests': ['tsvgm']}}, 03:08:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:08:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:08:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'tests': ['damp', 'tps']}, 03:08:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['damp', 'tps']}, 03:08:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:08:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:44 INFO - 'other': {'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'other_l64': {'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'other_nol64': {'tests': ['a11yr', 03:08:44 INFO - 'ts_paint', 03:08:44 INFO - 'tpaint', 03:08:44 INFO - 'sessionrestore', 03:08:44 INFO - 'sessionrestore_no_auto_restore']}, 03:08:44 INFO - 'svgr': {'tests': ['tsvgx', 03:08:44 INFO - 'tsvgr_opacity', 03:08:44 INFO - 'tart', 03:08:44 INFO - 'tscrollx', 03:08:44 INFO - 'cart']}, 03:08:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['tsvgx', 03:08:44 INFO - 'tsvgr_opacity', 03:08:44 INFO - 'tart', 03:08:44 INFO - 'tscrollx', 03:08:44 INFO - 'cart']}, 03:08:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'tests': ['tp5o']}, 03:08:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'talos_options': ['--e10s'], 03:08:44 INFO - 'tests': ['tp5o']}, 03:08:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'talos_options': ['--xperf_path', 03:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:44 INFO - 'tests': ['tp5n']}, 03:08:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:44 INFO - 'talos_options': ['--e10s', 03:08:44 INFO - '--xperf_path', 03:08:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:44 INFO - 'tests': ['tp5n']}}, 03:08:44 INFO - 'talos.zip': {'path': '', 03:08:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:44 INFO - Running post-action listener: _resource_record_post_action 03:08:44 INFO - ##### 03:08:44 INFO - ##### Running create-virtualenv step. 03:08:44 INFO - ##### 03:08:44 INFO - Running pre-action listener: _resource_record_pre_action 03:08:44 INFO - Running main action method: create_virtualenv 03:08:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:08:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:08:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:08:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:44 INFO - Using real prefix '/usr' 03:08:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:08:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:46 INFO - Installing pip.................done. 03:08:46 INFO - Return code: 0 03:08:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:46 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08:46 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 03:08:46 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 03:08:46 INFO - Using env: {'DISPLAY': ':0', 03:08:46 INFO - 'HOME': '/home/cltbld', 03:08:46 INFO - 'LANG': 'en_US.UTF-8', 03:08:46 INFO - 'LANGUAGE': 'en_US:en', 03:08:46 INFO - 'LOGNAME': 'cltbld', 03:08:46 INFO - 'MAIL': '/var/mail/cltbld', 03:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:46 INFO - 'MOZ_NO_REMOTE': '1', 03:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:46 INFO - 'NO_EM_RESTART': '1', 03:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:46 INFO - 'SHELL': '/bin/bash', 03:08:46 INFO - 'SHLVL': '1', 03:08:46 INFO - 'TERM': 'linux', 03:08:46 INFO - 'TMOUT': '86400', 03:08:46 INFO - 'USER': 'cltbld', 03:08:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:46 INFO - '_': '/tools/buildbot/bin/python'} 03:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:08:46 INFO - Cleaning up... 03:08:46 INFO - Return code: 0 03:08:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:46 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08:46 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 03:08:46 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 03:08:46 INFO - Using env: {'DISPLAY': ':0', 03:08:46 INFO - 'HOME': '/home/cltbld', 03:08:46 INFO - 'LANG': 'en_US.UTF-8', 03:08:46 INFO - 'LANGUAGE': 'en_US:en', 03:08:46 INFO - 'LOGNAME': 'cltbld', 03:08:46 INFO - 'MAIL': '/var/mail/cltbld', 03:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:46 INFO - 'MOZ_NO_REMOTE': '1', 03:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:46 INFO - 'NO_EM_RESTART': '1', 03:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:46 INFO - 'SHELL': '/bin/bash', 03:08:46 INFO - 'SHLVL': '1', 03:08:46 INFO - 'TERM': 'linux', 03:08:46 INFO - 'TMOUT': '86400', 03:08:46 INFO - 'USER': 'cltbld', 03:08:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:46 INFO - '_': '/tools/buildbot/bin/python'} 03:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:47 INFO - Downloading/unpacking psutil>=0.7.1 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:48 INFO - Installing collected packages: psutil 03:08:48 INFO - Running setup.py install for psutil 03:08:48 INFO - building 'psutil._psutil_linux' extension 03:08:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:08:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:08:49 INFO - building 'psutil._psutil_posix' extension 03:08:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:08:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:08:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:49 INFO - Successfully installed psutil 03:08:49 INFO - Cleaning up... 03:08:49 INFO - Return code: 0 03:08:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:49 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08:49 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 03:08:49 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 03:08:49 INFO - Using env: {'DISPLAY': ':0', 03:08:49 INFO - 'HOME': '/home/cltbld', 03:08:49 INFO - 'LANG': 'en_US.UTF-8', 03:08:49 INFO - 'LANGUAGE': 'en_US:en', 03:08:49 INFO - 'LOGNAME': 'cltbld', 03:08:49 INFO - 'MAIL': '/var/mail/cltbld', 03:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:49 INFO - 'MOZ_NO_REMOTE': '1', 03:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:49 INFO - 'NO_EM_RESTART': '1', 03:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:49 INFO - 'SHELL': '/bin/bash', 03:08:49 INFO - 'SHLVL': '1', 03:08:49 INFO - 'TERM': 'linux', 03:08:49 INFO - 'TMOUT': '86400', 03:08:49 INFO - 'USER': 'cltbld', 03:08:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:49 INFO - '_': '/tools/buildbot/bin/python'} 03:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:08:51 INFO - Installing collected packages: mozsystemmonitor 03:08:51 INFO - Running setup.py install for mozsystemmonitor 03:08:51 INFO - Successfully installed mozsystemmonitor 03:08:51 INFO - Cleaning up... 03:08:51 INFO - Return code: 0 03:08:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:08: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')]} 03:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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', '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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:08: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 blobuploader==1.2.4 03:08:51 INFO - Using env: {'DISPLAY': ':0', 03:08:51 INFO - 'HOME': '/home/cltbld', 03:08:51 INFO - 'LANG': 'en_US.UTF-8', 03:08:51 INFO - 'LANGUAGE': 'en_US:en', 03:08:51 INFO - 'LOGNAME': 'cltbld', 03:08:51 INFO - 'MAIL': '/var/mail/cltbld', 03:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:51 INFO - 'MOZ_NO_REMOTE': '1', 03:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:51 INFO - 'NO_EM_RESTART': '1', 03:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:51 INFO - 'SHELL': '/bin/bash', 03:08:51 INFO - 'SHLVL': '1', 03:08:51 INFO - 'TERM': 'linux', 03:08:51 INFO - 'TMOUT': '86400', 03:08:51 INFO - 'USER': 'cltbld', 03:08:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:51 INFO - '_': '/tools/buildbot/bin/python'} 03:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08: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 03:08:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:08:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:54 INFO - Downloading docopt-0.6.1.tar.gz 03:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:54 INFO - Running setup.py install for blobuploader 03:08:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:08:54 INFO - Running setup.py install for requests 03:08:54 INFO - Running setup.py install for docopt 03:08:54 INFO - Successfully installed blobuploader requests docopt 03:08:54 INFO - Cleaning up... 03:08:54 INFO - Return code: 0 03:08:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:54 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08:54 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 03:08:54 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 03:08:54 INFO - Using env: {'DISPLAY': ':0', 03:08:54 INFO - 'HOME': '/home/cltbld', 03:08:54 INFO - 'LANG': 'en_US.UTF-8', 03:08:54 INFO - 'LANGUAGE': 'en_US:en', 03:08:54 INFO - 'LOGNAME': 'cltbld', 03:08:54 INFO - 'MAIL': '/var/mail/cltbld', 03:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:54 INFO - 'MOZ_NO_REMOTE': '1', 03:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:54 INFO - 'NO_EM_RESTART': '1', 03:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:54 INFO - 'SHELL': '/bin/bash', 03:08:54 INFO - 'SHLVL': '1', 03:08:54 INFO - 'TERM': 'linux', 03:08:54 INFO - 'TMOUT': '86400', 03:08:54 INFO - 'USER': 'cltbld', 03:08:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:54 INFO - '_': '/tools/buildbot/bin/python'} 03:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:55 INFO - Running setup.py (path:/tmp/pip-xLSLrm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:55 INFO - Running setup.py (path:/tmp/pip-iiDFIW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:55 INFO - Running setup.py (path:/tmp/pip-XZ2cky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:55 INFO - Running setup.py (path:/tmp/pip-0zuhoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:55 INFO - Running setup.py (path:/tmp/pip-K0DZbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:55 INFO - Running setup.py (path:/tmp/pip-eZJIbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:55 INFO - Running setup.py (path:/tmp/pip-iTOy0H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:55 INFO - Running setup.py (path:/tmp/pip-beHcxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:55 INFO - Running setup.py (path:/tmp/pip-G1L_Iq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:55 INFO - Running setup.py (path:/tmp/pip-uoKcFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:55 INFO - Running setup.py (path:/tmp/pip-X7dER7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:55 INFO - Running setup.py (path:/tmp/pip-15k15z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:55 INFO - Running setup.py (path:/tmp/pip-XETvXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:56 INFO - Running setup.py (path:/tmp/pip-on81Da-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:56 INFO - Running setup.py (path:/tmp/pip-IgSWPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:56 INFO - Running setup.py (path:/tmp/pip-l46K9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:56 INFO - Running setup.py (path:/tmp/pip-Pwte4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:56 INFO - Running setup.py install for manifestparser 03:08:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:08:56 INFO - Running setup.py install for mozcrash 03:08:56 INFO - Running setup.py install for mozdebug 03:08:56 INFO - Running setup.py install for mozdevice 03:08:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:08:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:08:56 INFO - Running setup.py install for mozfile 03:08:56 INFO - Running setup.py install for mozhttpd 03:08:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:08:56 INFO - Running setup.py install for mozinfo 03:08:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:08:56 INFO - Running setup.py install for mozInstall 03:08:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Running setup.py install for mozleak 03:08:57 INFO - Running setup.py install for mozlog 03:08:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Running setup.py install for moznetwork 03:08:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Running setup.py install for mozprocess 03:08:57 INFO - Running setup.py install for mozprofile 03:08:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Running setup.py install for mozrunner 03:08:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:08:57 INFO - Running setup.py install for mozscreenshot 03:08:57 INFO - Running setup.py install for moztest 03:08:57 INFO - Running setup.py install for mozversion 03:08:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:08:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:58 INFO - Cleaning up... 03:08:58 INFO - Return code: 0 03:08:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:58 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:08:58 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 03:08:58 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 03:08:58 INFO - Using env: {'DISPLAY': ':0', 03:08:58 INFO - 'HOME': '/home/cltbld', 03:08:58 INFO - 'LANG': 'en_US.UTF-8', 03:08:58 INFO - 'LANGUAGE': 'en_US:en', 03:08:58 INFO - 'LOGNAME': 'cltbld', 03:08:58 INFO - 'MAIL': '/var/mail/cltbld', 03:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:58 INFO - 'MOZ_NO_REMOTE': '1', 03:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:58 INFO - 'NO_EM_RESTART': '1', 03:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:08:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:08:58 INFO - 'SHELL': '/bin/bash', 03:08:58 INFO - 'SHLVL': '1', 03:08:58 INFO - 'TERM': 'linux', 03:08:58 INFO - 'TMOUT': '86400', 03:08:58 INFO - 'USER': 'cltbld', 03:08:58 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:58 INFO - '_': '/tools/buildbot/bin/python'} 03:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:58 INFO - Running setup.py (path:/tmp/pip-lCwxpK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:58 INFO - Running setup.py (path:/tmp/pip-y0CD1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:58 INFO - Running setup.py (path:/tmp/pip-6FSDbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:58 INFO - Running setup.py (path:/tmp/pip-w71IVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:58 INFO - Running setup.py (path:/tmp/pip-IcwfMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:58 INFO - Running setup.py (path:/tmp/pip-SoNYma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:58 INFO - Running setup.py (path:/tmp/pip-kIG4Rw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:58 INFO - Running setup.py (path:/tmp/pip-ye426u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:58 INFO - Running setup.py (path:/tmp/pip-J7FmqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:08:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:58 INFO - Running setup.py (path:/tmp/pip-WQdYB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:59 INFO - Running setup.py (path:/tmp/pip-2aHn21-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:59 INFO - Running setup.py (path:/tmp/pip-JPkt41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:59 INFO - Running setup.py (path:/tmp/pip-IVn1kK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:59 INFO - Running setup.py (path:/tmp/pip-YD9NE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:59 INFO - Running setup.py (path:/tmp/pip-ao3oz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:59 INFO - Running setup.py (path:/tmp/pip-Ob_lt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:08:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:59 INFO - Running setup.py (path:/tmp/pip-em6wL_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:08:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:01 INFO - Downloading blessings-1.6.tar.gz 03:09:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:09:01 INFO - Installing collected packages: blessings 03:09:01 INFO - Running setup.py install for blessings 03:09:01 INFO - Successfully installed blessings 03:09:01 INFO - Cleaning up... 03:09:01 INFO - Return code: 0 03:09:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:09:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:01 INFO - Reading from file tmpfile_stdout 03:09:01 INFO - Current package versions: 03:09:01 INFO - argparse == 1.2.1 03:09:01 INFO - blessings == 1.6 03:09:01 INFO - blobuploader == 1.2.4 03:09:01 INFO - docopt == 0.6.1 03:09:01 INFO - manifestparser == 1.1 03:09:01 INFO - mozInstall == 1.12 03:09:01 INFO - mozcrash == 0.16 03:09:01 INFO - mozdebug == 0.1 03:09:01 INFO - mozdevice == 0.47 03:09:01 INFO - mozfile == 1.2 03:09:01 INFO - mozhttpd == 0.7 03:09:01 INFO - mozinfo == 0.9 03:09:01 INFO - mozleak == 0.1 03:09:01 INFO - mozlog == 3.1 03:09:01 INFO - moznetwork == 0.27 03:09:01 INFO - mozprocess == 0.22 03:09:01 INFO - mozprofile == 0.27 03:09:01 INFO - mozrunner == 6.11 03:09:01 INFO - mozscreenshot == 0.1 03:09:01 INFO - mozsystemmonitor == 0.0 03:09:01 INFO - moztest == 0.7 03:09:01 INFO - mozversion == 1.4 03:09:01 INFO - psutil == 3.1.1 03:09:01 INFO - requests == 1.2.3 03:09:01 INFO - wsgiref == 0.1.2 03:09:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:01 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 03:09:01 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 03:09:01 INFO - Using env: {'DISPLAY': ':0', 03:09:01 INFO - 'HOME': '/home/cltbld', 03:09:01 INFO - 'LANG': 'en_US.UTF-8', 03:09:01 INFO - 'LANGUAGE': 'en_US:en', 03:09:01 INFO - 'LOGNAME': 'cltbld', 03:09:01 INFO - 'MAIL': '/var/mail/cltbld', 03:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:01 INFO - 'MOZ_NO_REMOTE': '1', 03:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:01 INFO - 'NO_EM_RESTART': '1', 03:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:01 INFO - 'SHELL': '/bin/bash', 03:09:01 INFO - 'SHLVL': '1', 03:09:01 INFO - 'TERM': 'linux', 03:09:01 INFO - 'TMOUT': '86400', 03:09:01 INFO - 'USER': 'cltbld', 03:09:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:01 INFO - '_': '/tools/buildbot/bin/python'} 03:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:09:01 INFO - Cleaning up... 03:09:01 INFO - Return code: 0 03:09:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:01 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:01 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 03:09:01 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 03:09:01 INFO - Using env: {'DISPLAY': ':0', 03:09:01 INFO - 'HOME': '/home/cltbld', 03:09:01 INFO - 'LANG': 'en_US.UTF-8', 03:09:01 INFO - 'LANGUAGE': 'en_US:en', 03:09:01 INFO - 'LOGNAME': 'cltbld', 03:09:01 INFO - 'MAIL': '/var/mail/cltbld', 03:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:01 INFO - 'MOZ_NO_REMOTE': '1', 03:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:01 INFO - 'NO_EM_RESTART': '1', 03:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:01 INFO - 'SHELL': '/bin/bash', 03:09:01 INFO - 'SHLVL': '1', 03:09:01 INFO - 'TERM': 'linux', 03:09:01 INFO - 'TMOUT': '86400', 03:09:01 INFO - 'USER': 'cltbld', 03:09:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:01 INFO - '_': '/tools/buildbot/bin/python'} 03:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:02 INFO - Downloading/unpacking jsonschema 03:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:09:04 INFO - Downloading/unpacking functools32 (from jsonschema) 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:09:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:09:04 INFO - warning: no files found matching '*.txt' 03:09:04 INFO - no previously-included directories found matching 'build' 03:09:04 INFO - no previously-included directories found matching 'dist' 03:09:04 INFO - no previously-included directories found matching '.git*' 03:09:04 INFO - Installing collected packages: jsonschema, functools32 03:09:04 INFO - Running setup.py install for functools32 03:09:04 INFO - warning: no files found matching '*.txt' 03:09:04 INFO - no previously-included directories found matching 'build' 03:09:04 INFO - no previously-included directories found matching 'dist' 03:09:04 INFO - no previously-included directories found matching '.git*' 03:09:04 INFO - Successfully installed jsonschema functools32 03:09:04 INFO - Cleaning up... 03:09:04 INFO - Return code: 0 03:09:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:09:04 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 0x7fa950b7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1264450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:09:04 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 03:09:04 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 03:09:04 INFO - Using env: {'DISPLAY': ':0', 03:09:04 INFO - 'HOME': '/home/cltbld', 03:09:04 INFO - 'LANG': 'en_US.UTF-8', 03:09:04 INFO - 'LANGUAGE': 'en_US:en', 03:09:04 INFO - 'LOGNAME': 'cltbld', 03:09:04 INFO - 'MAIL': '/var/mail/cltbld', 03:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:04 INFO - 'MOZ_NO_REMOTE': '1', 03:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:04 INFO - 'NO_EM_RESTART': '1', 03:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:04 INFO - 'SHELL': '/bin/bash', 03:09:04 INFO - 'SHLVL': '1', 03:09:04 INFO - 'TERM': 'linux', 03:09:04 INFO - 'TMOUT': '86400', 03:09:04 INFO - 'USER': 'cltbld', 03:09:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:04 INFO - '_': '/tools/buildbot/bin/python'} 03:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:09:04 INFO - Downloading/unpacking flake8 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:09:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:09:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:09:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:07 INFO - no previously-included directories found matching 'docs/_build' 03:09:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:09:07 INFO - Running setup.py install for pep8 03:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:09:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:09:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:09:07 INFO - no previously-included directories found matching 'docs/_build' 03:09:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:09:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:09:07 INFO - Cleaning up... 03:09:07 INFO - Return code: 0 03:09:07 INFO - Running post-action listener: _resource_record_post_action 03:09:07 INFO - Running post-action listener: _start_resource_monitoring 03:09:07 INFO - Starting resource monitoring. 03:09:07 INFO - ##### 03:09:07 INFO - ##### Running install step. 03:09:07 INFO - ##### 03:09:07 INFO - Running pre-action listener: _resource_record_pre_action 03:09:07 INFO - Running main action method: install 03:09:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:09:07 INFO - Reading from file tmpfile_stdout 03:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:09:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:09:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:09:08 INFO - Reading from file tmpfile_stdout 03:09:08 INFO - Output received: 03:09:08 INFO - Usage: mozinstall [options] installer 03:09:08 INFO - Options: 03:09:08 INFO - -h, --help show this help message and exit 03:09:08 INFO - -d DEST, --destination=DEST 03:09:08 INFO - Directory to install application into. [default: 03:09:08 INFO - "/builds/slave/test-pgo"] 03:09:08 INFO - --app=APP Application being installed. [default: firefox] 03:09:08 INFO - mkdir: /builds/slave/test-pgo/build/application 03:09:08 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'] 03:09:08 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 03:09:22 INFO - Reading from file tmpfile_stdout 03:09:22 INFO - Output received: 03:09:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:09:22 INFO - Running post-action listener: _resource_record_post_action 03:09:22 INFO - ##### 03:09:22 INFO - ##### Running run-tests step. 03:09:22 INFO - ##### 03:09:22 INFO - Running pre-action listener: _resource_record_pre_action 03:09:22 INFO - Running main action method: run_tests 03:09:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:09:22 INFO - Python 2.7.3 03:09:22 INFO - Return code: 0 03:09:22 INFO - grabbing minidump binary from tooltool 03:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:09:22 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 0x12f6a50>, '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 0x1262550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12629e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:09:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:09:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:09:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:22 INFO - Return code: 0 03:09:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:09:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:09:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:09:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:09:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:09:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:09:23 INFO - Return code: 0 03:09:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:09:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 03:09:23 INFO - Using env: {'DISPLAY': ':0', 03:09:23 INFO - 'HOME': '/home/cltbld', 03:09:23 INFO - 'LANG': 'en_US.UTF-8', 03:09:23 INFO - 'LANGUAGE': 'en_US:en', 03:09:23 INFO - 'LOGNAME': 'cltbld', 03:09:23 INFO - 'MAIL': '/var/mail/cltbld', 03:09:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:23 INFO - 'MOZ_NO_REMOTE': '1', 03:09:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:23 INFO - 'NO_EM_RESTART': '1', 03:09:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:09:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:09:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:09:23 INFO - 'SHELL': '/bin/bash', 03:09:23 INFO - 'SHLVL': '1', 03:09:23 INFO - 'TERM': 'linux', 03:09:23 INFO - 'TMOUT': '86400', 03:09:23 INFO - 'USER': 'cltbld', 03:09:23 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361', 03:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:23 INFO - '_': '/tools/buildbot/bin/python'} 03:09:23 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/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 03:09:23 INFO - mozversion INFO | application_buildid: 20160121004039 03:09:23 INFO - mozversion INFO | application_changeset: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 03:09:23 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:09:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:23 INFO - mozversion INFO | application_name: Firefox 03:09:23 INFO - mozversion INFO | application_remotingname: firefox-dev 03:09:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:23 INFO - mozversion INFO | application_vendor: Mozilla 03:09:23 INFO - mozversion INFO | application_version: 45.0a2 03:09:23 INFO - mozversion INFO | platform_buildid: 20160121004039 03:09:23 INFO - mozversion INFO | platform_changeset: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 03:09:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:23 INFO - mozversion INFO | platform_version: 45.0a2 03:09:23 INFO - 2016-01-21 03:09:23,918 DEBUG : using testdate: 1453374563 03:09:23 INFO - 2016-01-21 03:09:23,918 DEBUG : actual date: 1453374563 03:09:23 INFO - 2016-01-21 03:09:23,927 INFO : starting webserver on 'localhost:37222' 03:09:23 INFO - 2016-01-21 03:09:23,928 INFO : Starting test suite talos-linux64-ix-014.e 03:09:23 INFO - 2016-01-21 03:09:23,928 INFO : Starting test dromaeo_css 03:09:23 INFO - 2016-01-21 03:09:23,928 DEBUG : operating with platform_type : linux_ 03:09:23 INFO - 2016-01-21 03:09:23,929 INFO : Initialising browser for dromaeo_css test... 03:09:23 INFO - 2016-01-21 03:09:23,943 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5c7m09/profile http://localhost:37222/getInfo.html 03:09:27 INFO - 2016-01-21 03:09:27,739 DEBUG : BROWSER_OUTPUT: 03:09:27 INFO - 2016-01-21 03:09:27,739 DEBUG : BROWSER_OUTPUT: (process:23673): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:09:28 INFO - 2016-01-21 03:09:28,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:09:28 INFO - 2016-01-21 03:09:28,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:09:28 INFO - 2016-01-21 03:09:28,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:09:28 INFO - 2016-01-21 03:09:28,635 DEBUG : BROWSER_OUTPUT: __metrics 03:09:29 INFO - 2016-01-21 03:09:29,633 INFO : Browser initialized. 03:09:29 INFO - 2016-01-21 03:09:29,634 INFO : Running cycle 1/1 for dromaeo_css test... 03:09:29 INFO - 2016-01-21 03:09:29,634 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5c7m09/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:09:30 INFO - 2016-01-21 03:09:30,925 DEBUG : BROWSER_OUTPUT: 03:09:30 INFO - 2016-01-21 03:09:30,926 DEBUG : BROWSER_OUTPUT: (process:23785): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:09:41 INFO - 2016-01-21 03:09:41,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 136699904 03:09:41 INFO - 2016-01-21 03:09:41,426 DEBUG : BROWSER_OUTPUT: 03:10:31 INFO - 2016-01-21 03:10:31,041 DEBUG : BROWSER_OUTPUT: 1453374631036 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:12:39 INFO - 2016-01-21 03:12:39,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37222/tests/dromaeo/cssquery-ext.html) 03:12:40 INFO - 2016-01-21 03:12:40,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 140513280 03:12:40 INFO - 2016-01-21 03:12:40,306 DEBUG : BROWSER_OUTPUT: 03:15:42 INFO - 2016-01-21 03:15:42,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-ext.html (next: http://localhost:37222/tests/dromaeo/cssquery-jquery.html) 03:15:42 INFO - 2016-01-21 03:15:42,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 03:15:42 INFO - 2016-01-21 03:15:42,786 DEBUG : BROWSER_OUTPUT: 03:18:44 INFO - 2016-01-21 03:18:44,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37222/tests/dromaeo/cssquery-mootools.html) 03:18:44 INFO - 2016-01-21 03:18:44,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 140267520 03:18:44 INFO - 2016-01-21 03:18:44,950 DEBUG : BROWSER_OUTPUT: 03:21:46 INFO - 2016-01-21 03:21:46,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37222/tests/dromaeo/cssquery-prototype.html) 03:21:47 INFO - 2016-01-21 03:21:47,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 138911744 03:21:47 INFO - 2016-01-21 03:21:47,118 DEBUG : BROWSER_OUTPUT: 03:24:49 INFO - 2016-01-21 03:24:49,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37222/tests/dromaeo/cssquery-yui.html) 03:24:49 INFO - 2016-01-21 03:24:49,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 139186176 03:24:49 INFO - 2016-01-21 03:24:49,958 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/dromaeo/cssquery-yui.html (next: http://localhost:37222/tests/dromaeo/cssquery-dojo.html) 03:27:52 INFO - 2016-01-21 03:27:52,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 141180928 03:27:52 INFO - 2016-01-21 03:27:52,324 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,324 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:27:52 INFO - 2016-01-21 03:27:52,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:27:52 INFO - 2016-01-21 03:27:52,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:27:52 INFO - 2016-01-21 03:27:52,325 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:27:52 INFO - 2016-01-21 03:27:52,326 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3271.16585270756;3342.014105838779;3351.6983471487592;3363.8318084095795;3373.89878303651;5569.470900264473;5595.300587426572;5600.6079574429805;5614.410486898878;5620.803271885485;5570.972145139269;5598.944010559893;5611.214429979796;5630.09918413054;5655.943440565593;5044.470330615288;5136.948630513703;5174.456682048387;5212.687238765686;5231.163013917774;4993.226049962243;5022.547970682638;5117.974410127944;5161.148410512261;5163.993021360836;5051.823186188484;5077.263796749469;5110.514501122388;5114.641975061747;5131.179011358184;5034.068697290976;5048.6465947383695;5064.645474816764;5098.872528186788;5140.485951404867;4867.123917694814;4921.237208232729;4965.751712414401;4973.676711013773;5027.522385373383;5377.838664840061;5377.865553361158;5401.162819762943;5451.727413629303;5471.945280547184;5925.940740592625;6038.3659715729655;6061.515078793686;6064.484518815906;6065.878682426371;5753.88492230153;5936.792212272593;5995.040793473067;6076.817695469099;6113.44978951892;5633.464820842013;5650.5479561634975;5684.886302273972;5703.3441154267375;5711.114777209539;6134.7852825151795;6142.846428839315;6154.5384096192965;6160.10678451622;6169.8457538561;5610.4670056344585;5725.484706376446;5767.567432442584;5856.209411729362;5881.264841894763;5948.762049518057;6024.668643224665;6036.9698151508965;6040.09398590215;6042.758289668452;5820.854478638068;5957.285125784847;6014.097885317237;6016.69916504173;6029.186059881859;5839.357670656224;5916.645001299936;5927.9407205928255;5945.435183657545;5999.610025348338;4600.42494688164;4614.146382919103;4615.376924115269;4626.907461850811;4644.837430689977;3906.824192911326;4009.0578714002186;4131;4136.9793151034655;4184.769837658958;5666.17840413146;5677.120046392815;5703.287089113861;5738.68437235956;5786.826395208151;5981.551383646157;6029.909551356734;6038.456538911519;6042.093685947143;6045.244344456943;5556;5635.351934527582;5726.79956201531;5746.166805813134;5750.971245143831;5202.193659982709;5283.735813209324;5288.947110528922;5307.389650190277;5318.122509785842;6179.907301390483;6194.101855230966;6195;6201.410865967816;6225.315215326311;5747.511461525817;5883.911741323798;5927.792527261525;5996.850078748066;6075.422834830772;6156.168917196122;6221.191245138284;6229.719662615103;6231.563790534619;6269.68651567429;5918.141869428822;5953.970230148995;5962.940370596239;5966.403359663999;5973.283206015306;5847.619904706181;5955.6724380157775;6012.488938440281;6072.453479186895;6119.35746746603;5887.764489420547;5902.1441890926435;5904.793332233351;5926.67403292823;5939;5901.1443340714495;5920.319163296103;5925.466707996301;5925.911111333247;5940;5668.5465162787705;5676.318841738853;5723;5778.508826749773;5815.41845815415;5785.074388097884;5849.298084229919;5856.590038697421;5868.471837534642;5967.31375891778;5624.268845050281;5762.481376676119;5781.161731548986;5784.305883294031;5784.768609255582 03:27:52 INFO - 2016-01-21 03:27:52,327 DEBUG : BROWSER_OUTPUT: |1;ext.html;595.2618752746596;596.1207219351456;600.8888355654204;626.4424662050773;633.771842136831;39966.000849978765;40464.797676011614;41078;41084.99999999996;41201.17597648049;45215.32177017339;45623.31565026527;45802.083958320814;45884.54115458844;45925;9226.723198304062;9363.438193708365;9381.343305968585;9388.061193880625;9436.150746432819;9135.451872887616;9195.678151264707;9212.401193922407;9277;9296.256299496024;9162.404443711172;9165.175134237918;9241.815163696721;9262.166405023547;9263.953680231589;9264.212541933945;9349.579268932914;9364.297677674167;9369.625214991393;9377.859332110058;9133.588988495534;9342.57958391874;9357.111074447917;9368.765780855465;9377.296702747253;42555;43044.78477607592;43050;43062;43076.35385469221;3293.9835300823584;3690.1143725505685;3752.3058234226482;3761.3041587306434;3769.9623003769884;30035.249118772204;30301.69698303011;30508;30617.38765224683;30934.38131237385;4050.9392359114636;4058.9797051014853;4065.8170382332864;4072.8370865165653;4123.299039163349;235184;235415;236382;236768;237030;44747.328790068175;45046.77476612662;45232;56854.71572642193;57195;43040;43080;43132.35301470481;43187;43277.783611081744;17233.396831111102;17287.222075006404;17390.739138912926;17421.47735567935;17441.040742759018;13494.93252533731;13543.864561354458;13545.59363219105;13569;13576.524821631196;15298.617534561503;15322.540323790305;15365.308561114776;15376;15378.231088445757;5978.5814992950945;6016.308124565643;6019.398060193946;6093.939060609426;6099.024156134997;986.2603047714215;1049.040128282628;1050.779336339362;1080.8540846985713;1112.3881864974232;29518.852405737834;29858.40283194324;29890.850545747566;30451.69548304533;30488.237794055327;1053.773438710681;1076.1283360478037;1122.1247427006947;1172.472387425662;1186.489809381974;14823.70352592942;14983.400663973536;14988.400463981538;15238.542843714706;15488.148151851756;731661;732860;733776;735758;794572;58005.4199458;58366.12450813241;58863.70568147132;58991;59044;1428.607133038402;1430.6709456824988;1433.1401159304542;1452.6949340638373;1459.4599998000808;30060.398792024476;30435.695643043287;30781;31083.844580776953;31356.52965205478;47594.52405475901;47628.285575717084;47651.285230722264;47746.52253477421;47781;329044;330173;332504;332649;335287;33429.49855752214;33682.32635347328;33743;33858.83070584631;34102.48846267357;44994.75173988523;45293;45693.31460028169;45742.542574575156;46053.30920036135;37936.24127517379;38345.233095338495;38845.80577097096;39259.6074039256;39535.80232098821;38400.6159938397;38891.61108388993;39063.38952006161;39274.214515708954;39548.40677389899;38559.6144038556;43715;44300.33549496696;44681.77659111684;45391.773041134584;34790.47814282737;35350.82324588361;35548.28903421969;35568.46647300241;35581.64418355783;27120.32199194957;27649.308767280174;27694.74739314542;27762.305942351602;28073.859630701714 03:27:52 INFO - 2016-01-21 03:27:52,331 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.15022846539125;374.6197609426431;382.28131113506606;383.33300057899254;389.2778895149498;15213.543593692208;16777.916110419446;18180.727289090675;19075.523111922208;19127.617447651057;17660.82339176608;17705.822941770577;17851.375201867937;18039.72940405892;18051.548711282223;5548.140038294061;5614.494695477406;5666.348369937448;5668.234788303567;5669.291338582677;5429.782808687667;5517.393086760453;5599.580031497633;5611.270534830487;5615.4665306796;5546.500814926656;5564.610477266573;5581.246531718207;5592.273004509429;5772.307323121231;4980.551750342468;5888.322842873082;5890.941090589082;5891.734871930774;5899.5870289079785;5564.276644036249;5614.6631202128;5647.689377084259;5708.65748055118;5746.569007324426;13308.600741977756;13476.595702128854;13553.186808791406;13572.660683482893;13832.585022449342;2139.251262058267;2237.8433509654333;2249.1228420915854;2269.307861102363;2313.5141620259765;10301.032696229771;10363.48182590875;10537.73655658607;10553.314034587727;10638.308509946828;1873.4941565777165;1905.7998910114377;1945.6400565895356;1950.7366505521716;1981.9405417837488;64898.67550662217;66686.66656666686;67495.66252168707;67988.6600566994;68677.96983045258;10770.730731731614;10860.511276992554;10885.346879187116;10897.891021089688;10910.836337454944;14451.638709032359;14507.492237771627;14527.201003944885;14530.782038269434;14567.41730330775;8122.065962414398;8157.8368432632205;8218.424710270343;8458.661653533913;8586.356023298153;8098.7165449209;8141.267285944294;8193.344532437392;8254.752357429286;8280.958595206985;4337.9783101084295;4491.034427598082;4560.726356418625;4593.678442509059;4646.4191976003;1927.9710804337947;1929.778075521305;2004.5690176612097;2007.4078146946686;2014.9421553684433;957.4686049242598;1012.2003617142523;1031.1441503552035;1055.8416237564272;1119.4850368830266;16411.097389643684;17509.824901751075;19273.22907083701;19417.126229319714;19534.5116372089;954.1174413667469;989.6981420666766;1045.6601604478574;1064.9414282214552;1083.409541799721;10409.68770936873;10426.895731042745;10434.37393756377;10506.789864202674;10517.684469465776;630053;637858;648557;674120;678671;86921.5653921739;87537;89057.55471222731;90600.5469972659;90621.54689226643;1217.7686239614268;1222.6148763139583;1236.3014896583402;1250.4498020870788;1265.5064524835323;15471.226438678246;16169;16261.105639189485;16310.510684679479;16985.49043528696;34749.82625086858;34815.65184348124;35467.64532354747;35820.28359432745;35835.82082089573;42053.579464204966;42856.57143428526;44532.55467445284;46559.76720116378;48189.75905120452;9991.650292239738;10124.69625911224;10182.287239893136;10183.592656293962;10579.94710026445;17432.65134697324;17971.73042404391;18184.45446636603;18752;19098.23607055702;15056.397744090114;15178;15361.923190383977;15422.383104675688;15601.063936163866;14798.556043318718;15181.089134651515;15187.696246075238;15463.458778942682;15724.977876437995;14705.33825977855;15070;15789.605259868595;16029.438969636007;16182.838171618134;10111.59553617847;10136.847947280945;10216.795664086825;10230.539625717009;10319.380837149794;11167.274127181707;14499.78250326267;15183.620409489851;15290.541283761506;16256.756148657543 03:27:52 INFO - 2016-01-21 03:27:52,331 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1547.1722628393811;1549.8217704963924;1722.2249987505625;1784.5806235534646;1833.945481348225;7583.582902940343;7910.36717062635;8035.116137224901;8043.155468675785;8043.396745244108;7873.330766884822;7915.2084791520965;7984.840303193932;7993.560354180518;8002.0797608274925;2320.8027317677975;2338.5673650374733;2344.495933374324;2346.7770561796688;2348.5889969255313;2360.5396947595227;2368.5973384524673;2386.2364043506086;2400.3759022654062;2403.567357875582;2191.868487890724;2202.394341556077;2215.789499997498;2251.1783199132283;2254.571631390039;2295.4605667668084;2335.054303007285;2363.95272094558;2366.4438856868624;2370.6444033394955;2330.755270696586;2370.383700237933;2372.8457650252676;2375.09746296408;2375.3586531636533;7911.723089691834;7912.683492660287;8002.839943201162;8009.639566219534;8017.719379821737;4857.077155340474;4927.162382395001;4951.876203094951;4965.478624744386;4968.90062198754;3113.937721245585;3151.6848315168527;3196.280836811722;3203.343314620497;3238.9352212955846;1054.9103326217205;1059.6079450603327;1060.0989159214682;1083.0577397664083;1083.0956151613411;10782.13742900574;10785.62250321235;10870;10891.237613367068;10904.073153781937;4199.9370009449885;4253.106847562047;4303.117860838521;4303.462067241595;4310.762908040025;8873.378863479624;8896.065913079034;8896.377253592316;8926.419782714103;8934.374593778502;4858.82994095205;4861.465238823726;4874.0495603357;4879.902401951941;4888.242322440027;4449.933251001237;4451.866444006685;4478.596926276651;4499.370088187657;4505.954940450619;3440.7419443541835;3471.4272145096284;3487.773294735834;3488.930221395558;3497.4753786932165;1095.3756358875364;1115.9163062770324;1116.564539829467;1121.7419993401563;1184.768970050849;1118.7818375416716;1131.7170707323169;1171.824226366052;1179.675589212956;1191.4638412714314;7594.050743657043;7596.620168991528;7598.278163574451;7604.657790399446;7717.459777815499;1167.2121318110242;1180.6458062581191;1180.8819118088122;1185.6265276437894;1216.4951545108859;6033.818985430444;6050.48570871472;6054.091886217103;6075.058365953284;6095.512359011268;9101.863472047924;9578.760530986781;9614.03859614047;9624.711258662252;9632.566534505964;9324.720258392259;9372.812543749087;9379.20276776468;9401.905980940102;9429.198518126037;7209.0988626421695;7401.925980740231;7426.368758655467;7456;7477.999999999891;7156.427485801228;7244.855102898018;7245.420366370572;7272.41820654357;7275.308845659654;8183.8772418414965;8232.17678232172;8328.6668533258;8340.749777506684;8391.118932512243;8207.220314070153;8464.153584641486;8473.49159050459;8484.236418722097;8511.574421278787;6787.117674702257;6828.317168283132;6844.691988860413;6845.589264644137;6849.931500685128;7511.436642251962;7515.962420187864;7560.130584982798;7561.243875612395;7566.31903128721;6892.655367231518;6915.308469153045;6923.688434020381;6984.16190057176;7124.608146551782;6825.726970921108;7031.22656507794;7059.894101588583;7108.715651373887;7173.0675012248075;7233.3851622612665;7273.8908916365235;7284.053073100463;7290.3438690518105;7298.306660867209;6544.509161812978;6558.114654521769;6585.736570537125;6592.80221593353;6637.535372523877;6626.56927299724;6753.223379311442;6753.3246675332075;6756.054152418567;6789.592624442549 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: |4;prototype.html;366.5326708446731;370.1948262528999;373.2888846746948;375.4349703695937;376.2343630711501;6347.492200623945;6358.61848289103;6401.71192296346;6449.54853160279;6453.096566480691;6118;6284.591501552407;6309.179806625132;6314.589551679138;6321.873562528758;4912.336834527328;4914.803407863681;4925.064237794825;4925.310456536088;4931.358923339961;4918.704877707331;4923.75381230937;4928.063667903105;4929.556339929406;4935.481774413689;4745.477997420281;4884.462709101996;4887.755612219393;4893.339399181118;4895.11887860185;4852.150873597124;4874.610031197496;4884.780184891689;4893.388326459192;4914.189158788813;4340.110277393158;4345.47854257488;4350.347447882811;4356.390105385249;4361.887718631729;5947.613405128653;6043.576949613529;6055.485283750886;6063.090536419529;6073.908891366633;5677.205191273225;5680.403557626472;5690.658560486384;5692.37383887772;5702;6704.296048914891;6716.261211266757;6722.563033402813;6723.865522689568;6730.9903514472735;4753.83361582343;4780.426348838162;4781.760911954389;4784.40194975628;4800.231962885921;6769.492288078413;6922.100126983511;6987.7204911803465;6995.40539054181;6998.7402267591815;4937.580305674058;4938.58022068121;4940.110780059624;4942.851714448572;4951.158303088484;4997.125503036954;5001.699898006132;5009.323741294878;5014.749262536859;5017.37282839645;5628.634138780966;5686.521504408884;5717.085266357446;5717.742701578439;5727.6849773262875;6772.864542709217;6787.423069039089;6792.864142717217;6797.626130562867;6805.591664500146;1722.6468573942561;1779.8665100117544;1781.4210381626024;1782.295993082751;1784.5538615346163;1219.8597161326384;1221.883921027501;1224.675461002835;1237.832892559511;1246.6197809667956;6547.410733034049;6563;6574.704138313788;6577.2436169841085;6583.275839657634;6914.481413893978;6923.099997000358;6931.79204623852;6932.064171336906;6955.652217389212;6389.9361006389345;6562.212534495796;6562.80311590653;6563.3764792344655;6575.967120164369;3761.492198553215;3796.772193668389;3802.6007269236884;3803.220339830328;3807.2575847709986;7159.248278930741;7178.641067946582;7193.604351760703;7196;7209.423246140296;7031.050808140835;7077.292270772881;7125.50121491501;7135.250798666169;7267.236940121211;7278.199398066208;7304.817379565553;7337.19290878003;7345.77962661121;7357.448191385667;7060.117485314336;7063.752768653072;7098.183708873546;7110.253423390676;7115.1106111736035;6856.108705868205;6958.512904096665;6976.4767642426;6983.9650801745665;7004.229534751072;7278.636068196463;7309.378702810321;7311;7337.6698048589005;7342.5227360221415;4792.784324705466;4834.057358814997;4847.733374664286;4851.296561998561;4871.391076115486;6906.240313565403;6949.30506949301;7072.752453664097;7097.183823860322;7105.964470177616;6827.863442731018;6881.552699074544;6896.655167241718;6916.481263905127;6919.757808476679;6798.83002924911;6824.249332573512;6849.965750171217;6864.347886950732;6865.691043902936;6537.248216454978;6763.391294783296;6767;6767.695453704497;6772.051912732123;6909.619970901447;6928.688209030706;6930.3762661360715;6944.270851560514;6946.340097690711;6614.867702645824;6705;6745.055692202997;6747.831304217238;6759.763408280686 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: |5;yui.html;782.2177822177822;805.5166899860085;810.5866008335747;845.4124383553429;900.0684291758027;15840.920795396021;15978.76031859523;16045.358185672589;16056.27746751396;16076.115813630246;14755.18846463444;14861.108333499971;14909.254537273147;14917.32872020759;14918.508149185076;888.6578667213137;906.8231694819513;908.2597682888425;915.4095608332622;918.4718786697642;900.0729248873638;904.3759805734022;905.6830109461669;905.7373361725125;908.5230254116609;945.1021529546923;950.6197520991624;952.342883410448;953.275510611933;954.6706386296751;941.2093841173447;941.7975135345899;943.3160958305242;943.4197968249512;944.7874228298647;694.7741983855267;698.4866123399297;700.3556727810427;700.7442283566512;701.8420855307565;13946.372413241428;13973;13995.090319129224;14032.298385080705;14104.647383815383;12692.619221423372;12933.54732584355;13101.41043653038;13236;13334.066615336931;10546.683599492027;10577.418241996687;10608.469576521144;10717;10897.891021089767;3710.9072273193115;3737.252549490113;3742.850285988557;3749.2876353492748;3772.622737726233;49241.50758492405;49498;49520.50479495195;49832.50167498315;49952.25071623892;10244;10467.94766026165;10500.107490863209;10700.625478108228;10853.077488413415;18474.63050738978;18523.44429667112;18560.907195464206;18609.44171674852;18632.44102676922;7946.40401969843;7968.721094761656;8062.435629505995;8375.916240837514;8532.957335213285;4445.51099379068;4492.124035812985;4568.817247310137;4722.6221902247735;4810.542998415145;3334.9333013339597;3358.1436733633254;3366.107981384935;3366.6128395234373;3376.9324613507592;579.4784693775551;623.3454872383978;627.8367624417684;628.214731585518;629.0626965820894;653.3051163948711;655.7016557466342;668.5787953589207;693.9673626253306;699.9685014174374;9334.113259240361;9353.766155846159;9495;9522.619095236252;9664.03359664028;708.2598684374841;713.4791602130474;714.118064190724;723.4682508356353;769.9730509432255;4324.762138082436;4426.535213802569;4448.733076015449;4504.324351347259;4784.593309568726;55387;57126.7143664279;57485.425145748006;57691;58222.70888645529;52004.47995519996;52561.47438525642;52949.47050529523;53825.1926221107;53874;46769.532304677195;46853.297200542016;46941.76529117401;47202.05595888063;47428.525714743104;9225.062736825343;9295.581698823435;9334;9390.24878009744;9435.009324020879;34580;35431;35524;35733.82133089318;35835.10412239715;50969.74515127401;51988;52153;52775.47224527706;53371;11458.94270528642;11576.826347604961;11729.824052639047;12183.086268529718;12310.13829031995;13228.338583071001;13542.06694180633;13792.793108103588;13864.445422183;13982.440702372198;11548;11840.230385024946;12277.815832762695;12787.296698681661;12847.357632118543;12199.390030498616;12204.511819527119;12235.877641223475;12538.811917821422;12849.229046257255;12272.509099636272;12400.56598019065;12408.069394795608;12740.299283539123;13063.150895191782;10610;10753.46232688378;10967.341959482457;10998;11114.555417783198;10236.385816851012;10411.375317480975;10641.467926603793;10759.731006724895;10850.728731781768 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1453375672324__endTimestamp 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,335 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5568.05 Median:5762.48 stddev:623.34 (10.8%) stddev-sans-first:598.64 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: Values: 3271.2 3342.0 3351.7 3363.8 3373.9 5569.5 5595.3 5600.6 5614.4 5620.8 5571.0 5598.9 5611.2 5630.1 5655.9 5044.5 5136.9 5174.5 5212.7 5231.2 4993.2 5022.5 5118.0 5161.1 5164.0 5051.8 5077.3 5110.5 5114.6 5131.2 5034.1 5048.6 5064.6 5098.9 5140.5 4867.1 4921.2 4965.8 4973.7 5027.5 5377.8 5377.9 5401.2 5451.7 5471.9 5925.9 6038.4 6061.5 6064.5 6065.9 5753.9 5936.8 5995.0 6076.8 6113.4 5633.5 5650.5 5684.9 5703.3 5711.1 6134.8 6142.8 6154.5 6160.1 6169.8 5610.5 5725.5 5767.6 5856.2 5881.3 5948.8 6024.7 6037.0 6040.1 6042.8 5820.9 5957.3 6014.1 6016.7 6029.2 5839.4 5916.6 5927.9 5945.4 5999.6 4600.4 4614.1 4615.4 4626.9 4644.8 3906.8 4009.1 4131.0 4137.0 4184.8 5666.2 5677.1 5703.3 5738.7 5786.8 5981.6 6029.9 6038.5 6042.1 6045.2 5556.0 5635.4 5726.8 5746.2 5751.0 5202.2 5283.7 5288.9 5307.4 5318.1 6179.9 6194.1 6195.0 6201.4 6225.3 5747.5 5883.9 5927.8 5996.9 6075.4 6156.2 6221.2 6229.7 6231.6 6269.7 5918.1 5954.0 5962.9 5966.4 5973.3 5847.6 5955.7 6012.5 6072.5 6119.4 5887.8 5902.1 5904.8 5926.7 5939.0 5901.1 5920.3 5925.5 5925.9 5940.0 5668.5 5676.3 5723.0 5778.5 5815.4 5785.1 5849.3 5856.6 5868.5 5967.3 5624.3 5762.5 5781.2 5784.3 5784.8 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58974.67 Median:40215.40 stddev:132393.92 (329.2%) stddev-sans-first:132692.76 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: Values: 595.3 596.1 600.9 626.4 633.8 39966.0 40464.8 41078.0 41085.0 41201.2 45215.3 45623.3 45802.1 45884.5 45925.0 9226.7 9363.4 9381.3 9388.1 9436.2 9135.5 9195.7 9212.4 9277.0 9296.3 9162.4 9165.2 9241.8 9262.2 9264.0 9264.2 9349.6 9364.3 9369.6 9377.9 9133.6 9342.6 9357.1 9368.8 9377.3 42555.0 43044.8 43050.0 43062.0 43076.4 3294.0 3690.1 3752.3 3761.3 3770.0 30035.2 30301.7 30508.0 30617.4 30934.4 4050.9 4059.0 4065.8 4072.8 4123.3 235184.0 235415.0 236382.0 236768.0 237030.0 44747.3 45046.8 45232.0 56854.7 57195.0 43040.0 43080.0 43132.4 43187.0 43277.8 17233.4 17287.2 17390.7 17421.5 17441.0 13494.9 13543.9 13545.6 13569.0 13576.5 15298.6 15322.5 15365.3 15376.0 15378.2 5978.6 6016.3 6019.4 6093.9 6099.0 986.3 1049.0 1050.8 1080.9 1112.4 29518.9 29858.4 29890.9 30451.7 30488.2 1053.8 1076.1 1122.1 1172.5 1186.5 14823.7 14983.4 14988.4 15238.5 15488.1 731661.0 732860.0 733776.0 735758.0 794572.0 58005.4 58366.1 58863.7 58991.0 59044.0 1428.6 1430.7 1433.1 1452.7 1459.5 30060.4 30435.7 30781.0 31083.8 31356.5 47594.5 47628.3 47651.3 47746.5 47781.0 329044.0 330173.0 332504.0 332649.0 335287.0 33429.5 33682.3 33743.0 33858.8 34102.5 44994.8 45293.0 45693.3 45742.5 46053.3 37936.2 38345.2 38845.8 39259.6 39535.8 38400.6 38891.6 39063.4 39274.2 39548.4 38559.6 43715.0 44300.3 44681.8 45391.8 34790.5 35350.8 35548.3 35568.5 35581.6 27120.3 27649.3 27694.7 27762.3 28073.9 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,336 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32737.70 Median:10600.60 stddev:106856.12 (1008.0%) stddev-sans-first:107128.22 03:27:52 INFO - 2016-01-21 03:27:52,337 DEBUG : BROWSER_OUTPUT: Values: 363.2 374.6 382.3 383.3 389.3 15213.5 16777.9 18180.7 19075.5 19127.6 17660.8 17705.8 17851.4 18039.7 18051.5 5548.1 5614.5 5666.3 5668.2 5669.3 5429.8 5517.4 5599.6 5611.3 5615.5 5546.5 5564.6 5581.2 5592.3 5772.3 4980.6 5888.3 5890.9 5891.7 5899.6 5564.3 5614.7 5647.7 5708.7 5746.6 13308.6 13476.6 13553.2 13572.7 13832.6 2139.3 2237.8 2249.1 2269.3 2313.5 10301.0 10363.5 10537.7 10553.3 10638.3 1873.5 1905.8 1945.6 1950.7 1981.9 64898.7 66686.7 67495.7 67988.7 68678.0 10770.7 10860.5 10885.3 10897.9 10910.8 14451.6 14507.5 14527.2 14530.8 14567.4 8122.1 8157.8 8218.4 8458.7 8586.4 8098.7 8141.3 8193.3 8254.8 8281.0 4338.0 4491.0 4560.7 4593.7 4646.4 1928.0 1929.8 2004.6 2007.4 2014.9 957.5 1012.2 1031.1 1055.8 1119.5 16411.1 17509.8 19273.2 19417.1 19534.5 954.1 989.7 1045.7 1064.9 1083.4 10409.7 10426.9 10434.4 10506.8 10517.7 630053.0 637858.0 648557.0 674120.0 678671.0 86921.6 87537.0 89057.6 90600.5 90621.5 1217.8 1222.6 1236.3 1250.4 1265.5 15471.2 16169.0 16261.1 16310.5 16985.5 34749.8 34815.7 35467.6 35820.3 35835.8 42053.6 42856.6 44532.6 46559.8 48189.8 9991.7 10124.7 10182.3 10183.6 10579.9 17432.7 17971.7 18184.5 18752.0 19098.2 15056.4 15178.0 15361.9 15422.4 15601.1 14798.6 15181.1 15187.7 15463.5 15725.0 14705.3 15070.0 15789.6 16029.4 16182.8 10111.6 10136.8 10216.8 10230.5 10319.4 11167.3 14499.8 15183.6 15290.5 16256.8 03:27:52 INFO - 2016-01-21 03:27:52,338 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,338 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5544.76 Median:6551.31 stddev:2832.72 (43.2%) stddev-sans-first:2824.73 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: Values: 1547.2 1549.8 1722.2 1784.6 1833.9 7583.6 7910.4 8035.1 8043.2 8043.4 7873.3 7915.2 7984.8 7993.6 8002.1 2320.8 2338.6 2344.5 2346.8 2348.6 2360.5 2368.6 2386.2 2400.4 2403.6 2191.9 2202.4 2215.8 2251.2 2254.6 2295.5 2335.1 2364.0 2366.4 2370.6 2330.8 2370.4 2372.8 2375.1 2375.4 7911.7 7912.7 8002.8 8009.6 8017.7 4857.1 4927.2 4951.9 4965.5 4968.9 3113.9 3151.7 3196.3 3203.3 3238.9 1054.9 1059.6 1060.1 1083.1 1083.1 10782.1 10785.6 10870.0 10891.2 10904.1 4199.9 4253.1 4303.1 4303.5 4310.8 8873.4 8896.1 8896.4 8926.4 8934.4 4858.8 4861.5 4874.0 4879.9 4888.2 4449.9 4451.9 4478.6 4499.4 4506.0 3440.7 3471.4 3487.8 3488.9 3497.5 1095.4 1115.9 1116.6 1121.7 1184.8 1118.8 1131.7 1171.8 1179.7 1191.5 7594.1 7596.6 7598.3 7604.7 7717.5 1167.2 1180.6 1180.9 1185.6 1216.5 6033.8 6050.5 6054.1 6075.1 6095.5 9101.9 9578.8 9614.0 9624.7 9632.6 9324.7 9372.8 9379.2 9401.9 9429.2 7209.1 7401.9 7426.4 7456.0 7478.0 7156.4 7244.9 7245.4 7272.4 7275.3 8183.9 8232.2 8328.7 8340.7 8391.1 8207.2 8464.2 8473.5 8484.2 8511.6 6787.1 6828.3 6844.7 6845.6 6849.9 7511.4 7516.0 7560.1 7561.2 7566.3 6892.7 6915.3 6923.7 6984.2 7124.6 6825.7 7031.2 7059.9 7108.7 7173.1 7233.4 7273.9 7284.1 7290.3 7298.3 6544.5 6558.1 6585.7 6592.8 6637.5 6626.6 6753.2 6753.3 6756.1 6789.6 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5704.85 Median:6495.17 stddev:1698.26 (26.1%) stddev-sans-first:1655.09 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: Values: 366.5 370.2 373.3 375.4 376.2 6347.5 6358.6 6401.7 6449.5 6453.1 6118.0 6284.6 6309.2 6314.6 6321.9 4912.3 4914.8 4925.1 4925.3 4931.4 4918.7 4923.8 4928.1 4929.6 4935.5 4745.5 4884.5 4887.8 4893.3 4895.1 4852.2 4874.6 4884.8 4893.4 4914.2 4340.1 4345.5 4350.3 4356.4 4361.9 5947.6 6043.6 6055.5 6063.1 6073.9 5677.2 5680.4 5690.7 5692.4 5702.0 6704.3 6716.3 6722.6 6723.9 6731.0 4753.8 4780.4 4781.8 4784.4 4800.2 6769.5 6922.1 6987.7 6995.4 6998.7 4937.6 4938.6 4940.1 4942.9 4951.2 4997.1 5001.7 5009.3 5014.7 5017.4 5628.6 5686.5 5717.1 5717.7 5727.7 6772.9 6787.4 6792.9 6797.6 6805.6 1722.6 1779.9 1781.4 1782.3 1784.6 1219.9 1221.9 1224.7 1237.8 1246.6 6547.4 6563.0 6574.7 6577.2 6583.3 6914.5 6923.1 6931.8 6932.1 6955.7 6389.9 6562.2 6562.8 6563.4 6576.0 3761.5 3796.8 3802.6 3803.2 3807.3 7159.2 7178.6 7193.6 7196.0 7209.4 7031.1 7077.3 7125.5 7135.3 7267.2 7278.2 7304.8 7337.2 7345.8 7357.4 7060.1 7063.8 7098.2 7110.3 7115.1 6856.1 6958.5 6976.5 6984.0 7004.2 7278.6 7309.4 7311.0 7337.7 7342.5 4792.8 4834.1 4847.7 4851.3 4871.4 6906.2 6949.3 7072.8 7097.2 7106.0 6827.9 6881.6 6896.7 6916.5 6919.8 6798.8 6824.2 6850.0 6864.3 6865.7 6537.2 6763.4 6767.0 6767.7 6772.1 6909.6 6928.7 6930.4 6944.3 6946.3 6614.9 6705.0 6745.1 6747.8 6759.8 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14637.87 Median:4536.57 stddev:16530.37 (364.4%) stddev-sans-first:16543.99 03:27:52 INFO - 2016-01-21 03:27:52,339 DEBUG : BROWSER_OUTPUT: Values: 782.2 805.5 810.6 845.4 900.1 15840.9 15978.8 16045.4 16056.3 16076.1 14755.2 14861.1 14909.3 14917.3 14918.5 888.7 906.8 908.3 915.4 918.5 900.1 904.4 905.7 905.7 908.5 945.1 950.6 952.3 953.3 954.7 941.2 941.8 943.3 943.4 944.8 694.8 698.5 700.4 700.7 701.8 13946.4 13973.0 13995.1 14032.3 14104.6 12692.6 12933.5 13101.4 13236.0 13334.1 10546.7 10577.4 10608.5 10717.0 10897.9 3710.9 3737.3 3742.9 3749.3 3772.6 49241.5 49498.0 49520.5 49832.5 49952.3 10244.0 10467.9 10500.1 10700.6 10853.1 18474.6 18523.4 18560.9 18609.4 18632.4 7946.4 7968.7 8062.4 8375.9 8533.0 4445.5 4492.1 4568.8 4722.6 4810.5 3334.9 3358.1 3366.1 3366.6 3376.9 579.5 623.3 627.8 628.2 629.1 653.3 655.7 668.6 694.0 700.0 9334.1 9353.8 9495.0 9522.6 9664.0 708.3 713.5 714.1 723.5 770.0 4324.8 4426.5 4448.7 4504.3 4784.6 55387.0 57126.7 57485.4 57691.0 58222.7 52004.5 52561.5 52949.5 53825.2 53874.0 46769.5 46853.3 46941.8 47202.1 47428.5 9225.1 9295.6 9334.0 9390.2 9435.0 34580.0 35431.0 35524.0 35733.8 35835.1 50969.7 51988.0 52153.0 52775.5 53371.0 11458.9 11576.8 11729.8 12183.1 12310.1 13228.3 13542.1 13792.8 13864.4 13982.4 11548.0 11840.2 12277.8 12787.3 12847.4 12199.4 12204.5 12235.9 12538.8 12849.2 12272.5 12400.6 12408.1 12740.3 13063.2 10610.0 10753.5 10967.3 10998.0 11114.6 10236.4 10411.4 10641.5 10759.7 10850.7 03:27:52 INFO - 2016-01-21 03:27:52,340 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:27:52 INFO - 2016-01-21 03:27:52,340 DEBUG : BROWSER_OUTPUT: 03:27:52 INFO - 2016-01-21 03:27:52,978 INFO : Browser exited with error code: 0 03:27:52 INFO - 2016-01-21 03:27:52,999 INFO : Completed test dromaeo_css (00:18:29) 03:27:52 INFO - 2016-01-21 03:27:52,999 INFO : Starting test kraken 03:27:52 INFO - 2016-01-21 03:27:52,999 DEBUG : operating with platform_type : linux_ 03:27:53 INFO - 2016-01-21 03:27:52,999 INFO : Initialising browser for kraken test... 03:27:53 INFO - 2016-01-21 03:27:53,005 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEfvIX3/profile http://localhost:37222/getInfo.html 03:27:56 INFO - 2016-01-21 03:27:56,559 DEBUG : BROWSER_OUTPUT: 03:27:56 INFO - 2016-01-21 03:27:56,559 DEBUG : BROWSER_OUTPUT: (process:24051): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:27:57 INFO - 2016-01-21 03:27:57,404 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:27:57 INFO - 2016-01-21 03:27:57,404 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:27:57 INFO - 2016-01-21 03:27:57,404 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:27:57 INFO - 2016-01-21 03:27:57,404 DEBUG : BROWSER_OUTPUT: __metrics 03:27:58 INFO - 2016-01-21 03:27:58,409 INFO : Browser initialized. 03:27:58 INFO - 2016-01-21 03:27:58,410 INFO : Running cycle 1/1 for kraken test... 03:27:58 INFO - 2016-01-21 03:27:58,410 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEfvIX3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:27:59 INFO - 2016-01-21 03:27:59,681 DEBUG : BROWSER_OUTPUT: 03:27:59 INFO - 2016-01-21 03:27:59,681 DEBUG : BROWSER_OUTPUT: (process:24162): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:10 INFO - 2016-01-21 03:28:10,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 136450048 03:28:10 INFO - 2016-01-21 03:28:10,190 DEBUG : BROWSER_OUTPUT: 03:28:12 INFO - 2016-01-21 03:28:12,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37222/tests/kraken/driver.html?testName=audio-beat-detection) 03:28:13 INFO - 2016-01-21 03:28:13,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 03:28:13 INFO - 2016-01-21 03:28:13,244 DEBUG : BROWSER_OUTPUT: 03:28:15 INFO - 2016-01-21 03:28:15,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37222/tests/kraken/driver.html?testName=audio-dft) 03:28:16 INFO - 2016-01-21 03:28:16,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 138973184 03:28:16 INFO - 2016-01-21 03:28:16,444 DEBUG : BROWSER_OUTPUT: 03:28:19 INFO - 2016-01-21 03:28:19,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37222/tests/kraken/driver.html?testName=audio-fft) 03:28:19 INFO - 2016-01-21 03:28:19,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 139227136 03:28:19 INFO - 2016-01-21 03:28:19,858 DEBUG : BROWSER_OUTPUT: 03:28:21 INFO - 2016-01-21 03:28:21,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37222/tests/kraken/driver.html?testName=audio-oscillator) 03:28:22 INFO - 2016-01-21 03:28:22,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 03:28:22 INFO - 2016-01-21 03:28:22,438 DEBUG : BROWSER_OUTPUT: 03:28:24 INFO - 2016-01-21 03:28:24,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:25 INFO - 2016-01-21 03:28:25,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 03:28:25 INFO - 2016-01-21 03:28:25,197 DEBUG : BROWSER_OUTPUT: 03:28:28 INFO - 2016-01-21 03:28:28,141 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37222/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:28 INFO - 2016-01-21 03:28:28,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 139567104 03:28:28 INFO - 2016-01-21 03:28:28,728 DEBUG : BROWSER_OUTPUT: 03:28:32 INFO - 2016-01-21 03:28:32,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37222/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:32 INFO - 2016-01-21 03:28:32,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 03:28:32 INFO - 2016-01-21 03:28:32,625 DEBUG : BROWSER_OUTPUT: 03:28:35 INFO - 2016-01-21 03:28:35,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37222/tests/kraken/driver.html?testName=json-parse-financial) 03:28:35 INFO - 2016-01-21 03:28:35,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 138428416 03:28:35 INFO - 2016-01-21 03:28:35,998 DEBUG : BROWSER_OUTPUT: 03:28:37 INFO - 2016-01-21 03:28:37,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:38 INFO - 2016-01-21 03:28:38,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 138637312 03:28:38 INFO - 2016-01-21 03:28:38,177 DEBUG : BROWSER_OUTPUT: 03:28:39 INFO - 2016-01-21 03:28:39,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:40 INFO - 2016-01-21 03:28:40,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 03:28:40 INFO - 2016-01-21 03:28:40,573 DEBUG : BROWSER_OUTPUT: 03:28:42 INFO - 2016-01-21 03:28:42,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:43 INFO - 2016-01-21 03:28:43,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 139120640 03:28:43 INFO - 2016-01-21 03:28:43,236 DEBUG : BROWSER_OUTPUT: 03:28:45 INFO - 2016-01-21 03:28:45,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:46 INFO - 2016-01-21 03:28:46,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 138829824 03:28:46 INFO - 2016-01-21 03:28:46,222 DEBUG : BROWSER_OUTPUT: 03:28:48 INFO - 2016-01-21 03:28:48,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:49 INFO - 2016-01-21 03:28:49,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 03:28:49 INFO - 2016-01-21 03:28:49,320 DEBUG : BROWSER_OUTPUT: 03:28:50 INFO - 2016-01-21 03:28:50,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37222/tests/kraken/driver.html?testName=ai-astar) 03:28:51 INFO - 2016-01-21 03:28:51,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 140255232 03:28:51 INFO - 2016-01-21 03:28:51,209 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,210 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:28:51 INFO - 2016-01-21 03:28:51,211 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:28:51 INFO - 2016-01-21 03:28:51,211 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:28:51 INFO - 2016-01-21 03:28:51,211 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:28:51 INFO - 2016-01-21 03:28:51,211 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;112;113;112;121;111;111;110;109 03:28:51 INFO - 2016-01-21 03:28:51,211 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;123;150;159;131;152;152;128;164;131 03:28:51 INFO - 2016-01-21 03:28:51,212 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;161;162;162;162;161;168;162 03:28:51 INFO - 2016-01-21 03:28:51,212 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;72;72;150;72;72;72;73;157;71 03:28:51 INFO - 2016-01-21 03:28:51,212 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;133;91;92;92;136;92;92;137 03:28:51 INFO - 2016-01-21 03:28:51,212 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;109;110;109;110;109;111;111 03:28:51 INFO - 2016-01-21 03:28:51,213 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;146;147;146;147;147;148;145 03:28:51 INFO - 2016-01-21 03:28:51,213 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;98;96;97;95;96;96 03:28:51 INFO - 2016-01-21 03:28:51,213 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;61;61;62;64;61;61;60;59;60 03:28:51 INFO - 2016-01-21 03:28:51,213 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;64;64;66;64;64;66;65;65 03:28:51 INFO - 2016-01-21 03:28:51,214 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;89;86;82;84;81;82;83;88;89 03:28:51 INFO - 2016-01-21 03:28:51,214 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;120;111;114;127;113;127;121;118;112 03:28:51 INFO - 2016-01-21 03:28:51,214 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;149;146;146;156;147;146;134;140;146 03:28:51 INFO - 2016-01-21 03:28:51,215 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;66;66;65;68;67;69;64;66 03:28:51 INFO - 2016-01-21 03:28:51,215 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:28:51 INFO - 2016-01-21 03:28:51,216 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:28:51 INFO - 2016-01-21 03:28:51,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,702 03:28:51 INFO - 2016-01-21 03:28:51,216 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:28:51 INFO - 2016-01-21 03:28:51,216 DEBUG : BROWSER_OUTPUT: __startTimestamp1453375731210__endTimestamp 03:28:51 INFO - 2016-01-21 03:28:51,216 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,217 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:3.68 (3.3%) stddev-sans-first:3.90 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 112.0 113.0 112.0 121.0 111.0 111.0 110.0 109.0 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:152.00 stddev:14.86 (9.8%) stddev-sans-first:15.08 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: Values: 157.0 123.0 150.0 159.0 131.0 152.0 152.0 128.0 164.0 131.0 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,218 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.01 (1.2%) stddev-sans-first:2.13 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 161.0 162.0 162.0 162.0 161.0 168.0 162.0 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:72.00 stddev:34.18 (47.5%) stddev-sans-first:35.98 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: Values: 77.0 72.0 72.0 150.0 72.0 72.0 72.0 73.0 157.0 71.0 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:21.03 (22.9%) stddev-sans-first:21.78 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 133.0 91.0 92.0 92.0 136.0 92.0 92.0 137.0 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 03:28:51 INFO - 2016-01-21 03:28:51,219 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 111.0 111.0 03:28:51 INFO - 2016-01-21 03:28:51,220 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,220 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:28:51 INFO - 2016-01-21 03:28:51,220 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 148.0 145.0 03:28:51 INFO - 2016-01-21 03:28:51,220 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,220 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 03:28:51 INFO - 2016-01-21 03:28:51,221 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 98.0 96.0 97.0 95.0 96.0 96.0 03:28:51 INFO - 2016-01-21 03:28:51,221 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,221 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:1.64 (2.7%) stddev-sans-first:1.41 03:28:51 INFO - 2016-01-21 03:28:51,221 DEBUG : BROWSER_OUTPUT: Values: 58.0 61.0 61.0 62.0 64.0 61.0 61.0 60.0 59.0 60.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 64.0 64.0 66.0 64.0 64.0 66.0 65.0 65.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:86.00 stddev:3.02 (3.5%) stddev-sans-first:3.18 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: Values: 86.0 89.0 86.0 82.0 84.0 81.0 82.0 83.0 88.0 89.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:119.00 stddev:6.10 (5.1%) stddev-sans-first:6.13 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: Values: 112.0 120.0 111.0 114.0 127.0 113.0 127.0 121.0 118.0 112.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:146.00 stddev:6.57 (4.5%) stddev-sans-first:6.00 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: Values: 135.0 149.0 146.0 146.0 156.0 147.0 146.0 134.0 140.0 146.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 66.0 66.0 65.0 68.0 67.0 69.0 64.0 66.0 03:28:51 INFO - 2016-01-21 03:28:51,222 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:28:51 INFO - 2016-01-21 03:28:51,223 DEBUG : BROWSER_OUTPUT: 03:28:52 INFO - 2016-01-21 03:28:52,058 INFO : Browser exited with error code: 0 03:28:52 INFO - 2016-01-21 03:28:52,137 INFO : Completed test kraken (00:00:59) 03:28:52 INFO - 2016-01-21 03:28:52,137 INFO : Starting test v8_7 03:28:52 INFO - 2016-01-21 03:28:52,137 DEBUG : operating with platform_type : linux_ 03:28:52 INFO - 2016-01-21 03:28:52,137 INFO : Initialising browser for v8_7 test... 03:28:52 INFO - 2016-01-21 03:28:52,143 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_9llGL/profile http://localhost:37222/getInfo.html 03:28:55 INFO - 2016-01-21 03:28:55,703 DEBUG : BROWSER_OUTPUT: 03:28:55 INFO - 2016-01-21 03:28:55,703 DEBUG : BROWSER_OUTPUT: (process:24472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:28:56 INFO - 2016-01-21 03:28:56,577 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:28:56 INFO - 2016-01-21 03:28:56,577 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:28:56 INFO - 2016-01-21 03:28:56,578 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:28:56 INFO - 2016-01-21 03:28:56,578 DEBUG : BROWSER_OUTPUT: __metrics 03:28:57 INFO - 2016-01-21 03:28:57,617 INFO : Browser initialized. 03:28:57 INFO - 2016-01-21 03:28:57,618 INFO : Running cycle 1/1 for v8_7 test... 03:28:57 INFO - 2016-01-21 03:28:57,618 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_9llGL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:28:58 INFO - 2016-01-21 03:28:58,916 DEBUG : BROWSER_OUTPUT: 03:28:58 INFO - 2016-01-21 03:28:58,916 DEBUG : BROWSER_OUTPUT: (process:24587): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:29:09 INFO - 2016-01-21 03:29:09,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 135892992 03:29:09 INFO - 2016-01-21 03:29:09,426 DEBUG : BROWSER_OUTPUT: 03:29:30 INFO - 2016-01-21 03:29:30,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37222/tests/v8_7/run.html (next: http://localhost:37222/tests/v8_7/run.html) 03:29:31 INFO - 2016-01-21 03:29:31,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 136138752 03:29:31 INFO - 2016-01-21 03:29:31,060 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,061 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:29:31 INFO - 2016-01-21 03:29:31,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:29:31 INFO - 2016-01-21 03:29:31,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:29:31 INFO - 2016-01-21 03:29:31,061 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0437365901964 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.6944490748458 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |4;RayTrace;916.5902841429881 03:29:31 INFO - 2016-01-21 03:29:31,062 DEBUG : BROWSER_OUTPUT: |5;Earley;547.645125958379 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: |6;Boyer;10670.212765957447 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: |7;RegExp;23651.162790697676 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: |8;Splay;520.5408216328653 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1453375771058__endTimestamp 03:29:31 INFO - 2016-01-21 03:29:31,063 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,064 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:29:31 INFO - 2016-01-21 03:29:31,064 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:29:31 INFO - 2016-01-21 03:29:31,064 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,064 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.04 Median:165.04 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,064 DEBUG : BROWSER_OUTPUT: Values: 165.0 03:29:31 INFO - 2016-01-21 03:29:31,065 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,065 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,065 DEBUG : BROWSER_OUTPUT: Values: 166.7 03:29:31 INFO - 2016-01-21 03:29:31,065 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,065 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,066 DEBUG : BROWSER_OUTPUT: Values: 278.6 03:29:31 INFO - 2016-01-21 03:29:31,066 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,066 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,066 DEBUG : BROWSER_OUTPUT: Values: 5154.6 03:29:31 INFO - 2016-01-21 03:29:31,066 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,067 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:916.59 Median:916.59 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,067 DEBUG : BROWSER_OUTPUT: Values: 916.6 03:29:31 INFO - 2016-01-21 03:29:31,067 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,067 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.65 Median:547.65 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,067 DEBUG : BROWSER_OUTPUT: Values: 547.6 03:29:31 INFO - 2016-01-21 03:29:31,068 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10670.21 Median:10670.21 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: Values: 10670.2 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23651.16 Median:23651.16 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: Values: 23651.2 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:520.54 Median:520.54 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: Values: 520.5 03:29:31 INFO - 2016-01-21 03:29:31,069 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,070 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 03:29:31 INFO - 2016-01-21 03:29:31,070 DEBUG : BROWSER_OUTPUT: Values: 4850.2 03:29:31 INFO - 2016-01-21 03:29:31,070 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:29:31 INFO - 2016-01-21 03:29:31,070 DEBUG : BROWSER_OUTPUT: 03:29:31 INFO - 2016-01-21 03:29:31,893 INFO : Browser exited with error code: 0 03:29:31 INFO - 2016-01-21 03:29:31,912 INFO : Completed test v8_7 (00:00:39) 03:29:32 INFO - 2016-01-21 03:29:32,090 INFO : Completed test suite (00:20:08) 03:29:32 INFO - 2016-01-21 03:29:32,091 DEBUG : Working with test: dromaeo_css 03:29:32 INFO - 2016-01-21 03:29:32,091 DEBUG : Generating results file: dromaeo_css 03:29:32 INFO - 2016-01-21 03:29:32,092 DEBUG : Working with test: kraken 03:29:32 INFO - 2016-01-21 03:29:32,092 DEBUG : Generating results file: kraken 03:29:32 INFO - 2016-01-21 03:29:32,092 INFO : javascript benchmark 03:29:32 INFO - 2016-01-21 03:29:32,092 DEBUG : Working with test: v8_7 03:29:32 INFO - 2016-01-21 03:29:32,092 DEBUG : Generating results file: v8_7 03:29:32 INFO - 2016-01-21 03:29:32,093 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:32 INFO - 2016-01-21 03:29:32,149 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:29:32 INFO - 2016-01-21 03:29:32,149 DEBUG : process_Request line: dromaeo_css 7391.45 graph.html#tests=[[72,52,43]] 03:29:32 INFO - 2016-01-21 03:29:32,149 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:32 INFO - 2016-01-21 03:29:32,183 DEBUG : process_Request line: kraken 1504.10 graph.html#tests=[[232,52,43]] 03:29:32 INFO - 2016-01-21 03:29:32,183 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:29:32 INFO - 2016-01-21 03:29:32,212 DEBUG : process_Request line: v8_7 23400.51 graph.html#tests=[[230,52,43]] 03:29:32 INFO - 2016-01-21 03:29:32,213 INFO : javascript benchmark 03:29:32 INFO - 2016-01-21 03:29:32,217 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.16585270756, 3342.014105838779, 3351.6983471487592, 3363.8318084095795, 3373.89878303651, 5569.470900264473, 5595.300587426572, 5600.6079574429805, 5614.410486898878, 5620.803271885485, 5570.972145139269, 5598.944010559893, 5611.214429979796, 5630.09918413054, 5655.943440565593, 5044.470330615288, 5136.948630513703, 5174.456682048387, 5212.687238765686, 5231.163013917774, 4993.226049962243, 5022.547970682638, 5117.974410127944, 5161.148410512261, 5163.993021360836, 5051.823186188484, 5077.263796749469, 5110.514501122388, 5114.641975061747, 5131.179011358184, 5034.068697290976, 5048.6465947383695, 5064.645474816764, 5098.872528186788, 5140.485951404867, 4867.123917694814, 4921.237208232729, 4965.751712414401, 4973.676711013773, 5027.522385373383, 5377.838664840061, 5377.865553361158, 5401.162819762943, 5451.727413629303, 5471.945280547184, 5925.940740592625, 6038.3659715729655, 6061.515078793686, 6064.484518815906, 6065.878682426371, 5753.88492230153, 5936.792212272593, 5995.040793473067, 6076.817695469099, 6113.44978951892, 5633.464820842013, 5650.5479561634975, 5684.886302273972, 5703.3441154267375, 5711.114777209539, 6134.7852825151795, 6142.846428839315, 6154.5384096192965, 6160.10678451622, 6169.8457538561, 5610.4670056344585, 5725.484706376446, 5767.567432442584, 5856.209411729362, 5881.264841894763, 5948.762049518057, 6024.668643224665, 6036.9698151508965, 6040.09398590215, 6042.758289668452, 5820.854478638068, 5957.285125784847, 6014.097885317237, 6016.69916504173, 6029.186059881859, 5839.357670656224, 5916.645001299936, 5927.9407205928255, 5945.435183657545, 5999.610025348338, 4600.42494688164, 4614.146382919103, 4615.376924115269, 4626.907461850811, 4644.837430689977, 3906.824192911326, 4009.0578714002186, 4131.0, 4136.9793151034655, 4184.769837658958, 5666.17840413146, 5677.120046392815, 5703.287089113861, 5738.68437235956, 5786.826395208151, 5981.551383646157, 6029.909551356734, 6038.456538911519, 6042.093685947143, 6045.244344456943, 5556.0, 5635.351934527582, 5726.79956201531, 5746.166805813134, 5750.971245143831, 5202.193659982709, 5283.735813209324, 5288.947110528922, 5307.389650190277, 5318.122509785842, 6179.907301390483, 6194.101855230966, 6195.0, 6201.410865967816, 6225.315215326311, 5747.511461525817, 5883.911741323798, 5927.792527261525, 5996.850078748066, 6075.422834830772, 6156.168917196122, 6221.191245138284, 6229.719662615103, 6231.563790534619, 6269.68651567429, 5918.141869428822, 5953.970230148995, 5962.940370596239, 5966.403359663999, 5973.283206015306, 5847.619904706181, 5955.6724380157775, 6012.488938440281, 6072.453479186895, 6119.35746746603, 5887.764489420547, 5902.1441890926435, 5904.793332233351, 5926.67403292823, 5939.0, 5901.1443340714495, 5920.319163296103, 5925.466707996301, 5925.911111333247, 5940.0, 5668.5465162787705, 5676.318841738853, 5723.0, 5778.508826749773, 5815.41845815415, 5785.074388097884, 5849.298084229919, 5856.590038697421, 5868.471837534642, 5967.31375891778, 5624.268845050281, 5762.481376676119, 5781.161731548986, 5784.305883294031, 5784.768609255582], "unit": "ms", "name": "dojo.html", "value": 5527.177290736045}, {"lowerIsBetter": false, "replicates": [595.2618752746596, 596.1207219351456, 600.8888355654204, 626.4424662050773, 633.771842136831, 39966.000849978765, 40464.797676011614, 41078.0, 41084.99999999996, 41201.17597648049, 45215.32177017339, 45623.31565026527, 45802.083958320814, 45884.54115458844, 45925.0, 9226.723198304062, 9363.438193708365, 9381.343305968585, 9388.061193880625, 9436.150746432819, 9135.451872887616, 9195.678151264707, 9212.401193922407, 9277.0, 9296.256299496024, 9162.404443711172, 9165.175134237918, 9241.815163696721, 9262.166405023547, 9263.953680231589, 9264.212541933945, 9349.579268932914, 9364.297677674167, 9369.625214991393, 9377.859332110058, 9133.588988495534, 9342.57958391874, 9357.111074447917, 9368.765780855465, 9377.296702747253, 42555.0, 43044.78477607592, 43050.0, 43062.0, 43076.35385469221, 3293.9835300823584, 3690.1143725505685, 3752.3058234226482, 3761.3041587306434, 3769.9623003769884, 30035.249118772204, 30301.69698303011, 30508.0, 30617.38765224683, 30934.38131237385, 4050.9392359114636, 4058.9797051014853, 4065.8170382332864, 4072.8370865165653, 4123.299039163349, 235184.0, 235415.0, 236382.0, 236768.0, 237030.0, 44747.328790068175, 45046.77476612662, 45232.0, 56854.71572642193, 57195.0, 43040.0, 43080.0, 43132.35301470481, 43187.0, 43277.783611081744, 17233.396831111102, 17287.222075006404, 17390.739138912926, 17421.47735567935, 17441.040742759018, 13494.93252533731, 13543.864561354458, 13545.59363219105, 13569.0, 13576.524821631196, 15298.617534561503, 15322.540323790305, 15365.308561114776, 15376.0, 15378.231088445757, 5978.5814992950945, 6016.308124565643, 6019.398060193946, 6093.939060609426, 6099.024156134997, 986.2603047714215, 1049.040128282628, 1050.779336339362, 1080.8540846985713, 1112.3881864974232, 29518.852405737834, 29858.40283194324, 29890.850545747566, 30451.69548304533, 30488.237794055327, 1053.773438710681, 1076.1283360478037, 1122.1247427006947, 1172.472387425662, 1186.489809381974, 14823.70352592942, 14983.400663973536, 14988.400463981538, 15238.542843714706, 15488.148151851756, 731661.0, 732860.0, 733776.0, 735758.0, 794572.0, 58005.4199458, 58366.12450813241, 58863.70568147132, 58991.0, 59044.0, 1428.607133038402, 1430.6709456824988, 1433.1401159304542, 1452.6949340638373, 1459.4599998000808, 30060.398792024476, 30435.695643043287, 30781.0, 31083.844580776953, 31356.52965205478, 47594.52405475901, 47628.285575717084, 47651.285230722264, 47746.52253477421, 47781.0, 329044.0, 330173.0, 332504.0, 332649.0, 335287.0, 33429.49855752214, 33682.32635347328, 33743.0, 33858.83070584631, 34102.48846267357, 44994.75173988523, 45293.0, 45693.31460028169, 45742.542574575156, 46053.30920036135, 37936.24127517379, 38345.233095338495, 38845.80577097096, 39259.6074039256, 39535.80232098821, 38400.6159938397, 38891.61108388993, 39063.38952006161, 39274.214515708954, 39548.40677389899, 38559.6144038556, 43715.0, 44300.33549496696, 44681.77659111684, 45391.773041134584, 34790.47814282737, 35350.82324588361, 35548.28903421969, 35568.46647300241, 35581.64418355783, 27120.32199194957, 27649.308767280174, 27694.74739314542, 27762.305942351602, 28073.859630701714], "unit": "ms", "name": "ext.html", "value": 19502.729723570115}, {"lowerIsBetter": false, "replicates": [363.15022846539125, 374.6197609426431, 382.28131113506606, 383.33300057899254, 389.2778895149498, 15213.543593692208, 16777.916110419446, 18180.727289090675, 19075.523111922208, 19127.617447651057, 17660.82339176608, 17705.822941770577, 17851.375201867937, 18039.72940405892, 18051.548711282223, 5548.140038294061, 5614.494695477406, 5666.348369937448, 5668.234788303567, 5669.291338582677, 5429.782808687667, 5517.393086760453, 5599.580031497633, 5611.270534830487, 5615.4665306796, 5546.500814926656, 5564.610477266573, 5581.246531718207, 5592.273004509429, 5772.307323121231, 4980.551750342468, 5888.322842873082, 5890.941090589082, 5891.734871930774, 5899.5870289079785, 5564.276644036249, 5614.6631202128, 5647.689377084259, 5708.65748055118, 5746.569007324426, 13308.600741977756, 13476.595702128854, 13553.186808791406, 13572.660683482893, 13832.585022449342, 2139.251262058267, 2237.8433509654333, 2249.1228420915854, 2269.307861102363, 2313.5141620259765, 10301.032696229771, 10363.48182590875, 10537.73655658607, 10553.314034587727, 10638.308509946828, 1873.4941565777165, 1905.7998910114377, 1945.6400565895356, 1950.7366505521716, 1981.9405417837488, 64898.67550662217, 66686.66656666686, 67495.66252168707, 67988.6600566994, 68677.96983045258, 10770.730731731614, 10860.511276992554, 10885.346879187116, 10897.891021089688, 10910.836337454944, 14451.638709032359, 14507.492237771627, 14527.201003944885, 14530.782038269434, 14567.41730330775, 8122.065962414398, 8157.8368432632205, 8218.424710270343, 8458.661653533913, 8586.356023298153, 8098.7165449209, 8141.267285944294, 8193.344532437392, 8254.752357429286, 8280.958595206985, 4337.9783101084295, 4491.034427598082, 4560.726356418625, 4593.678442509059, 4646.4191976003, 1927.9710804337947, 1929.778075521305, 2004.5690176612097, 2007.4078146946686, 2014.9421553684433, 957.4686049242598, 1012.2003617142523, 1031.1441503552035, 1055.8416237564272, 1119.4850368830266, 16411.097389643684, 17509.824901751075, 19273.22907083701, 19417.126229319714, 19534.5116372089, 954.1174413667469, 989.6981420666766, 1045.6601604478574, 1064.9414282214552, 1083.409541799721, 10409.68770936873, 10426.895731042745, 10434.37393756377, 10506.789864202674, 10517.684469465776, 630053.0, 637858.0, 648557.0, 674120.0, 678671.0, 86921.5653921739, 87537.0, 89057.55471222731, 90600.5469972659, 90621.54689226643, 1217.7686239614268, 1222.6148763139583, 1236.3014896583402, 1250.4498020870788, 1265.5064524835323, 15471.226438678246, 16169.0, 16261.105639189485, 16310.510684679479, 16985.49043528696, 34749.82625086858, 34815.65184348124, 35467.64532354747, 35820.28359432745, 35835.82082089573, 42053.579464204966, 42856.57143428526, 44532.55467445284, 46559.76720116378, 48189.75905120452, 9991.650292239738, 10124.69625911224, 10182.287239893136, 10183.592656293962, 10579.94710026445, 17432.65134697324, 17971.73042404391, 18184.45446636603, 18752.0, 19098.23607055702, 15056.397744090114, 15178.0, 15361.923190383977, 15422.383104675688, 15601.063936163866, 14798.556043318718, 15181.089134651515, 15187.696246075238, 15463.458778942682, 15724.977876437995, 14705.33825977855, 15070.0, 15789.605259868595, 16029.438969636007, 16182.838171618134, 10111.59553617847, 10136.847947280945, 10216.795664086825, 10230.539625717009, 10319.380837149794, 11167.274127181707, 14499.78250326267, 15183.620409489851, 15290.541283761506, 16256.756148657543], "unit": "ms", "name": "jquery.html", "value": 9388.594485276033}, {"lowerIsBetter": false, "replicates": [1547.1722628393811, 1549.8217704963924, 1722.2249987505625, 1784.5806235534646, 1833.945481348225, 7583.582902940343, 7910.36717062635, 8035.116137224901, 8043.155468675785, 8043.396745244108, 7873.330766884822, 7915.2084791520965, 7984.840303193932, 7993.560354180518, 8002.0797608274925, 2320.8027317677975, 2338.5673650374733, 2344.495933374324, 2346.7770561796688, 2348.5889969255313, 2360.5396947595227, 2368.5973384524673, 2386.2364043506086, 2400.3759022654062, 2403.567357875582, 2191.868487890724, 2202.394341556077, 2215.789499997498, 2251.1783199132283, 2254.571631390039, 2295.4605667668084, 2335.054303007285, 2363.95272094558, 2366.4438856868624, 2370.6444033394955, 2330.755270696586, 2370.383700237933, 2372.8457650252676, 2375.09746296408, 2375.3586531636533, 7911.723089691834, 7912.683492660287, 8002.839943201162, 8009.639566219534, 8017.719379821737, 4857.077155340474, 4927.162382395001, 4951.876203094951, 4965.478624744386, 4968.90062198754, 3113.937721245585, 3151.6848315168527, 3196.280836811722, 3203.343314620497, 3238.9352212955846, 1054.9103326217205, 1059.6079450603327, 1060.0989159214682, 1083.0577397664083, 1083.0956151613411, 10782.13742900574, 10785.62250321235, 10870.0, 10891.237613367068, 10904.073153781937, 4199.9370009449885, 4253.106847562047, 4303.117860838521, 4303.462067241595, 4310.762908040025, 8873.378863479624, 8896.065913079034, 8896.377253592316, 8926.419782714103, 8934.374593778502, 4858.82994095205, 4861.465238823726, 4874.0495603357, 4879.902401951941, 4888.242322440027, 4449.933251001237, 4451.866444006685, 4478.596926276651, 4499.370088187657, 4505.954940450619, 3440.7419443541835, 3471.4272145096284, 3487.773294735834, 3488.930221395558, 3497.4753786932165, 1095.3756358875364, 1115.9163062770324, 1116.564539829467, 1121.7419993401563, 1184.768970050849, 1118.7818375416716, 1131.7170707323169, 1171.824226366052, 1179.675589212956, 1191.4638412714314, 7594.050743657043, 7596.620168991528, 7598.278163574451, 7604.657790399446, 7717.459777815499, 1167.2121318110242, 1180.6458062581191, 1180.8819118088122, 1185.6265276437894, 1216.4951545108859, 6033.818985430444, 6050.48570871472, 6054.091886217103, 6075.058365953284, 6095.512359011268, 9101.863472047924, 9578.760530986781, 9614.03859614047, 9624.711258662252, 9632.566534505964, 9324.720258392259, 9372.812543749087, 9379.20276776468, 9401.905980940102, 9429.198518126037, 7209.0988626421695, 7401.925980740231, 7426.368758655467, 7456.0, 7477.999999999891, 7156.427485801228, 7244.855102898018, 7245.420366370572, 7272.41820654357, 7275.308845659654, 8183.8772418414965, 8232.17678232172, 8328.6668533258, 8340.749777506684, 8391.118932512243, 8207.220314070153, 8464.153584641486, 8473.49159050459, 8484.236418722097, 8511.574421278787, 6787.117674702257, 6828.317168283132, 6844.691988860413, 6845.589264644137, 6849.931500685128, 7511.436642251962, 7515.962420187864, 7560.130584982798, 7561.243875612395, 7566.31903128721, 6892.655367231518, 6915.308469153045, 6923.688434020381, 6984.16190057176, 7124.608146551782, 6825.726970921108, 7031.22656507794, 7059.894101588583, 7108.715651373887, 7173.0675012248075, 7233.3851622612665, 7273.8908916365235, 7284.053073100463, 7290.3438690518105, 7298.306660867209, 6544.509161812978, 6558.114654521769, 6585.736570537125, 6592.80221593353, 6637.535372523877, 6626.56927299724, 6753.223379311442, 6753.3246675332075, 6756.054152418567, 6789.592624442549], "unit": "ms", "name": "mootools.html", "value": 4575.808626013545}, {"lowerIsBetter": false, "replicates": [366.5326708446731, 370.1948262528999, 373.2888846746948, 375.4349703695937, 376.2343630711501, 6347.492200623945, 6358.61848289103, 6401.71192296346, 6449.54853160279, 6453.096566480691, 6118.0, 6284.591501552407, 6309.179806625132, 6314.589551679138, 6321.873562528758, 4912.336834527328, 4914.803407863681, 4925.064237794825, 4925.310456536088, 4931.358923339961, 4918.704877707331, 4923.75381230937, 4928.063667903105, 4929.556339929406, 4935.481774413689, 4745.477997420281, 4884.462709101996, 4887.755612219393, 4893.339399181118, 4895.11887860185, 4852.150873597124, 4874.610031197496, 4884.780184891689, 4893.388326459192, 4914.189158788813, 4340.110277393158, 4345.47854257488, 4350.347447882811, 4356.390105385249, 4361.887718631729, 5947.613405128653, 6043.576949613529, 6055.485283750886, 6063.090536419529, 6073.908891366633, 5677.205191273225, 5680.403557626472, 5690.658560486384, 5692.37383887772, 5702.0, 6704.296048914891, 6716.261211266757, 6722.563033402813, 6723.865522689568, 6730.9903514472735, 4753.83361582343, 4780.426348838162, 4781.760911954389, 4784.40194975628, 4800.231962885921, 6769.492288078413, 6922.100126983511, 6987.7204911803465, 6995.40539054181, 6998.7402267591815, 4937.580305674058, 4938.58022068121, 4940.110780059624, 4942.851714448572, 4951.158303088484, 4997.125503036954, 5001.699898006132, 5009.323741294878, 5014.749262536859, 5017.37282839645, 5628.634138780966, 5686.521504408884, 5717.085266357446, 5717.742701578439, 5727.6849773262875, 6772.864542709217, 6787.423069039089, 6792.864142717217, 6797.626130562867, 6805.591664500146, 1722.6468573942561, 1779.8665100117544, 1781.4210381626024, 1782.295993082751, 1784.5538615346163, 1219.8597161326384, 1221.883921027501, 1224.675461002835, 1237.832892559511, 1246.6197809667956, 6547.410733034049, 6563.0, 6574.704138313788, 6577.2436169841085, 6583.275839657634, 6914.481413893978, 6923.099997000358, 6931.79204623852, 6932.064171336906, 6955.652217389212, 6389.9361006389345, 6562.212534495796, 6562.80311590653, 6563.3764792344655, 6575.967120164369, 3761.492198553215, 3796.772193668389, 3802.6007269236884, 3803.220339830328, 3807.2575847709986, 7159.248278930741, 7178.641067946582, 7193.604351760703, 7196.0, 7209.423246140296, 7031.050808140835, 7077.292270772881, 7125.50121491501, 7135.250798666169, 7267.236940121211, 7278.199398066208, 7304.817379565553, 7337.19290878003, 7345.77962661121, 7357.448191385667, 7060.117485314336, 7063.752768653072, 7098.183708873546, 7110.253423390676, 7115.1106111736035, 6856.108705868205, 6958.512904096665, 6976.4767642426, 6983.9650801745665, 7004.229534751072, 7278.636068196463, 7309.378702810321, 7311.0, 7337.6698048589005, 7342.5227360221415, 4792.784324705466, 4834.057358814997, 4847.733374664286, 4851.296561998561, 4871.391076115486, 6906.240313565403, 6949.30506949301, 7072.752453664097, 7097.183823860322, 7105.964470177616, 6827.863442731018, 6881.552699074544, 6896.655167241718, 6916.481263905127, 6919.757808476679, 6798.83002924911, 6824.249332573512, 6849.965750171217, 6864.347886950732, 6865.691043902936, 6537.248216454978, 6763.391294783296, 6767.0, 6767.695453704497, 6772.051912732123, 6909.619970901447, 6928.688209030706, 6930.3762661360715, 6944.270851560514, 6946.340097690711, 6614.867702645824, 6705.0, 6745.055692202997, 6747.831304217238, 6759.763408280686], "unit": "ms", "name": "prototype.html", "value": 5161.887563499869}, {"lowerIsBetter": false, "replicates": [782.2177822177822, 805.5166899860085, 810.5866008335747, 845.4124383553429, 900.0684291758027, 15840.920795396021, 15978.76031859523, 16045.358185672589, 16056.27746751396, 16076.115813630246, 14755.18846463444, 14861.108333499971, 14909.254537273147, 14917.32872020759, 14918.508149185076, 888.6578667213137, 906.8231694819513, 908.2597682888425, 915.4095608332622, 918.4718786697642, 900.0729248873638, 904.3759805734022, 905.6830109461669, 905.7373361725125, 908.5230254116609, 945.1021529546923, 950.6197520991624, 952.342883410448, 953.275510611933, 954.6706386296751, 941.2093841173447, 941.7975135345899, 943.3160958305242, 943.4197968249512, 944.7874228298647, 694.7741983855267, 698.4866123399297, 700.3556727810427, 700.7442283566512, 701.8420855307565, 13946.372413241428, 13973.0, 13995.090319129224, 14032.298385080705, 14104.647383815383, 12692.619221423372, 12933.54732584355, 13101.41043653038, 13236.0, 13334.066615336931, 10546.683599492027, 10577.418241996687, 10608.469576521144, 10717.0, 10897.891021089767, 3710.9072273193115, 3737.252549490113, 3742.850285988557, 3749.2876353492748, 3772.622737726233, 49241.50758492405, 49498.0, 49520.50479495195, 49832.50167498315, 49952.25071623892, 10244.0, 10467.94766026165, 10500.107490863209, 10700.625478108228, 10853.077488413415, 18474.63050738978, 18523.44429667112, 18560.907195464206, 18609.44171674852, 18632.44102676922, 7946.40401969843, 7968.721094761656, 8062.435629505995, 8375.916240837514, 8532.957335213285, 4445.51099379068, 4492.124035812985, 4568.817247310137, 4722.6221902247735, 4810.542998415145, 3334.9333013339597, 3358.1436733633254, 3366.107981384935, 3366.6128395234373, 3376.9324613507592, 579.4784693775551, 623.3454872383978, 627.8367624417684, 628.214731585518, 629.0626965820894, 653.3051163948711, 655.7016557466342, 668.5787953589207, 693.9673626253306, 699.9685014174374, 9334.113259240361, 9353.766155846159, 9495.0, 9522.619095236252, 9664.03359664028, 708.2598684374841, 713.4791602130474, 714.118064190724, 723.4682508356353, 769.9730509432255, 4324.762138082436, 4426.535213802569, 4448.733076015449, 4504.324351347259, 4784.593309568726, 55387.0, 57126.7143664279, 57485.425145748006, 57691.0, 58222.70888645529, 52004.47995519996, 52561.47438525642, 52949.47050529523, 53825.1926221107, 53874.0, 46769.532304677195, 46853.297200542016, 46941.76529117401, 47202.05595888063, 47428.525714743104, 9225.062736825343, 9295.581698823435, 9334.0, 9390.24878009744, 9435.009324020879, 34580.0, 35431.0, 35524.0, 35733.82133089318, 35835.10412239715, 50969.74515127401, 51988.0, 52153.0, 52775.47224527706, 53371.0, 11458.94270528642, 11576.826347604961, 11729.824052639047, 12183.086268529718, 12310.13829031995, 13228.338583071001, 13542.06694180633, 13792.793108103588, 13864.445422183, 13982.440702372198, 11548.0, 11840.230385024946, 12277.815832762695, 12787.296698681661, 12847.357632118543, 12199.390030498616, 12204.511819527119, 12235.877641223475, 12538.811917821422, 12849.229046257255, 12272.509099636272, 12400.56598019065, 12408.069394795608, 12740.299283539123, 13063.150895191782, 10610.0, 10753.46232688378, 10967.341959482457, 10998.0, 11114.555417783198, 10236.385816851012, 10411.375317480975, 10641.467926603793, 10759.731006724895, 10850.728731781768], "unit": "ms", "name": "yui.html", "value": 6821.263253229132}], "name": "dromaeo_css", "value": 7391.449967288053}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 113.0, 112.0, 121.0, 111.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [157.0, 123.0, 150.0, 159.0, 131.0, 152.0, 152.0, 128.0, 164.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 168.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 72.0, 150.0, 72.0, 72.0, 72.0, 73.0, 157.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 133.0, 91.0, 92.0, 92.0, 136.0, 92.0, 92.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 111.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 98.0, 96.0, 97.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 61.0, 62.0, 64.0, 61.0, 61.0, 60.0, 59.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 64.0, 64.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [86.0, 89.0, 86.0, 82.0, 84.0, 81.0, 82.0, 83.0, 88.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [112.0, 120.0, 111.0, 114.0, 127.0, 113.0, 127.0, 121.0, 118.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 146.0, 146.0, 156.0, 147.0, 146.0, 134.0, 140.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 68.0, 67.0, 69.0, 64.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1504.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0437365901964], "unit": "score", "name": "Richards", "value": 213.894818}, {"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "DeltaBlue", "value": 396.64188200000007}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [916.5902841429881], "unit": "score", "name": "RayTrace", "value": 807.327999}, {"lowerIsBetter": false, "replicates": [547.645125958379], "unit": "score", "name": "Earley", "value": 1216.961438}, {"lowerIsBetter": false, "replicates": [10670.212765957447], "unit": "score", "name": "Boyer", "value": 62.46014157527414}, {"lowerIsBetter": false, "replicates": [23651.162790697676], "unit": "score", "name": "RegExp", "value": 38.51755653883975}, {"lowerIsBetter": false, "replicates": [520.5408216328653], "unit": "score", "name": "Splay", "value": 156.55064235764237}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 23400.507888443768}]} 03:29:32 INFO - RETURN: dromaeo_css: 7391.45 03:29:32 INFO - RETURN: kraken: 1504.10 03:29:32 INFO - RETURN: v8_7: 23400.51 03:29:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23400.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7391.45"}}} 03:29:32 INFO - Return code: 0 03:29:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:29:32 INFO - # TBPL SUCCESS # 03:29:32 INFO - Running post-action listener: _resource_record_post_action 03:29:32 INFO - Running post-run listener: _resource_record_post_run 03:29:33 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 282624; Write bytes: 507711488; Read time: 68; Write time: 520868 03:29:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 237928448; Read time: 0; Write time: 351800 03:29:33 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 282624; Write bytes: 269783040; Read time: 68; Write time: 169068 03:29:33 INFO - Running post-run listener: _upload_blobber_files 03:29:33 INFO - Blob upload gear active. 03:29:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:29:33 INFO - Copying logs to upload dir... 03:29:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.540706 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-21 03:29:33.341288) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 03:29:33.345106) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010085 build_url: 'https://queue.taskcluster.net/v1/task/FEfjg3tUTaK5fQkncCPv4Q/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 03:29:33.397869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:29:33.398241) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1453370334.973842-284125361 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 03:29:33.448586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 03:29:33.448935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 03:29:33.449286) ========= ========= Total master_lag: 0.26 =========