builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1453394730.12 results: success (0) buildid: 20160121061721 builduid: c065713d7dc543488d404410584f8b2d revision: 01b93573f9d466514485a3188bc666bb621d09bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.124078) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.124606) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.124945) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004908 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.147264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.147601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.163137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.163714) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.213652) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.214004) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.214419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.214747) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 08:45:30-- 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% 218M=0s 2016-01-21 08:45:30 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.447681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.448398) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020870 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:30.501921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 08:45:30.502273) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 01b93573f9d466514485a3188bc666bb621d09bb --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 01b93573f9d466514485a3188bc666bb621d09bb --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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 08:45:30,636 truncating revision to first 12 chars 2016-01-21 08:45:30,637 Setting DEBUG logging. 2016-01-21 08:45:30,637 attempt 1/10 2016-01-21 08:45:30,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/01b93573f9d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 08:45:31,593 unpacking tar archive at: mozilla-aurora-01b93573f9d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232195 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 08:45:31.748041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.748446) ========= echo 01b93573f9d466514485a3188bc666bb621d09bb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'01b93573f9d466514485a3188bc666bb621d09bb'] 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01b93573f9d466514485a3188bc666bb621d09bb program finished with exit code 0 elapsedTime=0.003553 script_repo_revision: '01b93573f9d466514485a3188bc666bb621d09bb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.798969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.799324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.810116) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.810426) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/01b93573f9d466514485a3188bc666bb621d09bb ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 08:45:31.810852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-21 08:45:31.811192) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:32 INFO - MultiFileLogger online at 20160121 08:45:32 in /builds/slave/test-pgo 08:45:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:45:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:45:32 INFO - {'append_to_log': False, 08:45:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:45:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:45:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:45:32 INFO - 'branch': 'Mozilla-Aurora', 08:45:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:32 INFO - 'config_files': ('talos/linux_config.py',), 08:45:32 INFO - 'default_actions': ('clobber', 08:45:32 INFO - 'read-buildbot-config', 08:45:32 INFO - 'download-and-extract', 08:45:32 INFO - 'populate-webroot', 08:45:32 INFO - 'create-virtualenv', 08:45:32 INFO - 'install', 08:45:32 INFO - 'run-tests'), 08:45:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:32 INFO - 'download_minidump_stackwalk': True, 08:45:32 INFO - 'download_symbols': 'ondemand', 08:45:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:32 INFO - 'installer_path': 'installer.exe', 08:45:32 INFO - 'log_level': 'info', 08:45:32 INFO - 'log_name': 'talos', 08:45:32 INFO - 'log_to_console': True, 08:45:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:32 INFO - 'opt_config_files': (), 08:45:32 INFO - 'pip_index': False, 08:45:32 INFO - 'sps_profile': False, 08:45:32 INFO - 'sps_profile_interval': 0, 08:45:32 INFO - 'suite': 'dromaeojs', 08:45:32 INFO - 'system_bits': '32', 08:45:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:32 INFO - 'title': 'talos-linux64-ix-022', 08:45:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:32 INFO - 'use_talos_json': True, 08:45:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:45:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:32 INFO - 'work_dir': 'build'} 08:45:32 INFO - ##### 08:45:32 INFO - ##### Running clobber step. 08:45:32 INFO - ##### 08:45:32 INFO - Running pre-action listener: _resource_record_pre_action 08:45:32 INFO - Running main action method: clobber 08:45:32 INFO - rmtree: /builds/slave/test-pgo/build 08:45:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:45:32 INFO - Running post-action listener: _resource_record_post_action 08:45:32 INFO - ##### 08:45:32 INFO - ##### Running read-buildbot-config step. 08:45:32 INFO - ##### 08:45:32 INFO - Running pre-action listener: _resource_record_pre_action 08:45:32 INFO - Running main action method: read_buildbot_config 08:45:32 INFO - Using buildbot properties: 08:45:32 INFO - { 08:45:32 INFO - "properties": { 08:45:32 INFO - "buildnumber": 100, 08:45:32 INFO - "product": "firefox", 08:45:32 INFO - "script_repo_revision": "production", 08:45:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:45:32 INFO - "repository": "", 08:45:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:45:32 INFO - "buildid": "20160121061721", 08:45:32 INFO - "slavename": "talos-linux64-ix-022", 08:45:32 INFO - "pgo_build": "True", 08:45:32 INFO - "basedir": "/builds/slave/test-pgo", 08:45:32 INFO - "project": "", 08:45:32 INFO - "platform": "ubuntu64_hw", 08:45:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:45:32 INFO - "slavebuilddir": "test", 08:45:32 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:45:32 INFO - "branch": "mozilla-aurora", 08:45:32 INFO - "repo_path": "releases/mozilla-aurora", 08:45:32 INFO - "stage_platform": "linux64-pgo", 08:45:32 INFO - "builduid": "c065713d7dc543488d404410584f8b2d", 08:45:32 INFO - "revision": "01b93573f9d466514485a3188bc666bb621d09bb" 08:45:32 INFO - }, 08:45:32 INFO - "sourcestamp": { 08:45:32 INFO - "repository": "", 08:45:32 INFO - "hasPatch": false, 08:45:32 INFO - "project": "", 08:45:32 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:45:32 INFO - "changes": [ 08:45:32 INFO - { 08:45:32 INFO - "category": null, 08:45:32 INFO - "files": [ 08:45:32 INFO - { 08:45:32 INFO - "url": null, 08:45:32 INFO - "name": "https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 08:45:32 INFO - } 08:45:32 INFO - ], 08:45:32 INFO - "repository": "", 08:45:32 INFO - "rev": "01b93573f9d466514485a3188bc666bb621d09bb", 08:45:32 INFO - "who": "cbook@mozilla.com", 08:45:32 INFO - "when": 1453394517, 08:45:32 INFO - "number": 7493569, 08:45:32 INFO - "comments": "Bug 1235908 - measure total event wait and process time. r=smaug, a=sylvestre\nNative events come with timestamps indicating when they were created or\ngenerated by the user. Using those, we can get a full picture of how long it\ntakes between the user trying to do something and us responding to it.\n\nThis is currently only for ports that populate WidgetEvent's timeStamp\n(presently gtk, Windows).", 08:45:32 INFO - "project": "", 08:45:32 INFO - "at": "Thu 21 Jan 2016 08:41:57", 08:45:32 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:45:32 INFO - "revlink": "", 08:45:32 INFO - "properties": [ 08:45:32 INFO - [ 08:45:32 INFO - "buildid", 08:45:32 INFO - "20160121061721", 08:45:32 INFO - "Change" 08:45:32 INFO - ], 08:45:32 INFO - [ 08:45:32 INFO - "builduid", 08:45:32 INFO - "c065713d7dc543488d404410584f8b2d", 08:45:32 INFO - "Change" 08:45:32 INFO - ], 08:45:32 INFO - [ 08:45:32 INFO - "pgo_build", 08:45:32 INFO - "True", 08:45:32 INFO - "Change" 08:45:32 INFO - ] 08:45:32 INFO - ], 08:45:32 INFO - "revision": "01b93573f9d466514485a3188bc666bb621d09bb" 08:45:32 INFO - } 08:45:32 INFO - ], 08:45:32 INFO - "revision": "01b93573f9d466514485a3188bc666bb621d09bb" 08:45:32 INFO - } 08:45:32 INFO - } 08:45:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 08:45:32 INFO - Running post-action listener: _resource_record_post_action 08:45:32 INFO - ##### 08:45:32 INFO - ##### Running download-and-extract step. 08:45:32 INFO - ##### 08:45:32 INFO - Running pre-action listener: _resource_record_pre_action 08:45:32 INFO - Running main action method: download_and_extract 08:45:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:45:32 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')]} 08:45:32 INFO - https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/test_packages.json 08:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/test_packages.json 08:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:45:34 INFO - Downloaded 1302 bytes. 08:45:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:45:34 INFO - Using the following test package requirements: 08:45:34 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:45:34 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:45:34 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'jsshell-linux-x86_64.zip'], 08:45:34 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:45:34 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:45:34 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:45:34 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:45:34 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:45:34 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:45:34 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:45:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:45:34 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:45:34 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')]} 08:45:34 INFO - https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:35 INFO - Downloaded 23159479 bytes. 08:45:35 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 08:45:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:35 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 08:45:36 INFO - Return code: 0 08:45:36 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 08:45:36 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')]} 08:45:36 INFO - https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:37 INFO - Downloaded 23159479 bytes. 08:45:37 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 08:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:45:37 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 08:45:38 INFO - Return code: 0 08:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:38 INFO - https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:39 INFO - Downloaded 11132038 bytes. 08:45:39 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 08:45:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:45:39 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 08:45:39 INFO - Return code: 0 08:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:39 INFO - https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/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 08:45:41 INFO - Downloaded 58142139 bytes. 08:45:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:45:41 INFO - mkdir: /builds/slave/test-pgo/properties 08:45:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:45:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:45:41 INFO - Contents: 08:45:41 INFO - build_url:https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:45:41 INFO - Running post-action listener: _resource_record_post_action 08:45:41 INFO - Running post-action listener: set_extra_try_arguments 08:45:41 INFO - ##### 08:45:41 INFO - ##### Running populate-webroot step. 08:45:41 INFO - ##### 08:45:41 INFO - Running pre-action listener: _resource_record_pre_action 08:45:41 INFO - Running main action method: populate_webroot 08:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:41 INFO - '--tppagecycles', 08:45:41 INFO - '7'], 08:45:41 INFO - 'tests': ['tsvgm']}}, 08:45:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:45:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:45:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:45:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'tests': ['damp', 'tps']}, 08:45:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['damp', 'tps']}, 08:45:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:41 INFO - 'other': {'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'other_l64': {'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'other_nol64': {'tests': ['a11yr', 08:45:41 INFO - 'ts_paint', 08:45:41 INFO - 'tpaint', 08:45:41 INFO - 'sessionrestore', 08:45:41 INFO - 'sessionrestore_no_auto_restore']}, 08:45:41 INFO - 'svgr': {'tests': ['tsvgx', 08:45:41 INFO - 'tsvgr_opacity', 08:45:41 INFO - 'tart', 08:45:41 INFO - 'tscrollx', 08:45:41 INFO - 'cart']}, 08:45:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['tsvgx', 08:45:41 INFO - 'tsvgr_opacity', 08:45:41 INFO - 'tart', 08:45:41 INFO - 'tscrollx', 08:45:41 INFO - 'cart']}, 08:45:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'tests': ['tp5o']}, 08:45:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'talos_options': ['--e10s'], 08:45:41 INFO - 'tests': ['tp5o']}, 08:45:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'talos_options': ['--xperf_path', 08:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:41 INFO - 'tests': ['tp5n']}, 08:45:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:41 INFO - 'talos_options': ['--e10s', 08:45:41 INFO - '--xperf_path', 08:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:41 INFO - 'tests': ['tp5n']}}, 08:45:41 INFO - 'talos.zip': {'path': '', 08:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:41 INFO - Running post-action listener: _resource_record_post_action 08:45:41 INFO - ##### 08:45:41 INFO - ##### Running create-virtualenv step. 08:45:41 INFO - ##### 08:45:41 INFO - Running pre-action listener: _resource_record_pre_action 08:45:41 INFO - Running main action method: create_virtualenv 08:45:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:45:41 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 08:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:41 INFO - Using real prefix '/usr' 08:45:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:45:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:43 INFO - Installing pip.................done. 08:45:43 INFO - Return code: 0 08:45:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:43 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:43 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 08:45:43 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 08:45:43 INFO - Using env: {'DISPLAY': ':0', 08:45:43 INFO - 'HOME': '/home/cltbld', 08:45:43 INFO - 'LANG': 'en_US.UTF-8', 08:45:43 INFO - 'LANGUAGE': 'en_US:en', 08:45:43 INFO - 'LOGNAME': 'cltbld', 08:45:43 INFO - 'MAIL': '/var/mail/cltbld', 08:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:43 INFO - 'MOZ_NO_REMOTE': '1', 08:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:43 INFO - 'NO_EM_RESTART': '1', 08:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:43 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:43 INFO - 'SHELL': '/bin/bash', 08:45:43 INFO - 'SHLVL': '1', 08:45:43 INFO - 'TERM': 'linux', 08:45:43 INFO - 'TMOUT': '86400', 08:45:43 INFO - 'USER': 'cltbld', 08:45:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:43 INFO - '_': '/tools/buildbot/bin/python'} 08:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:44 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 08:45:44 INFO - Cleaning up... 08:45:44 INFO - Return code: 0 08:45:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:44 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:44 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 08:45:44 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 08:45:44 INFO - Using env: {'DISPLAY': ':0', 08:45:44 INFO - 'HOME': '/home/cltbld', 08:45:44 INFO - 'LANG': 'en_US.UTF-8', 08:45:44 INFO - 'LANGUAGE': 'en_US:en', 08:45:44 INFO - 'LOGNAME': 'cltbld', 08:45:44 INFO - 'MAIL': '/var/mail/cltbld', 08:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:44 INFO - 'MOZ_NO_REMOTE': '1', 08:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:44 INFO - 'NO_EM_RESTART': '1', 08:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:44 INFO - 'SHELL': '/bin/bash', 08:45:44 INFO - 'SHLVL': '1', 08:45:44 INFO - 'TERM': 'linux', 08:45:44 INFO - 'TMOUT': '86400', 08:45:44 INFO - 'USER': 'cltbld', 08:45:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:44 INFO - '_': '/tools/buildbot/bin/python'} 08:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:44 INFO - Downloading/unpacking psutil>=0.7.1 08:45:44 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 08:45:44 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 08:45:44 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 08:45:44 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 08:45:44 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 08:45:44 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 08:45:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:46 INFO - Installing collected packages: psutil 08:45:46 INFO - Running setup.py install for psutil 08:45:46 INFO - building 'psutil._psutil_linux' extension 08:45:46 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 08:45:46 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 08:45:46 INFO - building 'psutil._psutil_posix' extension 08:45:46 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 08:45:46 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 08:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:46 INFO - Successfully installed psutil 08:45:46 INFO - Cleaning up... 08:45:46 INFO - Return code: 0 08:45:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:45: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')]} 08:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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', '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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:45: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 mozsystemmonitor==0.0.0 08:45:46 INFO - Using env: {'DISPLAY': ':0', 08:45:46 INFO - 'HOME': '/home/cltbld', 08:45:46 INFO - 'LANG': 'en_US.UTF-8', 08:45:46 INFO - 'LANGUAGE': 'en_US:en', 08:45:46 INFO - 'LOGNAME': 'cltbld', 08:45:46 INFO - 'MAIL': '/var/mail/cltbld', 08:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:46 INFO - 'MOZ_NO_REMOTE': '1', 08:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:46 INFO - 'NO_EM_RESTART': '1', 08:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:46 INFO - 'SHELL': '/bin/bash', 08:45:46 INFO - 'SHLVL': '1', 08:45:46 INFO - 'TERM': 'linux', 08:45:46 INFO - 'TMOUT': '86400', 08:45:46 INFO - 'USER': 'cltbld', 08:45:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:46 INFO - '_': '/tools/buildbot/bin/python'} 08:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:45:46 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 08:45:46 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 08:45:46 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 08:45:46 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 08:45:46 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 08:45:46 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 08:45:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:45:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:45:48 INFO - Installing collected packages: mozsystemmonitor 08:45:48 INFO - Running setup.py install for mozsystemmonitor 08:45:48 INFO - Successfully installed mozsystemmonitor 08:45:48 INFO - Cleaning up... 08:45:48 INFO - Return code: 0 08:45:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:45:48 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')]} 08:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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')]} 08:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:48 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 08:45:48 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 08:45:48 INFO - Using env: {'DISPLAY': ':0', 08:45:48 INFO - 'HOME': '/home/cltbld', 08:45:48 INFO - 'LANG': 'en_US.UTF-8', 08:45:48 INFO - 'LANGUAGE': 'en_US:en', 08:45:48 INFO - 'LOGNAME': 'cltbld', 08:45:48 INFO - 'MAIL': '/var/mail/cltbld', 08:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:48 INFO - 'MOZ_NO_REMOTE': '1', 08:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:48 INFO - 'NO_EM_RESTART': '1', 08:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:48 INFO - 'SHELL': '/bin/bash', 08:45:48 INFO - 'SHLVL': '1', 08:45:48 INFO - 'TERM': 'linux', 08:45:48 INFO - 'TMOUT': '86400', 08:45:48 INFO - 'USER': 'cltbld', 08:45:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:48 INFO - '_': '/tools/buildbot/bin/python'} 08:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:51 INFO - Downloading docopt-0.6.1.tar.gz 08:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:51 INFO - Running setup.py install for blobuploader 08:45:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:45:51 INFO - Running setup.py install for requests 08:45:52 INFO - Running setup.py install for docopt 08:45:52 INFO - Successfully installed blobuploader requests docopt 08:45:52 INFO - Cleaning up... 08:45:52 INFO - Return code: 0 08:45:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:45:52 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')]} 08:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:52 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')]} 08:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:52 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:52 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 08:45:52 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 08:45:52 INFO - Using env: {'DISPLAY': ':0', 08:45:52 INFO - 'HOME': '/home/cltbld', 08:45:52 INFO - 'LANG': 'en_US.UTF-8', 08:45:52 INFO - 'LANGUAGE': 'en_US:en', 08:45:52 INFO - 'LOGNAME': 'cltbld', 08:45:52 INFO - 'MAIL': '/var/mail/cltbld', 08:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:52 INFO - 'MOZ_NO_REMOTE': '1', 08:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:52 INFO - 'NO_EM_RESTART': '1', 08:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:52 INFO - 'SHELL': '/bin/bash', 08:45:52 INFO - 'SHLVL': '1', 08:45:52 INFO - 'TERM': 'linux', 08:45:52 INFO - 'TMOUT': '86400', 08:45:52 INFO - 'USER': 'cltbld', 08:45:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:52 INFO - '_': '/tools/buildbot/bin/python'} 08:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:45:52 INFO - Running setup.py (path:/tmp/pip-9NPXNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:45:52 INFO - Running setup.py (path:/tmp/pip-8qeuPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:45:52 INFO - Running setup.py (path:/tmp/pip-otg5v2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:45:52 INFO - Running setup.py (path:/tmp/pip-Xuyx54-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:45:52 INFO - Running setup.py (path:/tmp/pip-RSiIVw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:45:52 INFO - Running setup.py (path:/tmp/pip-nyD6i0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:45:52 INFO - Running setup.py (path:/tmp/pip-1kIiTX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:45:52 INFO - Running setup.py (path:/tmp/pip-cQI9yA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:45:52 INFO - Running setup.py (path:/tmp/pip-ees1z9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:45:53 INFO - Running setup.py (path:/tmp/pip-boZlkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:45:53 INFO - Running setup.py (path:/tmp/pip-4zYsKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:45:53 INFO - Running setup.py (path:/tmp/pip-WhqnWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:45:53 INFO - Running setup.py (path:/tmp/pip-jNaKx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:45:53 INFO - Running setup.py (path:/tmp/pip-NsZ9Yb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:45:53 INFO - Running setup.py (path:/tmp/pip-IwJk3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:45:53 INFO - Running setup.py (path:/tmp/pip-Q9Xe5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:45:53 INFO - Running setup.py (path:/tmp/pip-YofY_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:45:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:53 INFO - Running setup.py install for manifestparser 08:45:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:45:53 INFO - Running setup.py install for mozcrash 08:45:53 INFO - Running setup.py install for mozdebug 08:45:53 INFO - Running setup.py install for mozdevice 08:45:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for mozfile 08:45:54 INFO - Running setup.py install for mozhttpd 08:45:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for mozinfo 08:45:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for mozInstall 08:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for mozleak 08:45:54 INFO - Running setup.py install for mozlog 08:45:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for moznetwork 08:45:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Running setup.py install for mozprocess 08:45:54 INFO - Running setup.py install for mozprofile 08:45:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:45:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:45:55 INFO - Running setup.py install for mozrunner 08:45:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:45:55 INFO - Running setup.py install for mozscreenshot 08:45:55 INFO - Running setup.py install for moztest 08:45:55 INFO - Running setup.py install for mozversion 08:45:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:55 INFO - Cleaning up... 08:45:55 INFO - Return code: 0 08:45:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:55 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:55 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 08:45:55 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 08:45:55 INFO - Using env: {'DISPLAY': ':0', 08:45:55 INFO - 'HOME': '/home/cltbld', 08:45:55 INFO - 'LANG': 'en_US.UTF-8', 08:45:55 INFO - 'LANGUAGE': 'en_US:en', 08:45:55 INFO - 'LOGNAME': 'cltbld', 08:45:55 INFO - 'MAIL': '/var/mail/cltbld', 08:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:55 INFO - 'MOZ_NO_REMOTE': '1', 08:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:55 INFO - 'NO_EM_RESTART': '1', 08:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:55 INFO - 'SHELL': '/bin/bash', 08:45:55 INFO - 'SHLVL': '1', 08:45:55 INFO - 'TERM': 'linux', 08:45:55 INFO - 'TMOUT': '86400', 08:45:55 INFO - 'USER': 'cltbld', 08:45:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:55 INFO - '_': '/tools/buildbot/bin/python'} 08:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:45:55 INFO - Running setup.py (path:/tmp/pip-E6KxS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:45:55 INFO - Running setup.py (path:/tmp/pip-biA2Kv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:45:55 INFO - Running setup.py (path:/tmp/pip-T2U9KY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:45:55 INFO - Running setup.py (path:/tmp/pip-PkJMJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:45:55 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)) 08:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:45:55 INFO - Running setup.py (path:/tmp/pip-yRaC6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:45:56 INFO - Running setup.py (path:/tmp/pip-zv2UqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:45:56 INFO - Running setup.py (path:/tmp/pip-5H3z53-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:45:56 INFO - Running setup.py (path:/tmp/pip-5IKqun-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:45:56 INFO - Running setup.py (path:/tmp/pip-O8BIM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:45:56 INFO - Running setup.py (path:/tmp/pip-WPG9ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:45:56 INFO - Running setup.py (path:/tmp/pip-3Hkm_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:45:56 INFO - Running setup.py (path:/tmp/pip-tbIr30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:45:56 INFO - Running setup.py (path:/tmp/pip-M9YaOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:45:56 INFO - Running setup.py (path:/tmp/pip-o6zR3g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:45:56 INFO - Running setup.py (path:/tmp/pip-oe3zNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:45:56 INFO - Running setup.py (path:/tmp/pip-UWroYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:45:56 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)) 08:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:45:56 INFO - Running setup.py (path:/tmp/pip-gjMtol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 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)) 08:45:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:58 INFO - Downloading blessings-1.6.tar.gz 08:45:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:58 INFO - Installing collected packages: blessings 08:45:58 INFO - Running setup.py install for blessings 08:45:58 INFO - Successfully installed blessings 08:45:58 INFO - Cleaning up... 08:45:58 INFO - Return code: 0 08:45:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:45:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:45:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:45:59 INFO - Reading from file tmpfile_stdout 08:45:59 INFO - Current package versions: 08:45:59 INFO - argparse == 1.2.1 08:45:59 INFO - blessings == 1.6 08:45:59 INFO - blobuploader == 1.2.4 08:45:59 INFO - docopt == 0.6.1 08:45:59 INFO - manifestparser == 1.1 08:45:59 INFO - mozInstall == 1.12 08:45:59 INFO - mozcrash == 0.16 08:45:59 INFO - mozdebug == 0.1 08:45:59 INFO - mozdevice == 0.47 08:45:59 INFO - mozfile == 1.2 08:45:59 INFO - mozhttpd == 0.7 08:45:59 INFO - mozinfo == 0.9 08:45:59 INFO - mozleak == 0.1 08:45:59 INFO - mozlog == 3.1 08:45:59 INFO - moznetwork == 0.27 08:45:59 INFO - mozprocess == 0.22 08:45:59 INFO - mozprofile == 0.27 08:45:59 INFO - mozrunner == 6.11 08:45:59 INFO - mozscreenshot == 0.1 08:45:59 INFO - mozsystemmonitor == 0.0 08:45:59 INFO - moztest == 0.7 08:45:59 INFO - mozversion == 1.4 08:45:59 INFO - psutil == 3.1.1 08:45:59 INFO - requests == 1.2.3 08:45:59 INFO - wsgiref == 0.1.2 08:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:59 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 08:45:59 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 08:45:59 INFO - Using env: {'DISPLAY': ':0', 08:45:59 INFO - 'HOME': '/home/cltbld', 08:45:59 INFO - 'LANG': 'en_US.UTF-8', 08:45:59 INFO - 'LANGUAGE': 'en_US:en', 08:45:59 INFO - 'LOGNAME': 'cltbld', 08:45:59 INFO - 'MAIL': '/var/mail/cltbld', 08:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:59 INFO - 'MOZ_NO_REMOTE': '1', 08:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:59 INFO - 'NO_EM_RESTART': '1', 08:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:59 INFO - 'SHELL': '/bin/bash', 08:45:59 INFO - 'SHLVL': '1', 08:45:59 INFO - 'TERM': 'linux', 08:45:59 INFO - 'TMOUT': '86400', 08:45:59 INFO - 'USER': 'cltbld', 08:45:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:59 INFO - '_': '/tools/buildbot/bin/python'} 08:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45:59 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)) 08:45: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:45: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:45:59 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)) 08:45:59 INFO - Cleaning up... 08:45:59 INFO - Return code: 0 08:45:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:59 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 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:45:59 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 08:45:59 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 08:45:59 INFO - Using env: {'DISPLAY': ':0', 08:45:59 INFO - 'HOME': '/home/cltbld', 08:45:59 INFO - 'LANG': 'en_US.UTF-8', 08:45:59 INFO - 'LANGUAGE': 'en_US:en', 08:45:59 INFO - 'LOGNAME': 'cltbld', 08:45:59 INFO - 'MAIL': '/var/mail/cltbld', 08:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:59 INFO - 'MOZ_NO_REMOTE': '1', 08:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:59 INFO - 'NO_EM_RESTART': '1', 08:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 08:45:59 INFO - 'SHELL': '/bin/bash', 08:45:59 INFO - 'SHLVL': '1', 08:45:59 INFO - 'TERM': 'linux', 08:45:59 INFO - 'TMOUT': '86400', 08:45:59 INFO - 'USER': 'cltbld', 08:45:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:59 INFO - '_': '/tools/buildbot/bin/python'} 08:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:59 INFO - Downloading/unpacking jsonschema 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:46:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:01 INFO - Downloading/unpacking functools32 (from jsonschema) 08:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:01 INFO - warning: no files found matching '*.txt' 08:46:01 INFO - no previously-included directories found matching 'build' 08:46:01 INFO - no previously-included directories found matching 'dist' 08:46:01 INFO - no previously-included directories found matching '.git*' 08:46:01 INFO - Installing collected packages: jsonschema, functools32 08:46:01 INFO - Running setup.py install for functools32 08:46:01 INFO - warning: no files found matching '*.txt' 08:46:01 INFO - no previously-included directories found matching 'build' 08:46:01 INFO - no previously-included directories found matching 'dist' 08:46:01 INFO - no previously-included directories found matching '.git*' 08:46:01 INFO - Successfully installed jsonschema functools32 08:46:01 INFO - Cleaning up... 08:46:01 INFO - Return code: 0 08:46:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:46: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')]} 08:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73df514f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cd600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', '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 08:46: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', 'flake8'] in /builds/slave/test-pgo/build 08:46: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 flake8 08:46:01 INFO - Using env: {'DISPLAY': ':0', 08:46:01 INFO - 'HOME': '/home/cltbld', 08:46:01 INFO - 'LANG': 'en_US.UTF-8', 08:46:01 INFO - 'LANGUAGE': 'en_US:en', 08:46:01 INFO - 'LOGNAME': 'cltbld', 08:46:01 INFO - 'MAIL': '/var/mail/cltbld', 08:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:01 INFO - 'MOZ_NO_REMOTE': '1', 08:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:01 INFO - 'NO_EM_RESTART': '1', 08:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:46:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:46:01 INFO - 'SHELL': '/bin/bash', 08:46:01 INFO - 'SHLVL': '1', 08:46:01 INFO - 'TERM': 'linux', 08:46:01 INFO - 'TMOUT': '86400', 08:46:01 INFO - 'USER': 'cltbld', 08:46:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:01 INFO - '_': '/tools/buildbot/bin/python'} 08:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:01 INFO - Downloading/unpacking flake8 08:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:46:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:46:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:04 INFO - no previously-included directories found matching 'docs/_build' 08:46:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:46:04 INFO - Running setup.py install for pep8 08:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:46:04 INFO - no previously-included directories found matching 'docs/_build' 08:46:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:46:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:46:04 INFO - Cleaning up... 08:46:04 INFO - Return code: 0 08:46:04 INFO - Running post-action listener: _resource_record_post_action 08:46:04 INFO - Running post-action listener: _start_resource_monitoring 08:46:04 INFO - Starting resource monitoring. 08:46:04 INFO - ##### 08:46:04 INFO - ##### Running install step. 08:46:04 INFO - ##### 08:46:04 INFO - Running pre-action listener: _resource_record_pre_action 08:46:04 INFO - Running main action method: install 08:46:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:46:04 INFO - Reading from file tmpfile_stdout 08:46:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:46:05 INFO - Reading from file tmpfile_stdout 08:46:05 INFO - Output received: 08:46:05 INFO - Usage: mozinstall [options] installer 08:46:05 INFO - Options: 08:46:05 INFO - -h, --help show this help message and exit 08:46:05 INFO - -d DEST, --destination=DEST 08:46:05 INFO - Directory to install application into. [default: 08:46:05 INFO - "/builds/slave/test-pgo"] 08:46:05 INFO - --app=APP Application being installed. [default: firefox] 08:46:05 INFO - mkdir: /builds/slave/test-pgo/build/application 08:46:05 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'] 08:46:05 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 08:46:19 INFO - Reading from file tmpfile_stdout 08:46:19 INFO - Output received: 08:46:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:46:19 INFO - Running post-action listener: _resource_record_post_action 08:46:19 INFO - ##### 08:46:19 INFO - ##### Running run-tests step. 08:46:19 INFO - ##### 08:46:19 INFO - Running pre-action listener: _resource_record_pre_action 08:46:19 INFO - Running main action method: run_tests 08:46:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:46:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:46:19 INFO - Python 2.7.3 08:46:19 INFO - Return code: 0 08:46:19 INFO - grabbing minidump binary from tooltool 08:46: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')]} 08:46:19 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 0x245c350>, '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 0x245d250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245d6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:46:19 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 08:46:19 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 08:46:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:19 INFO - Return code: 0 08:46:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:46:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:46:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:46:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:46:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:46:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:46:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:46:20 INFO - Return code: 0 08:46:20 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:46:20 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 08:46:20 INFO - Using env: {'DISPLAY': ':0', 08:46:20 INFO - 'HOME': '/home/cltbld', 08:46:20 INFO - 'LANG': 'en_US.UTF-8', 08:46:20 INFO - 'LANGUAGE': 'en_US:en', 08:46:20 INFO - 'LOGNAME': 'cltbld', 08:46:20 INFO - 'MAIL': '/var/mail/cltbld', 08:46:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:46:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:20 INFO - 'MOZ_NO_REMOTE': '1', 08:46:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:20 INFO - 'NO_EM_RESTART': '1', 08:46:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:46:20 INFO - 'PWD': '/builds/slave/test-pgo', 08:46:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:46:20 INFO - 'SHELL': '/bin/bash', 08:46:20 INFO - 'SHLVL': '1', 08:46:20 INFO - 'TERM': 'linux', 08:46:20 INFO - 'TMOUT': '86400', 08:46:20 INFO - 'USER': 'cltbld', 08:46:20 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934', 08:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:20 INFO - '_': '/tools/buildbot/bin/python'} 08:46:20 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 08:46:20 INFO - mozversion INFO | application_buildid: 20160121061721 08:46:20 INFO - mozversion INFO | application_changeset: 01b93573f9d466514485a3188bc666bb621d09bb 08:46:20 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:46:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:20 INFO - mozversion INFO | application_name: Firefox 08:46:20 INFO - mozversion INFO | application_remotingname: firefox-dev 08:46:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:46:20 INFO - mozversion INFO | application_vendor: Mozilla 08:46:20 INFO - mozversion INFO | application_version: 45.0a2 08:46:20 INFO - mozversion INFO | platform_buildid: 20160121061721 08:46:20 INFO - mozversion INFO | platform_changeset: 01b93573f9d466514485a3188bc666bb621d09bb 08:46:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:46:20 INFO - mozversion INFO | platform_version: 45.0a2 08:46:20 INFO - 2016-01-21 08:46:20,939 DEBUG : using testdate: 1453394780 08:46:20 INFO - 2016-01-21 08:46:20,939 DEBUG : actual date: 1453394780 08:46:20 INFO - 2016-01-21 08:46:20,948 INFO : starting webserver on 'localhost:48992' 08:46:20 INFO - 2016-01-21 08:46:20,949 INFO : Starting test suite talos-linux64-ix-022 08:46:20 INFO - 2016-01-21 08:46:20,949 INFO : Starting test dromaeo_css 08:46:20 INFO - 2016-01-21 08:46:20,949 DEBUG : operating with platform_type : linux_ 08:46:20 INFO - 2016-01-21 08:46:20,950 INFO : Initialising browser for dromaeo_css test... 08:46:20 INFO - 2016-01-21 08:46:20,966 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkYopiX/profile http://localhost:48992/getInfo.html 08:46:24 INFO - 2016-01-21 08:46:24,907 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:46:24 INFO - 2016-01-21 08:46:24,907 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:46:24 INFO - 2016-01-21 08:46:24,907 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:46:24 INFO - 2016-01-21 08:46:24,907 DEBUG : BROWSER_OUTPUT: __metrics 08:46:25 INFO - 2016-01-21 08:46:25,044 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:46:26 INFO - 2016-01-21 08:46:26,236 INFO : Browser initialized. 08:46:26 INFO - 2016-01-21 08:46:26,236 INFO : Running cycle 1/1 for dromaeo_css test... 08:46:26 INFO - 2016-01-21 08:46:26,237 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkYopiX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:46:37 INFO - 2016-01-21 08:46:37,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 137986048 08:46:37 INFO - 2016-01-21 08:46:37,967 DEBUG : BROWSER_OUTPUT: 08:47:29 INFO - 2016-01-21 08:47:29,723 DEBUG : BROWSER_OUTPUT: 1453394849722 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] 08:49:36 INFO - 2016-01-21 08:49:36,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48992/tests/dromaeo/cssquery-ext.html) 08:49:37 INFO - 2016-01-21 08:49:37,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 267726848 08:49:37 INFO - 2016-01-21 08:49:37,990 DEBUG : BROWSER_OUTPUT: 08:52:40 INFO - 2016-01-21 08:52:40,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-ext.html (next: http://localhost:48992/tests/dromaeo/cssquery-jquery.html) 08:52:40 INFO - 2016-01-21 08:52:40,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 214368256 08:52:40 INFO - 2016-01-21 08:52:40,874 DEBUG : BROWSER_OUTPUT: 08:55:42 INFO - 2016-01-21 08:55:42,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48992/tests/dromaeo/cssquery-mootools.html) 08:55:43 INFO - 2016-01-21 08:55:43,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 219787264 08:55:43 INFO - 2016-01-21 08:55:43,289 DEBUG : BROWSER_OUTPUT: 08:58:45 INFO - 2016-01-21 08:58:45,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48992/tests/dromaeo/cssquery-prototype.html) 08:58:45 INFO - 2016-01-21 08:58:45,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 205848576 08:58:45 INFO - 2016-01-21 08:58:45,593 DEBUG : BROWSER_OUTPUT: 09:01:47 INFO - 2016-01-21 09:01:47,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48992/tests/dromaeo/cssquery-yui.html) 09:01:48 INFO - 2016-01-21 09:01:48,510 DEBUG : BROWSER_OUTPUT: RSS: Main: 202436608 09:01:48 INFO - 2016-01-21 09:01:48,510 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/dromaeo/cssquery-yui.html (next: http://localhost:48992/tests/dromaeo/cssquery-dojo.html) 09:04:50 INFO - 2016-01-21 09:04:50,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 243834880 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:04:50 INFO - 2016-01-21 09:04:50,942 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3244;3327.567416235889;3353.228757385801;3360.1431634933087;3385.475251336043;5357.866053348664;5386.434424385442;5394.379646340672;5395.028894798935;5431.4840090191465;5373.623846330758;5412.864678383043;5418.8916221675545;5427.945720542793;5456.563474922006;4751.762411879409;4946.9257961130525;4993.500649934996;5017.774200161001;5037.042961837257;4904.632152588552;4961.925571116436;4962.6526143169995;4982.202847544394;4984.476629953857;4816.51834816519;4889.975550122263;4956.925646115311;4963.35476388069;4968.577670897978;4883.19427294496;4950.6782059166035;4975.502449754996;5000;5017.222330538772;4934.777934992934;4959.628027897886;4972.477889821553;4995.550400463976;5022.4224214215465;5044.1677123274985;5112.156494178456;5136.203888397267;5151;5219.817306394258;5708.77164913403;5748.223989761371;5756.884862302731;5763.625364351304;5837.066069428914;5826.796062137847;5827.825165245049;5831.446012628793;5832.883342333172;5849.736761845727;5313.229581710631;5385.7307134643115;5397.082495975694;5459.208414779874;5484.561235101182;5848.970755146197;5888.234529511136;5898.026825573818;5899.528037756969;5900.704964751745;5676.0918253080135;5718.313802343745;5718.857028574319;5720.656760594377;5747.224124743189;5551;5608.859778505488;5665.745041473144;5672.376038635747;5692.089265717465;5662.68855212959;5770.58620637938;5802.390748971382;5803.912941305884;5804.651720896675;5564.4991950724625;5791;5795.884082318415;5800.0429929062075;5803.709814509258;4403.053343531156;4419.116176764595;4423.845165419195;4450.109978004412;4484.05834774701;4039.969807699018;4046.2716710992304;4053.8175782089875;4078.4494093297026;4081.2653722329674;5330.067238233293;5391.595630327741;5540.2243685884005;5559.24950131727;5560.165975103767;5645.407232240637;5699.2590963174525;5706.971465142731;5729.5702822288495;5766.855828604318;5438.809641662523;5496.31296087989;5499.532539734088;5500.972495137498;5501.229827824108;4820.638452116105;4926.655134140576;4941.678790878654;5029.64792464524;5069.239614057921;6008;6019.759209631566;6022.518198544106;6029.698515074228;6030.276366836008;5861.032929566659;5870.911936320873;5872.823815285548;5873.618214816023;5873.94126058751;5659.349174844946;5674.829755107354;5970.402959703995;6002.729877155626;6112.969435152796;5726.0838265877255;5731.656100633809;5742.2535070442245;5742.36833948257;5745.827625171251;5784.595078344475;5831.300243970751;5837.1244313351635;5838.824835254949;5841.240638716939;5516.696581688046;5528.91706624409;5580;5609.411011843697;5628.943710562842;5656.717164141859;5658.066419040977;5658.462446067617;5666.065099258576;5759.712014399347;5556.638818476948;5568.721563921868;5572.024895643165;5577.107662773937;5608.298962629671;5487.039768040657;5581.9162712560155;5584.3857175711455;5668.064769313182;5677.120046392815;5512;5540.473655002768;5540.97491963988;5570.053090974625;5595.608307418442 09:04:50 INFO - 2016-01-21 09:04:50,944 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.2985328046502;610.5359926455893;620.4013127332125;622.3776223776224;624.81255623313;32237.35525289496;38711.61288387115;39104.413433798516;39122.60877391225;39129.804350978244;44464.777676111575;45211;45244.32133517991;45246.547534524645;45374;8141.674333026672;8275.834483310331;9221.769455763626;9400.05999400058;10546.736331591734;10872.782544349107;10940.343579385222;10949.288296260758;10955.671329860117;10963.451827408637;10987.175961802857;11108.555657773679;11113.444327783618;11113.944430277877;11114.666560003172;8311.044229913578;8481.95759021207;10986.230963832535;11366.943165284121;11368.60209892658;10700.571977120906;10839.187060970458;10846.945765271203;10848.403337816417;10848.67453976382;42859;43228.567714322766;43385.34921976173;43410.13179736387;43458.78270608658;3657.725670574691;3684.428913518409;3735;3797.9430308545393;4173.91652166958;32581;33072.50391244109;33119.6688033119;33148;33413.498797518056;4243.215005224012;4260;4370.312257961363;4381.583749543788;4405.801738921757;287079;295687;295794;296157;298142.50928745436;61208.081878770965;62945;68364.6581767098;68986.31013689798;69151;75261;77087.61456192684;77282;77528.61235693785;77598.61200694073;15919.681606367807;15936.681266374608;15978.520644380687;16038;16143.919280403523;12183.390830458442;12192.39038048094;12218.327991960528;12255.632331030083;12296.262224266573;22056.779432205472;22150.446238843837;22170.667439988414;22790.202342917917;22889.31332060041;8303.667853285922;8715.302775777922;8826.073262307493;8844.513551754715;8875.778105547284;1000.9949950250202;1031.9164876879397;1059.7562560610947;1101.4492753623188;1121.5906194239044;29032.41935161285;29460.852695736383;29670.851645742066;29761.40477190444;30128.397432051675;1065.0999905080196;1109.4120116338354;1160.1299025730702;1162.4478372772865;1198.9389390389567;13951.302434878215;14852.331645075998;15132.773008404884;15564.45524406663;17327;440066;441584;443159;445769;447254;58339.4166058334;58613;58998;59065.70467147723;59071.11393329103;1328.6744747536916;1354.3093022558567;1395.2814300635182;1435.2034620785773;1459.4016453254114;29548.113556593336;29661;34154.31691366109;34421.82789086038;34746.30507389889;47780.7610961943;54060;55112.44887551073;55123.44876551183;55152.72423637856;237294;239265;240072;240075;290738;45050.324245137;46100.166034742855;46321.536784631724;46384.768076160755;48115.75942120267;49844;49913;49937.500624993285;50685.493145068074;51023.48976510188;40296;40658;41006;41180.61901545633;42340.576594234895;42159.578404215565;42472.5752742481;42519.1110312226;42970.57029429666;43135.56864431441;41103.7944810286;41501.58498414977;41879.581204188784;42146.1570768589;42231.577684223994;36333.63666363303;38376.616233838424;38651.61348386593;38678.80660596679;38814.4177837327;27846.16461506158;27963.004512252563;28110.251556935942;28185.154445366672;28213.576796348483 09:04:50 INFO - 2016-01-21 09:04:50,945 DEBUG : BROWSER_OUTPUT: |2;jquery.html;366.51985898472986;371.051962236486;371.35674639719235;372.3260897775027;372.6497092732831;15491.457798977039;17638.823611763877;17660.646787064252;18841.15214815333;19371.70942435861;11256.212065155421;11368.545258189662;11830;14202;18453.16960736767;5132.024915266097;5221.451747566508;5228.529432351088;5243.9213411798855;5254.106801843676;3890.630390112935;3986.2625414298304;5508.55931525477;5611.551075913938;5629.408912064236;5541.56669717283;5597.44025597439;5602.523785478219;5614;5650.5479561634975;6177.135201071854;6207.3792620737795;6254.093156492283;6254.124422580842;6267.780627678009;5150.150225212836;5499.862503437406;5510.421405752379;5512.972435137839;5523.475269849358;13284.269365184911;13318.267495287755;13444.596662100153;13507.392167352395;13694.178349298974;2045.2739277556402;2124.4157856589563;2196.978030219693;2314.3866875277895;2331.219041621059;10105.646302379455;10269.28115031948;10310.381377117397;12312.753744925052;13467.92256619468;1809.312461264724;1832.752578401912;1879.079251166932;1945.6984167454068;1952.5899561092187;63467.6826615864;66049.00926486154;66268.3373166267;66895.3310466894;67875.66062169657;10510.421926793946;10744.946275268574;10750.516226769658;10756.515956781963;10847.294925829954;13889.652758681113;13974.231417271943;13987.300634968211;14004.369803358873;14005.789913151311;8122.796930076795;8152.2662960333855;8160.143184965612;8185.444765494537;8197.098319184885;7999.720009799629;8019.1579884111325;8036.437449378487;8058.395620328499;8058.959705201553;4458.554144585581;4543.727376357363;4589.173948689268;4602.677812553156;4626.86119416418;1721.3286818140684;1790.8298711622374;1791.704368779163;1829.5243236758272;1846.1230915315118;942.948137852411;982.8034393121404;1028.0798685176726;1033.9970228877976;1050.9474526273655;13986.510472133426;16957.915210424115;17164.742528862076;17180.484585462455;17613.031283279543;990.6582229130938;993.1508560180941;1011.7369483934231;1054.1250761867632;1078.1644225725126;9400.48297343639;9939.850902236472;10115.241356898263;10636.627718029831;10747.892521074846;623785.6432153521;624705;634439;637711;647386;86088;86606.13393865981;88149;89935;91550.08449915549;1229.883161099694;1232.3037483821613;1236.202649291202;1239.69007748063;1245.6761242077125;15371.538853834403;15952.282147303631;16174.353025878832;16218.189090545662;16416.671666566363;33223.83388083044;33697.82057628069;34110.48834267537;35761.28477430385;37786.05534861651;45273;51994;52445.47554524406;52628;55000.72499637476;9606.66376676841;9787.657431989846;9824.950875245579;9887.159591434809;9897.55461004271;18365.173567189242;18504.444866654023;18697.90651046736;18866.434006979813;18919.43241702751;15051.924740376227;15060.79148124601;15500.844991550392;15581.532554023397;15736.213189340717;15113.924430377778;15230.695386091995;15376.154311512973;15525.689486209987;15617;12299.93850030744;14542.927285363505;14985.250737462866;15140;15178.848211517743;9259.398139120936;9334.439933604006;9475.526223688927;9502.287328450255;9559.23526117895;10447.425391603534;10502.527386267484;12828.166169198972;13665.863341366858;13691.383887725275 09:04:50 INFO - 2016-01-21 09:04:50,948 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1394.3307212537989;1717.4675850486346;1784.4379020608512;1805.1154934082303;1833.9541511462212;6634.90047649285;7723.768286951394;7905.604719764017;7911.683532658702;7927.722529711461;7809.219078092188;7947.046354437475;7955.085165206003;7955.482893611911;7973.122956474797;1957.618264438435;1989.055198780582;1989.3832911797317;2284.8743319117443;2315.1781117703226;2031.2890488329115;2281.7376001759844;2303.585354636165;2313.4910319729634;2316.119874447716;2230.408941630469;2247.1797793805226;2250.5948929192737;2260.08466571039;2295.540891821634;2295.3114065780364;2295.598270302699;2325.093213646679;2326.162581470661;2328.9752508896117;2304.193532263694;2345.2377977157494;2347.119830063726;2347.448349637834;2347.8943447544902;7569.545827250383;7662.61686915652;7668.884966725504;7669.884951725729;7677.808054798619;4702.670813043088;4791.7124972501415;4793.065352256312;4793.400824896888;4794.95205047952;3088.4903990841485;3139.9372012559847;3193.2016995751064;3221.629512606057;3226.3869864725625;1028.1928685981468;1030.258214085857;1905.7903630600622;1955.9608807823906;2001.0895042755512;10645.20160987929;10729.517171727213;10735.033846953811;10744.247902646895;10751;4184.916301673949;4232.111256636079;4269.060806622538;4344.82620695175;4344.913101737948;8760.693375731818;8777.561121943878;8798.86801697975;8799.29605631548;8803.647854085764;4840.75796210188;4841.201201801663;4853.344798452164;4857.6599638025;4858.295547145644;4440.35614835847;4461.24158892989;4472.776361181993;4477.350784136282;4497.595216430537;2971.7325440710006;3486.633903440102;3531.823408829548;3545.37955857729;3577.5170352002665;993.9304248702522;1054.778496515725;1104.6078642081945;1106.4854842498278;1114.0808832713044;1131.8811524789944;1133.659902029388;1136.4885801389407;1300.7918733002864;1364.3382959264948;7145.4998150128995;7215.49491535598;7640.80897977555;7669.884951725729;7736.419768517271;670.3698523388;672.3008071605573;680.5202332355677;684.9760258390933;810.9052778748642;5815.3021637402935;5909.202257695242;5912.793052243151;5915.142304365929;5923.940760592425;9194.586243619053;9420.387674801115;9524.90475095254;9726.076022777825;9776.9022309776;9645.180159686504;9659.420434773936;9765.511724413751;9769.462679552693;9773.169280611228;7457.403407727369;7460.216677248919;7476.738314158978;7630.427717921067;7643.121041080236;7465.06686664167;7516.398688105048;7520.623968801648;7527.661255243636;7537.585432801248;8289.751307460785;8439.535825529409;8443.113473085237;8587.957060214909;8626.39615226928;8662.090480499708;8683.305335573265;8841.955790221007;8877;8898.243649289883;7130.964345178241;7183.173934997542;7188.460865435009;7191.460640452092;7195.13658361;6546.934530654633;7714.267144621252;7745.690172393267;7748.535087894745;7761.573113478813;6441.355864413521;6949.992251123457;7234.02340684022;7396.852062958603;7398.630068496661;6728.428083612947;6779.35596118368;6881.621510816954;6882.483813714091;7291.635418229173;7029.332213439715;7060.470464715269;7070.71717131309;7100.147982242164;7116.323949224816;6799.422049125879;6813.080234168324;6818.795436136924;6820.590764553944;6825.1127353443735;6745.325467453215;6778.830529236809;6782.966085169543;6785.864282714417;6787.287334829772 09:04:50 INFO - 2016-01-21 09:04:50,950 DEBUG : BROWSER_OUTPUT: |4;prototype.html;347.69402925425624;353.9858405663772;354.90417587251426;355.33906933104413;361.117068766865;6026.849328766783;6096.481799047081;6113.7860174893885;6164.044573091167;6165.969170154149;5829.679367634779;6006.639601623895;6024.578279520435;6064;6076.848078798022;4670.042641258542;4671.229247174212;4690.929636055462;4699.553542413482;4714.151452738506;4504.099180163964;4591.1965406053805;4599.172149013176;4708.952910470903;4713.104510143079;4613.584777370036;4637.9072418551605;4641.327007583898;4650.093231819779;4664.4402671679445;4616.30755386693;4632.606228470584;4649.628029757611;4681.88295292617;4695.107929493385;4111.280525907954;4117.8970525736795;4129.607687269705;4131.8967025824295;4154.646855017327;5645.887082258332;5764.913526297109;5770.9422905770825;5771.163181338682;5776.913346299809;5453.972730136324;5456.7544460498975;5466;5466.262054622614;5474.534664553478;6391.424771770517;6422.454091402236;6423.357664233539;6424.93575064248;6429.2284925808735;4508.211063063951;4583.3125031245245;4592.196365636;4599.816007359702;4613;6673.9666301668185;6674.566153200027;6679.131712877295;6679.198496180489;6684.699188536528;4713.057388522309;4714.175019371596;4716.976415117971;4717.693349932243;4720.787564559603;4748.572628463386;4772;4780.995990841962;4781.091592597395;4781.593564546983;5175.378954525481;5343.6526625769975;5441.918371224435;5456.536194423518;5457.317835270591;6435.324290949383;6493.31820158886;6504.252011018793;6504.674766261668;6509.511786616023;1629.8370162983606;1645.2760785254688;1649.4474351092279;1651.9587010324838;1655.5198992292342;1079.6760971708457;1096.3367162866512;1101.3612104979093;1117.9385133817555;1121.5009320852305;6280.340564240781;6291.905621415683;6294.118823364733;6295.905561416583;6298.905516417258;6473.093766872642;6679.098321726505;6688.398044176048;6700.195976482853;6700.4639628830555;6207.596506227081;6269.749210031548;6273.654948977759;6329.651869147149;6337.176167098248;3602.27954409114;3629.4011488104693;3632.3098611263777;3636.8363423646;3639.5086663300117;6784.76253331131;6914.654267286615;6923.792286231421;6926;6945.652717364112;6870.381665650116;6874.312568743086;6875.862482750317;6878.69045892936;6884.070650462124;6918.8962165567555;6924.4114250288285;6929.064576282238;6942.20164681058;6944.166699996033;6564.704588293443;6694.966525167343;6712.832179195364;6715.764948226984;6716.899246511404;6596.868062638816;6621.602703837592;6622.668866556556;6634;6637.103990961158;6899.241083480913;6912.066870972354;6914.377706006484;6916.377526022682;6921.7231310747;4475.843345482893;4589.58693717567;4604.240300350539;4605.055963527536;4609.516000819865;6631.734730610721;6633.2371777246235;6642.800715978528;6646.567973081927;6652.368025037614;6443.323451037761;6457.225132984072;6458.160439142881;6469.320721324381;6469.482441404771;6346.397092276226;6433.806985790434;6435.163428754232;6443.903341449788;6456.677166141768;6284.24589049317;6318.336574659778;6322.336154703874;6326.620402775849;6337.4613157882095;6451.935480645134;6453.290138084901;6455.386738259858;6458.257300410513;6459.644719540471;6149.508039356751;6184.81445556634;6250.718717657625;6252.843678907881;6286.622802631857 09:04:50 INFO - 2016-01-21 09:04:50,951 DEBUG : BROWSER_OUTPUT: |5;yui.html;778.1673609238114;785.2251094024277;912.2246090822799;919.6183583812718;930.3394589841213;13302.334883255835;13516.391762370693;13521.05352625318;13540.187588744682;13541.864581354184;12024.879751202485;12048.819267710991;12050.57822976196;12159.696007599814;12316.692082697937;880.6653471680752;890.1054440287535;895.2122132523402;895.9552022398886;896.0725648953335;885.5572213893054;886.8182022685367;887.0951629338072;887.5562218890555;890.1321211818457;920.6179435534245;927.8608208768671;928.8885333759958;929.3866048408051;929.9674511392103;925.1673493855584;931.3340961212732;931.6692574136151;931.7903471718843;932.1563984593953;679.2799632389683;685.2736099734298;686.5297271369078;686.7836631461124;687.1410736579276;12754.553590624284;12761.553345632858;12887.484500619965;12899.161554498927;12919.031072669493;12053.2165409249;12355.567555135527;12694.873051269555;12722.554710585178;12995;10371;10407.115395191418;10449.895501045045;10727.678169654922;10814.35113893161;3779.2063666630042;3790.0714324990277;3823.9044023899346;3829.8659546915724;3832.9808350958065;41300;41401.58598414037;44921;48784;48959.755201223765;10100.595976160872;10231.897681023243;10271.589136434459;10448.68653940383;10697.625583104555;17845.28618855257;17914.925104493774;17929.551761206076;17965.550861228312;18489.445316640522;7586.127595326498;7693.230676932374;7718.035245594301;7758.883616745753;7929.167437419103;4680.672352935262;4705.882352941136;4768.332433459318;4783.23468245086;4869.099216644932;2974.3902499987453;2976.7172118648696;2981.59748433963;2991.491446454108;3005.9849700751356;561.5732043646776;563.5266376243893;563.7857614106613;567.2625586737225;596.260636810352;643.359856942336;685.6092027544352;726.7093162734948;732.3811379384412;743.4869939741561;8710.041895391501;8880.955595222113;9123.954380228057;9234.215091717278;9297.349185557081;600.9519238460913;656.6880731652523;664.6410938093376;720.7513407874275;754.3211110001043;4188.120494696148;4218.578142185757;4308.353746937984;4316.589923957219;4368.344748287782;56934.14598781022;57599.71200143972;57689.711551442815;58408;63032.36967630265;53153;53417;54097.72951135219;54163.72918135384;55034.44965550373;46419.53580464152;47228.52771472241;56334;58909.41090589125;58915.41084589099;8367.28878045373;8896.777580560538;9265.868850164365;9343.53282335867;9510;35213.29573408466;35562;36224.00767957787;36465;36732.81633591815;40938.79530602447;44271.77864110659;50710.23934641057;51465.485345146066;51952.740236298574;12159.574414895436;12237.510499579917;12546;12728.809067864175;12732.490700371882;13285.40215690277;13416.195028298333;13478.595642130751;14009.789853152008;14146.575602731935;12171.208871423683;12418.441170147546;12465.439055242718;12682.682932926751;13225.272610006543;11682.649520514398;11793.941030295136;11854;12013.519459221534;12292.201006934522;11379.715507112389;11759.76480470403;11791;11974.46114924813;12085.577004805142;10514.316569422963;11114.110871130451;11438.370889601152;11486.94256528712;11574.421278936188;9535.713928582154;9987.850182247126;9990.850137247802;10194.643187488698;10228.181745460197 09:04:50 INFO - 2016-01-21 09:04:50,951 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:04:50 INFO - 2016-01-21 09:04:50,951 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:04:50 INFO - 2016-01-21 09:04:50,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1038 09:04:50 INFO - 2016-01-21 09:04:50,951 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: __startTimestamp1453395890940__endTimestamp 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5371.57 Median:5560.17 stddev:572.84 (10.3%) stddev-sans-first:549.74 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: Values: 3244.0 3327.6 3353.2 3360.1 3385.5 5357.9 5386.4 5394.4 5395.0 5431.5 5373.6 5412.9 5418.9 5427.9 5456.6 4751.8 4946.9 4993.5 5017.8 5037.0 4904.6 4961.9 4962.7 4982.2 4984.5 4816.5 4890.0 4956.9 4963.4 4968.6 4883.2 4950.7 4975.5 5000.0 5017.2 4934.8 4959.6 4972.5 4995.6 5022.4 5044.2 5112.2 5136.2 5151.0 5219.8 5708.8 5748.2 5756.9 5763.6 5837.1 5826.8 5827.8 5831.4 5832.9 5849.7 5313.2 5385.7 5397.1 5459.2 5484.6 5849.0 5888.2 5898.0 5899.5 5900.7 5676.1 5718.3 5718.9 5720.7 5747.2 5551.0 5608.9 5665.7 5672.4 5692.1 5662.7 5770.6 5802.4 5803.9 5804.7 5564.5 5791.0 5795.9 5800.0 5803.7 4403.1 4419.1 4423.8 4450.1 4484.1 4040.0 4046.3 4053.8 4078.4 4081.3 5330.1 5391.6 5540.2 5559.2 5560.2 5645.4 5699.3 5707.0 5729.6 5766.9 5438.8 5496.3 5499.5 5501.0 5501.2 4820.6 4926.7 4941.7 5029.6 5069.2 6008.0 6019.8 6022.5 6029.7 6030.3 5861.0 5870.9 5872.8 5873.6 5873.9 5659.3 5674.8 5970.4 6002.7 6113.0 5726.1 5731.7 5742.3 5742.4 5745.8 5784.6 5831.3 5837.1 5838.8 5841.2 5516.7 5528.9 5580.0 5609.4 5628.9 5656.7 5658.1 5658.5 5666.1 5759.7 5556.6 5568.7 5572.0 5577.1 5608.3 5487.0 5581.9 5584.4 5668.1 5677.1 5512.0 5540.5 5541.0 5570.1 5595.6 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,952 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52548.80 Median:38514.11 stddev:89347.68 (232.0%) stddev-sans-first:89513.09 09:04:50 INFO - 2016-01-21 09:04:50,953 DEBUG : BROWSER_OUTPUT: Values: 570.3 610.5 620.4 622.4 624.8 32237.4 38711.6 39104.4 39122.6 39129.8 44464.8 45211.0 45244.3 45246.5 45374.0 8141.7 8275.8 9221.8 9400.1 10546.7 10872.8 10940.3 10949.3 10955.7 10963.5 10987.2 11108.6 11113.4 11113.9 11114.7 8311.0 8482.0 10986.2 11366.9 11368.6 10700.6 10839.2 10846.9 10848.4 10848.7 42859.0 43228.6 43385.3 43410.1 43458.8 3657.7 3684.4 3735.0 3797.9 4173.9 32581.0 33072.5 33119.7 33148.0 33413.5 4243.2 4260.0 4370.3 4381.6 4405.8 287079.0 295687.0 295794.0 296157.0 298142.5 61208.1 62945.0 68364.7 68986.3 69151.0 75261.0 77087.6 77282.0 77528.6 77598.6 15919.7 15936.7 15978.5 16038.0 16143.9 12183.4 12192.4 12218.3 12255.6 12296.3 22056.8 22150.4 22170.7 22790.2 22889.3 8303.7 8715.3 8826.1 8844.5 8875.8 1001.0 1031.9 1059.8 1101.4 1121.6 29032.4 29460.9 29670.9 29761.4 30128.4 1065.1 1109.4 1160.1 1162.4 1198.9 13951.3 14852.3 15132.8 15564.5 17327.0 440066.0 441584.0 443159.0 445769.0 447254.0 58339.4 58613.0 58998.0 59065.7 59071.1 1328.7 1354.3 1395.3 1435.2 1459.4 29548.1 29661.0 34154.3 34421.8 34746.3 47780.8 54060.0 55112.4 55123.4 55152.7 237294.0 239265.0 240072.0 240075.0 290738.0 45050.3 46100.2 46321.5 46384.8 48115.8 49844.0 49913.0 49937.5 50685.5 51023.5 40296.0 40658.0 41006.0 41180.6 42340.6 42159.6 42472.6 42519.1 42970.6 43135.6 41103.8 41501.6 41879.6 42146.2 42231.6 36333.6 38376.6 38651.6 38678.8 38814.4 27846.2 27963.0 28110.3 28185.2 28213.6 09:04:50 INFO - 2016-01-21 09:04:50,953 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,953 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31972.61 Median:2160.70 stddev:103603.69 (4794.9%) stddev-sans-first:103867.14 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: Values: 366.5 371.1 371.4 372.3 372.6 15491.5 17638.8 17660.6 18841.2 19371.7 11256.2 11368.5 11830.0 14202.0 18453.2 5132.0 5221.5 5228.5 5243.9 5254.1 3890.6 3986.3 5508.6 5611.6 5629.4 5541.6 5597.4 5602.5 5614.0 5650.5 6177.1 6207.4 6254.1 6254.1 6267.8 5150.2 5499.9 5510.4 5513.0 5523.5 13284.3 13318.3 13444.6 13507.4 13694.2 2045.3 2124.4 2197.0 2314.4 2331.2 10105.6 10269.3 10310.4 12312.8 13467.9 1809.3 1832.8 1879.1 1945.7 1952.6 63467.7 66049.0 66268.3 66895.3 67875.7 10510.4 10744.9 10750.5 10756.5 10847.3 13889.7 13974.2 13987.3 14004.4 14005.8 8122.8 8152.3 8160.1 8185.4 8197.1 7999.7 8019.2 8036.4 8058.4 8059.0 4458.6 4543.7 4589.2 4602.7 4626.9 1721.3 1790.8 1791.7 1829.5 1846.1 942.9 982.8 1028.1 1034.0 1050.9 13986.5 16957.9 17164.7 17180.5 17613.0 990.7 993.2 1011.7 1054.1 1078.2 9400.5 9939.9 10115.2 10636.6 10747.9 623785.6 624705.0 634439.0 637711.0 647386.0 86088.0 86606.1 88149.0 89935.0 91550.1 1229.9 1232.3 1236.2 1239.7 1245.7 15371.5 15952.3 16174.4 16218.2 16416.7 33223.8 33697.8 34110.5 35761.3 37786.1 45273.0 51994.0 52445.5 52628.0 55000.7 9606.7 9787.7 9825.0 9887.2 9897.6 18365.2 18504.4 18697.9 18866.4 18919.4 15051.9 15060.8 15500.8 15581.5 15736.2 15113.9 15230.7 15376.2 15525.7 15617.0 12299.9 14542.9 14985.3 15140.0 15178.8 9259.4 9334.4 9475.5 9502.3 9559.2 10447.4 10502.5 12828.2 13665.9 13691.4 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5542.04 Median:6762.08 stddev:2865.87 (42.4%) stddev-sans-first:2856.95 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: Values: 1394.3 1717.5 1784.4 1805.1 1834.0 6634.9 7723.8 7905.6 7911.7 7927.7 7809.2 7947.0 7955.1 7955.5 7973.1 1957.6 1989.1 1989.4 2284.9 2315.2 2031.3 2281.7 2303.6 2313.5 2316.1 2230.4 2247.2 2250.6 2260.1 2295.5 2295.3 2295.6 2325.1 2326.2 2329.0 2304.2 2345.2 2347.1 2347.4 2347.9 7569.5 7662.6 7668.9 7669.9 7677.8 4702.7 4791.7 4793.1 4793.4 4795.0 3088.5 3139.9 3193.2 3221.6 3226.4 1028.2 1030.3 1905.8 1956.0 2001.1 10645.2 10729.5 10735.0 10744.2 10751.0 4184.9 4232.1 4269.1 4344.8 4344.9 8760.7 8777.6 8798.9 8799.3 8803.6 4840.8 4841.2 4853.3 4857.7 4858.3 4440.4 4461.2 4472.8 4477.4 4497.6 2971.7 3486.6 3531.8 3545.4 3577.5 993.9 1054.8 1104.6 1106.5 1114.1 1131.9 1133.7 1136.5 1300.8 1364.3 7145.5 7215.5 7640.8 7669.9 7736.4 670.4 672.3 680.5 685.0 810.9 5815.3 5909.2 5912.8 5915.1 5923.9 9194.6 9420.4 9524.9 9726.1 9776.9 9645.2 9659.4 9765.5 9769.5 9773.2 7457.4 7460.2 7476.7 7630.4 7643.1 7465.1 7516.4 7520.6 7527.7 7537.6 8289.8 8439.5 8443.1 8588.0 8626.4 8662.1 8683.3 8842.0 8877.0 8898.2 7131.0 7183.2 7188.5 7191.5 7195.1 6546.9 7714.3 7745.7 7748.5 7761.6 6441.4 6950.0 7234.0 7396.9 7398.6 6728.4 6779.4 6881.6 6882.5 7291.6 7029.3 7060.5 7070.7 7100.1 7116.3 6799.4 6813.1 6818.8 6820.6 6825.1 6745.3 6778.8 6783.0 6785.9 6787.3 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,954 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5418.62 Median:6175.39 stddev:1618.60 (26.2%) stddev-sans-first:1577.76 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: Values: 347.7 354.0 354.9 355.3 361.1 6026.8 6096.5 6113.8 6164.0 6166.0 5829.7 6006.6 6024.6 6064.0 6076.8 4670.0 4671.2 4690.9 4699.6 4714.2 4504.1 4591.2 4599.2 4709.0 4713.1 4613.6 4637.9 4641.3 4650.1 4664.4 4616.3 4632.6 4649.6 4681.9 4695.1 4111.3 4117.9 4129.6 4131.9 4154.6 5645.9 5764.9 5770.9 5771.2 5776.9 5454.0 5456.8 5466.0 5466.3 5474.5 6391.4 6422.5 6423.4 6424.9 6429.2 4508.2 4583.3 4592.2 4599.8 4613.0 6674.0 6674.6 6679.1 6679.2 6684.7 4713.1 4714.2 4717.0 4717.7 4720.8 4748.6 4772.0 4781.0 4781.1 4781.6 5175.4 5343.7 5441.9 5456.5 5457.3 6435.3 6493.3 6504.3 6504.7 6509.5 1629.8 1645.3 1649.4 1652.0 1655.5 1079.7 1096.3 1101.4 1117.9 1121.5 6280.3 6291.9 6294.1 6295.9 6298.9 6473.1 6679.1 6688.4 6700.2 6700.5 6207.6 6269.7 6273.7 6329.7 6337.2 3602.3 3629.4 3632.3 3636.8 3639.5 6784.8 6914.7 6923.8 6926.0 6945.7 6870.4 6874.3 6875.9 6878.7 6884.1 6918.9 6924.4 6929.1 6942.2 6944.2 6564.7 6695.0 6712.8 6715.8 6716.9 6596.9 6621.6 6622.7 6634.0 6637.1 6899.2 6912.1 6914.4 6916.4 6921.7 4475.8 4589.6 4604.2 4605.1 4609.5 6631.7 6633.2 6642.8 6646.6 6652.4 6443.3 6457.2 6458.2 6469.3 6469.5 6346.4 6433.8 6435.2 6443.9 6456.7 6284.2 6318.3 6322.3 6326.6 6337.5 6451.9 6453.3 6455.4 6458.3 6459.6 6149.5 6184.8 6250.7 6252.8 6286.6 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14381.06 Median:44596.39 stddev:16692.04 (37.4%) stddev-sans-first:16707.60 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: Values: 778.2 785.2 912.2 919.6 930.3 13302.3 13516.4 13521.1 13540.2 13541.9 12024.9 12048.8 12050.6 12159.7 12316.7 880.7 890.1 895.2 896.0 896.1 885.6 886.8 887.1 887.6 890.1 920.6 927.9 928.9 929.4 930.0 925.2 931.3 931.7 931.8 932.2 679.3 685.3 686.5 686.8 687.1 12754.6 12761.6 12887.5 12899.2 12919.0 12053.2 12355.6 12694.9 12722.6 12995.0 10371.0 10407.1 10449.9 10727.7 10814.4 3779.2 3790.1 3823.9 3829.9 3833.0 41300.0 41401.6 44921.0 48784.0 48959.8 10100.6 10231.9 10271.6 10448.7 10697.6 17845.3 17914.9 17929.6 17965.6 18489.4 7586.1 7693.2 7718.0 7758.9 7929.2 4680.7 4705.9 4768.3 4783.2 4869.1 2974.4 2976.7 2981.6 2991.5 3006.0 561.6 563.5 563.8 567.3 596.3 643.4 685.6 726.7 732.4 743.5 8710.0 8881.0 9124.0 9234.2 9297.3 601.0 656.7 664.6 720.8 754.3 4188.1 4218.6 4308.4 4316.6 4368.3 56934.1 57599.7 57689.7 58408.0 63032.4 53153.0 53417.0 54097.7 54163.7 55034.4 46419.5 47228.5 56334.0 58909.4 58915.4 8367.3 8896.8 9265.9 9343.5 9510.0 35213.3 35562.0 36224.0 36465.0 36732.8 40938.8 44271.8 50710.2 51465.5 51952.7 12159.6 12237.5 12546.0 12728.8 12732.5 13285.4 13416.2 13478.6 14009.8 14146.6 12171.2 12418.4 12465.4 12682.7 13225.3 11682.6 11793.9 11854.0 12013.5 12292.2 11379.7 11759.8 11791.0 11974.5 12085.6 10514.3 11114.1 11438.4 11486.9 11574.4 9535.7 9987.9 9990.9 10194.6 10228.2 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:04:50 INFO - 2016-01-21 09:04:50,955 DEBUG : BROWSER_OUTPUT: 09:04:51 INFO - 2016-01-21 09:04:51,657 INFO : Browser exited with error code: 0 09:04:51 INFO - 2016-01-21 09:04:51,678 INFO : Completed test dromaeo_css (00:18:30) 09:04:51 INFO - 2016-01-21 09:04:51,679 INFO : Starting test kraken 09:04:51 INFO - 2016-01-21 09:04:51,679 DEBUG : operating with platform_type : linux_ 09:04:51 INFO - 2016-01-21 09:04:51,679 INFO : Initialising browser for kraken test... 09:04:51 INFO - 2016-01-21 09:04:51,685 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp25PSLc/profile http://localhost:48992/getInfo.html 09:04:55 INFO - 2016-01-21 09:04:55,807 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:04:55 INFO - 2016-01-21 09:04:55,807 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:04:55 INFO - 2016-01-21 09:04:55,808 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:04:55 INFO - 2016-01-21 09:04:55,808 DEBUG : BROWSER_OUTPUT: __metrics 09:04:55 INFO - 2016-01-21 09:04:55,965 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:56 INFO - 2016-01-21 09:04:56,753 INFO : Browser initialized. 09:04:56 INFO - 2016-01-21 09:04:56,754 INFO : Running cycle 1/1 for kraken test... 09:04:56 INFO - 2016-01-21 09:04:56,754 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp25PSLc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:05:08 INFO - 2016-01-21 09:05:08,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 135991296 09:05:08 INFO - 2016-01-21 09:05:08,563 DEBUG : BROWSER_OUTPUT: 09:05:10 INFO - 2016-01-21 09:05:10,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48992/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:11 INFO - 2016-01-21 09:05:11,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 169902080 09:05:11 INFO - 2016-01-21 09:05:11,559 DEBUG : BROWSER_OUTPUT: 09:05:14 INFO - 2016-01-21 09:05:14,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48992/tests/kraken/driver.html?testName=audio-dft) 09:05:14 INFO - 2016-01-21 09:05:14,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 168374272 09:05:14 INFO - 2016-01-21 09:05:14,687 DEBUG : BROWSER_OUTPUT: 09:05:17 INFO - 2016-01-21 09:05:17,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48992/tests/kraken/driver.html?testName=audio-fft) 09:05:18 INFO - 2016-01-21 09:05:18,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 166350848 09:05:18 INFO - 2016-01-21 09:05:18,057 DEBUG : BROWSER_OUTPUT: 09:05:20 INFO - 2016-01-21 09:05:20,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48992/tests/kraken/driver.html?testName=audio-oscillator) 09:05:20 INFO - 2016-01-21 09:05:20,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 166494208 09:05:20 INFO - 2016-01-21 09:05:20,636 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2016-01-21 09:05:22,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:23 INFO - 2016-01-21 09:05:23,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 165404672 09:05:23 INFO - 2016-01-21 09:05:23,372 DEBUG : BROWSER_OUTPUT: 09:05:26 INFO - 2016-01-21 09:05:26,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48992/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:26 INFO - 2016-01-21 09:05:26,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 164081664 09:05:26 INFO - 2016-01-21 09:05:26,812 DEBUG : BROWSER_OUTPUT: 09:05:30 INFO - 2016-01-21 09:05:30,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48992/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:30 INFO - 2016-01-21 09:05:30,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 166506496 09:05:30 INFO - 2016-01-21 09:05:30,732 DEBUG : BROWSER_OUTPUT: 09:05:33 INFO - 2016-01-21 09:05:33,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48992/tests/kraken/driver.html?testName=json-parse-financial) 09:05:34 INFO - 2016-01-21 09:05:34,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 166395904 09:05:34 INFO - 2016-01-21 09:05:34,022 DEBUG : BROWSER_OUTPUT: 09:05:35 INFO - 2016-01-21 09:05:35,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:36 INFO - 2016-01-21 09:05:36,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 170332160 09:05:36 INFO - 2016-01-21 09:05:36,145 DEBUG : BROWSER_OUTPUT: 09:05:37 INFO - 2016-01-21 09:05:37,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:38 INFO - 2016-01-21 09:05:38,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 167010304 09:05:38 INFO - 2016-01-21 09:05:38,506 DEBUG : BROWSER_OUTPUT: 09:05:40 INFO - 2016-01-21 09:05:40,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:41 INFO - 2016-01-21 09:05:41,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 176439296 09:05:41 INFO - 2016-01-21 09:05:41,068 DEBUG : BROWSER_OUTPUT: 09:05:43 INFO - 2016-01-21 09:05:43,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:43 INFO - 2016-01-21 09:05:43,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 181571584 09:05:43 INFO - 2016-01-21 09:05:43,989 DEBUG : BROWSER_OUTPUT: 09:05:46 INFO - 2016-01-21 09:05:46,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:47 INFO - 2016-01-21 09:05:47,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 179892224 09:05:47 INFO - 2016-01-21 09:05:47,098 DEBUG : BROWSER_OUTPUT: 09:05:48 INFO - 2016-01-21 09:05:48,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48992/tests/kraken/driver.html?testName=ai-astar) 09:05:49 INFO - 2016-01-21 09:05:49,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 238403584 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:05:49 INFO - 2016-01-21 09:05:49,019 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;104;109;110;110;99;109;110;112 09:05:49 INFO - 2016-01-21 09:05:49,020 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;120;147;158;122;158;145;120;160;121 09:05:49 INFO - 2016-01-21 09:05:49,020 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;160;159;160;159;161;161;159 09:05:49 INFO - 2016-01-21 09:05:49,020 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;71;72;143;72;73;73;72;150;77 09:05:49 INFO - 2016-01-21 09:05:49,020 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;139;92;93;93;139;93;93;129 09:05:49 INFO - 2016-01-21 09:05:49,020 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;109;109;109;109;110;109;109;109;109 09:05:49 INFO - 2016-01-21 09:05:49,021 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;145;147;145;148;147;147 09:05:49 INFO - 2016-01-21 09:05:49,021 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;96;96;96;95 09:05:49 INFO - 2016-01-21 09:05:49,021 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;56;57;58;60;57;56;60;54 09:05:49 INFO - 2016-01-21 09:05:49,021 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;65;65;66;65;65;66;65 09:05:49 INFO - 2016-01-21 09:05:49,021 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;80;88;80;80;82;80;82;81;80 09:05:49 INFO - 2016-01-21 09:05:49,022 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;111;112;110;118;118;121;117;112;112 09:05:49 INFO - 2016-01-21 09:05:49,022 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;149;145;148;149;133;158;141;145;134 09:05:49 INFO - 2016-01-21 09:05:49,022 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;65;66;65;66;64;66;67 09:05:49 INFO - 2016-01-21 09:05:49,022 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:05:49 INFO - 2016-01-21 09:05:49,022 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,889 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: __startTimestamp1453395949011__endTimestamp 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.81 (3.5%) stddev-sans-first:4.04 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 104.0 109.0 110.0 110.0 99.0 109.0 110.0 112.0 09:05:49 INFO - 2016-01-21 09:05:49,023 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.40 Median:150.00 stddev:17.56 (11.7%) stddev-sans-first:18.02 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: Values: 153.0 120.0 147.0 158.0 122.0 158.0 145.0 120.0 160.0 121.0 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 160.0 159.0 160.0 159.0 161.0 161.0 159.0 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:72.50 stddev:30.94 (42.7%) stddev-sans-first:32.56 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: Values: 77.0 71.0 72.0 143.0 72.0 73.0 73.0 72.0 150.0 77.0 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:20.93 (22.5%) stddev-sans-first:21.61 09:05:49 INFO - 2016-01-21 09:05:49,024 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 139.0 92.0 93.0 93.0 139.0 93.0 93.0 129.0 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:1.10 (0.8%) stddev-sans-first:1.17 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 145.0 147.0 145.0 148.0 147.0 147.0 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 09:05:49 INFO - 2016-01-21 09:05:49,025 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.87 (3.3%) stddev-sans-first:1.96 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 56.0 57.0 58.0 60.0 57.0 56.0 60.0 54.0 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 65.0 66.0 65.0 65.0 66.0 65.0 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:2.50 (3.1%) stddev-sans-first:2.60 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 88.0 80.0 80.0 82.0 80.0 82.0 81.0 80.0 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:117.00 stddev:3.79 (3.2%) stddev-sans-first:3.94 09:05:49 INFO - 2016-01-21 09:05:49,026 DEBUG : BROWSER_OUTPUT: Values: 117.0 111.0 112.0 110.0 118.0 118.0 121.0 117.0 112.0 112.0 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:146.50 stddev:7.40 (5.0%) stddev-sans-first:7.83 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: Values: 143.0 149.0 145.0 148.0 149.0 133.0 158.0 141.0 145.0 134.0 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 65.0 66.0 65.0 66.0 64.0 66.0 67.0 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:05:49 INFO - 2016-01-21 09:05:49,027 DEBUG : BROWSER_OUTPUT: 09:05:49 INFO - 2016-01-21 09:05:49,873 INFO : Browser exited with error code: 0 09:05:49 INFO - 2016-01-21 09:05:49,924 INFO : Completed test kraken (00:00:58) 09:05:49 INFO - 2016-01-21 09:05:49,924 INFO : Starting test v8_7 09:05:49 INFO - 2016-01-21 09:05:49,924 DEBUG : operating with platform_type : linux_ 09:05:49 INFO - 2016-01-21 09:05:49,924 INFO : Initialising browser for v8_7 test... 09:05:49 INFO - 2016-01-21 09:05:49,930 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SGYSd/profile http://localhost:48992/getInfo.html 09:05:54 INFO - 2016-01-21 09:05:54,161 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:05:54 INFO - 2016-01-21 09:05:54,161 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:05:54 INFO - 2016-01-21 09:05:54,161 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:05:54 INFO - 2016-01-21 09:05:54,161 DEBUG : BROWSER_OUTPUT: __metrics 09:05:54 INFO - 2016-01-21 09:05:54,350 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:55 INFO - 2016-01-21 09:05:55,199 INFO : Browser initialized. 09:05:55 INFO - 2016-01-21 09:05:55,199 INFO : Running cycle 1/1 for v8_7 test... 09:05:55 INFO - 2016-01-21 09:05:55,200 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8SGYSd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:06:06 INFO - 2016-01-21 09:06:06,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 135835648 09:06:06 INFO - 2016-01-21 09:06:06,926 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48992/tests/v8_7/run.html (next: http://localhost:48992/tests/v8_7/run.html) 09:06:28 INFO - 2016-01-21 09:06:28,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 427458560 09:06:28 INFO - 2016-01-21 09:06:28,586 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,587 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:06:28 INFO - 2016-01-21 09:06:28,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: |0;Richards;164.90765171503958 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;174.33751743375174 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 09:06:28 INFO - 2016-01-21 09:06:28,588 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 09:06:28 INFO - 2016-01-21 09:06:28,589 DEBUG : BROWSER_OUTPUT: |4;RayTrace;995.0248756218906 09:06:28 INFO - 2016-01-21 09:06:28,589 DEBUG : BROWSER_OUTPUT: |5;Earley;555.864369093941 09:06:28 INFO - 2016-01-21 09:06:28,589 DEBUG : BROWSER_OUTPUT: |6;Boyer;10891.304347826086 09:06:28 INFO - 2016-01-21 09:06:28,589 DEBUG : BROWSER_OUTPUT: |7;RegExp;24095.238095238095 09:06:28 INFO - 2016-01-21 09:06:28,589 DEBUG : BROWSER_OUTPUT: |8;Splay;520.0208008320333 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1453395988586__endTimestamp 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:06:28 INFO - 2016-01-21 09:06:28,590 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:06:28 INFO - 2016-01-21 09:06:28,591 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,591 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.91 Median:164.91 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,591 DEBUG : BROWSER_OUTPUT: Values: 164.9 09:06:28 INFO - 2016-01-21 09:06:28,591 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,591 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:174.34 Median:174.34 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: Values: 174.3 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: Values: 278.4 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,592 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,593 DEBUG : BROWSER_OUTPUT: Values: 5181.3 09:06:28 INFO - 2016-01-21 09:06:28,593 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,593 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:995.02 Median:995.02 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,594 DEBUG : BROWSER_OUTPUT: Values: 995.0 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:555.86 Median:555.86 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: Values: 555.9 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10891.30 Median:10891.30 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: Values: 10891.3 09:06:28 INFO - 2016-01-21 09:06:28,595 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24095.24 Median:24095.24 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: Values: 24095.2 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:520.02 Median:520.02 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: Values: 520.0 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: 09:06:28 INFO - 2016-01-21 09:06:28,596 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:06:28 INFO - 2016-01-21 09:06:28,597 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:06:28 INFO - 2016-01-21 09:06:28,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:06:28 INFO - 2016-01-21 09:06:28,597 DEBUG : BROWSER_OUTPUT: 09:06:29 INFO - 2016-01-21 09:06:29,382 INFO : Browser exited with error code: 0 09:06:29 INFO - 2016-01-21 09:06:29,394 INFO : Completed test v8_7 (00:00:39) 09:06:29 INFO - 2016-01-21 09:06:29,611 INFO : Completed test suite (00:20:08) 09:06:29 INFO - 2016-01-21 09:06:29,612 DEBUG : Working with test: dromaeo_css 09:06:29 INFO - 2016-01-21 09:06:29,612 DEBUG : Generating results file: dromaeo_css 09:06:29 INFO - 2016-01-21 09:06:29,613 DEBUG : Working with test: kraken 09:06:29 INFO - 2016-01-21 09:06:29,613 DEBUG : Generating results file: kraken 09:06:29 INFO - 2016-01-21 09:06:29,613 INFO : javascript benchmark 09:06:29 INFO - 2016-01-21 09:06:29,614 DEBUG : Working with test: v8_7 09:06:29 INFO - 2016-01-21 09:06:29,614 DEBUG : Generating results file: v8_7 09:06:29 INFO - 2016-01-21 09:06:29,614 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:29 INFO - 2016-01-21 09:06:29,668 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 09:06:29 INFO - 2016-01-21 09:06:29,668 DEBUG : process_Request line: dromaeo_css 7281.87 graph.html#tests=[[72,52,35]] 09:06:29 INFO - 2016-01-21 09:06:29,668 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:29 INFO - 2016-01-21 09:06:29,701 DEBUG : process_Request line: kraken 1481.20 graph.html#tests=[[232,52,35]] 09:06:29 INFO - 2016-01-21 09:06:29,701 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:29 INFO - 2016-01-21 09:06:29,739 DEBUG : process_Request line: v8_7 22986.35 graph.html#tests=[[230,52,35]] 09:06:29 INFO - 2016-01-21 09:06:29,740 INFO : javascript benchmark 09:06:29 INFO - 2016-01-21 09:06:29,744 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3244.0, 3327.567416235889, 3353.228757385801, 3360.1431634933087, 3385.475251336043, 5357.866053348664, 5386.434424385442, 5394.379646340672, 5395.028894798935, 5431.4840090191465, 5373.623846330758, 5412.864678383043, 5418.8916221675545, 5427.945720542793, 5456.563474922006, 4751.762411879409, 4946.9257961130525, 4993.500649934996, 5017.774200161001, 5037.042961837257, 4904.632152588552, 4961.925571116436, 4962.6526143169995, 4982.202847544394, 4984.476629953857, 4816.51834816519, 4889.975550122263, 4956.925646115311, 4963.35476388069, 4968.577670897978, 4883.19427294496, 4950.6782059166035, 4975.502449754996, 5000.0, 5017.222330538772, 4934.777934992934, 4959.628027897886, 4972.477889821553, 4995.550400463976, 5022.4224214215465, 5044.1677123274985, 5112.156494178456, 5136.203888397267, 5151.0, 5219.817306394258, 5708.77164913403, 5748.223989761371, 5756.884862302731, 5763.625364351304, 5837.066069428914, 5826.796062137847, 5827.825165245049, 5831.446012628793, 5832.883342333172, 5849.736761845727, 5313.229581710631, 5385.7307134643115, 5397.082495975694, 5459.208414779874, 5484.561235101182, 5848.970755146197, 5888.234529511136, 5898.026825573818, 5899.528037756969, 5900.704964751745, 5676.0918253080135, 5718.313802343745, 5718.857028574319, 5720.656760594377, 5747.224124743189, 5551.0, 5608.859778505488, 5665.745041473144, 5672.376038635747, 5692.089265717465, 5662.68855212959, 5770.58620637938, 5802.390748971382, 5803.912941305884, 5804.651720896675, 5564.4991950724625, 5791.0, 5795.884082318415, 5800.0429929062075, 5803.709814509258, 4403.053343531156, 4419.116176764595, 4423.845165419195, 4450.109978004412, 4484.05834774701, 4039.969807699018, 4046.2716710992304, 4053.8175782089875, 4078.4494093297026, 4081.2653722329674, 5330.067238233293, 5391.595630327741, 5540.2243685884005, 5559.24950131727, 5560.165975103767, 5645.407232240637, 5699.2590963174525, 5706.971465142731, 5729.5702822288495, 5766.855828604318, 5438.809641662523, 5496.31296087989, 5499.532539734088, 5500.972495137498, 5501.229827824108, 4820.638452116105, 4926.655134140576, 4941.678790878654, 5029.64792464524, 5069.239614057921, 6008.0, 6019.759209631566, 6022.518198544106, 6029.698515074228, 6030.276366836008, 5861.032929566659, 5870.911936320873, 5872.823815285548, 5873.618214816023, 5873.94126058751, 5659.349174844946, 5674.829755107354, 5970.402959703995, 6002.729877155626, 6112.969435152796, 5726.0838265877255, 5731.656100633809, 5742.2535070442245, 5742.36833948257, 5745.827625171251, 5784.595078344475, 5831.300243970751, 5837.1244313351635, 5838.824835254949, 5841.240638716939, 5516.696581688046, 5528.91706624409, 5580.0, 5609.411011843697, 5628.943710562842, 5656.717164141859, 5658.066419040977, 5658.462446067617, 5666.065099258576, 5759.712014399347, 5556.638818476948, 5568.721563921868, 5572.024895643165, 5577.107662773937, 5608.298962629671, 5487.039768040657, 5581.9162712560155, 5584.3857175711455, 5668.064769313182, 5677.120046392815, 5512.0, 5540.473655002768, 5540.97491963988, 5570.053090974625, 5595.608307418442], "unit": "ms", "name": "dojo.html", "value": 5336.408839379123}, {"lowerIsBetter": false, "replicates": [570.2985328046502, 610.5359926455893, 620.4013127332125, 622.3776223776224, 624.81255623313, 32237.35525289496, 38711.61288387115, 39104.413433798516, 39122.60877391225, 39129.804350978244, 44464.777676111575, 45211.0, 45244.32133517991, 45246.547534524645, 45374.0, 8141.674333026672, 8275.834483310331, 9221.769455763626, 9400.05999400058, 10546.736331591734, 10872.782544349107, 10940.343579385222, 10949.288296260758, 10955.671329860117, 10963.451827408637, 10987.175961802857, 11108.555657773679, 11113.444327783618, 11113.944430277877, 11114.666560003172, 8311.044229913578, 8481.95759021207, 10986.230963832535, 11366.943165284121, 11368.60209892658, 10700.571977120906, 10839.187060970458, 10846.945765271203, 10848.403337816417, 10848.67453976382, 42859.0, 43228.567714322766, 43385.34921976173, 43410.13179736387, 43458.78270608658, 3657.725670574691, 3684.428913518409, 3735.0, 3797.9430308545393, 4173.91652166958, 32581.0, 33072.50391244109, 33119.6688033119, 33148.0, 33413.498797518056, 4243.215005224012, 4260.0, 4370.312257961363, 4381.583749543788, 4405.801738921757, 287079.0, 295687.0, 295794.0, 296157.0, 298142.50928745436, 61208.081878770965, 62945.0, 68364.6581767098, 68986.31013689798, 69151.0, 75261.0, 77087.61456192684, 77282.0, 77528.61235693785, 77598.61200694073, 15919.681606367807, 15936.681266374608, 15978.520644380687, 16038.0, 16143.919280403523, 12183.390830458442, 12192.39038048094, 12218.327991960528, 12255.632331030083, 12296.262224266573, 22056.779432205472, 22150.446238843837, 22170.667439988414, 22790.202342917917, 22889.31332060041, 8303.667853285922, 8715.302775777922, 8826.073262307493, 8844.513551754715, 8875.778105547284, 1000.9949950250202, 1031.9164876879397, 1059.7562560610947, 1101.4492753623188, 1121.5906194239044, 29032.41935161285, 29460.852695736383, 29670.851645742066, 29761.40477190444, 30128.397432051675, 1065.0999905080196, 1109.4120116338354, 1160.1299025730702, 1162.4478372772865, 1198.9389390389567, 13951.302434878215, 14852.331645075998, 15132.773008404884, 15564.45524406663, 17327.0, 440066.0, 441584.0, 443159.0, 445769.0, 447254.0, 58339.4166058334, 58613.0, 58998.0, 59065.70467147723, 59071.11393329103, 1328.6744747536916, 1354.3093022558567, 1395.2814300635182, 1435.2034620785773, 1459.4016453254114, 29548.113556593336, 29661.0, 34154.31691366109, 34421.82789086038, 34746.30507389889, 47780.7610961943, 54060.0, 55112.44887551073, 55123.44876551183, 55152.72423637856, 237294.0, 239265.0, 240072.0, 240075.0, 290738.0, 45050.324245137, 46100.166034742855, 46321.536784631724, 46384.768076160755, 48115.75942120267, 49844.0, 49913.0, 49937.500624993285, 50685.493145068074, 51023.48976510188, 40296.0, 40658.0, 41006.0, 41180.61901545633, 42340.576594234895, 42159.578404215565, 42472.5752742481, 42519.1110312226, 42970.57029429666, 43135.56864431441, 41103.7944810286, 41501.58498414977, 41879.581204188784, 42146.1570768589, 42231.577684223994, 36333.63666363303, 38376.616233838424, 38651.61348386593, 38678.80660596679, 38814.4177837327, 27846.16461506158, 27963.004512252563, 28110.251556935942, 28185.154445366672, 28213.576796348483], "unit": "ms", "name": "ext.html", "value": 20775.47538642591}, {"lowerIsBetter": false, "replicates": [366.51985898472986, 371.051962236486, 371.35674639719235, 372.3260897775027, 372.6497092732831, 15491.457798977039, 17638.823611763877, 17660.646787064252, 18841.15214815333, 19371.70942435861, 11256.212065155421, 11368.545258189662, 11830.0, 14202.0, 18453.16960736767, 5132.024915266097, 5221.451747566508, 5228.529432351088, 5243.9213411798855, 5254.106801843676, 3890.630390112935, 3986.2625414298304, 5508.55931525477, 5611.551075913938, 5629.408912064236, 5541.56669717283, 5597.44025597439, 5602.523785478219, 5614.0, 5650.5479561634975, 6177.135201071854, 6207.3792620737795, 6254.093156492283, 6254.124422580842, 6267.780627678009, 5150.150225212836, 5499.862503437406, 5510.421405752379, 5512.972435137839, 5523.475269849358, 13284.269365184911, 13318.267495287755, 13444.596662100153, 13507.392167352395, 13694.178349298974, 2045.2739277556402, 2124.4157856589563, 2196.978030219693, 2314.3866875277895, 2331.219041621059, 10105.646302379455, 10269.28115031948, 10310.381377117397, 12312.753744925052, 13467.92256619468, 1809.312461264724, 1832.752578401912, 1879.079251166932, 1945.6984167454068, 1952.5899561092187, 63467.6826615864, 66049.00926486154, 66268.3373166267, 66895.3310466894, 67875.66062169657, 10510.421926793946, 10744.946275268574, 10750.516226769658, 10756.515956781963, 10847.294925829954, 13889.652758681113, 13974.231417271943, 13987.300634968211, 14004.369803358873, 14005.789913151311, 8122.796930076795, 8152.2662960333855, 8160.143184965612, 8185.444765494537, 8197.098319184885, 7999.720009799629, 8019.1579884111325, 8036.437449378487, 8058.395620328499, 8058.959705201553, 4458.554144585581, 4543.727376357363, 4589.173948689268, 4602.677812553156, 4626.86119416418, 1721.3286818140684, 1790.8298711622374, 1791.704368779163, 1829.5243236758272, 1846.1230915315118, 942.948137852411, 982.8034393121404, 1028.0798685176726, 1033.9970228877976, 1050.9474526273655, 13986.510472133426, 16957.915210424115, 17164.742528862076, 17180.484585462455, 17613.031283279543, 990.6582229130938, 993.1508560180941, 1011.7369483934231, 1054.1250761867632, 1078.1644225725126, 9400.48297343639, 9939.850902236472, 10115.241356898263, 10636.627718029831, 10747.892521074846, 623785.6432153521, 624705.0, 634439.0, 637711.0, 647386.0, 86088.0, 86606.13393865981, 88149.0, 89935.0, 91550.08449915549, 1229.883161099694, 1232.3037483821613, 1236.202649291202, 1239.69007748063, 1245.6761242077125, 15371.538853834403, 15952.282147303631, 16174.353025878832, 16218.189090545662, 16416.671666566363, 33223.83388083044, 33697.82057628069, 34110.48834267537, 35761.28477430385, 37786.05534861651, 45273.0, 51994.0, 52445.47554524406, 52628.0, 55000.72499637476, 9606.66376676841, 9787.657431989846, 9824.950875245579, 9887.159591434809, 9897.55461004271, 18365.173567189242, 18504.444866654023, 18697.90651046736, 18866.434006979813, 18919.43241702751, 15051.924740376227, 15060.79148124601, 15500.844991550392, 15581.532554023397, 15736.213189340717, 15113.924430377778, 15230.695386091995, 15376.154311512973, 15525.689486209987, 15617.0, 12299.93850030744, 14542.927285363505, 14985.250737462866, 15140.0, 15178.848211517743, 9259.398139120936, 9334.439933604006, 9475.526223688927, 9502.287328450255, 9559.23526117895, 10447.425391603534, 10502.527386267484, 12828.166169198972, 13665.863341366858, 13691.383887725275], "unit": "ms", "name": "jquery.html", "value": 9121.591506688339}, {"lowerIsBetter": false, "replicates": [1394.3307212537989, 1717.4675850486346, 1784.4379020608512, 1805.1154934082303, 1833.9541511462212, 6634.90047649285, 7723.768286951394, 7905.604719764017, 7911.683532658702, 7927.722529711461, 7809.219078092188, 7947.046354437475, 7955.085165206003, 7955.482893611911, 7973.122956474797, 1957.618264438435, 1989.055198780582, 1989.3832911797317, 2284.8743319117443, 2315.1781117703226, 2031.2890488329115, 2281.7376001759844, 2303.585354636165, 2313.4910319729634, 2316.119874447716, 2230.408941630469, 2247.1797793805226, 2250.5948929192737, 2260.08466571039, 2295.540891821634, 2295.3114065780364, 2295.598270302699, 2325.093213646679, 2326.162581470661, 2328.9752508896117, 2304.193532263694, 2345.2377977157494, 2347.119830063726, 2347.448349637834, 2347.8943447544902, 7569.545827250383, 7662.61686915652, 7668.884966725504, 7669.884951725729, 7677.808054798619, 4702.670813043088, 4791.7124972501415, 4793.065352256312, 4793.400824896888, 4794.95205047952, 3088.4903990841485, 3139.9372012559847, 3193.2016995751064, 3221.629512606057, 3226.3869864725625, 1028.1928685981468, 1030.258214085857, 1905.7903630600622, 1955.9608807823906, 2001.0895042755512, 10645.20160987929, 10729.517171727213, 10735.033846953811, 10744.247902646895, 10751.0, 4184.916301673949, 4232.111256636079, 4269.060806622538, 4344.82620695175, 4344.913101737948, 8760.693375731818, 8777.561121943878, 8798.86801697975, 8799.29605631548, 8803.647854085764, 4840.75796210188, 4841.201201801663, 4853.344798452164, 4857.6599638025, 4858.295547145644, 4440.35614835847, 4461.24158892989, 4472.776361181993, 4477.350784136282, 4497.595216430537, 2971.7325440710006, 3486.633903440102, 3531.823408829548, 3545.37955857729, 3577.5170352002665, 993.9304248702522, 1054.778496515725, 1104.6078642081945, 1106.4854842498278, 1114.0808832713044, 1131.8811524789944, 1133.659902029388, 1136.4885801389407, 1300.7918733002864, 1364.3382959264948, 7145.4998150128995, 7215.49491535598, 7640.80897977555, 7669.884951725729, 7736.419768517271, 670.3698523388, 672.3008071605573, 680.5202332355677, 684.9760258390933, 810.9052778748642, 5815.3021637402935, 5909.202257695242, 5912.793052243151, 5915.142304365929, 5923.940760592425, 9194.586243619053, 9420.387674801115, 9524.90475095254, 9726.076022777825, 9776.9022309776, 9645.180159686504, 9659.420434773936, 9765.511724413751, 9769.462679552693, 9773.169280611228, 7457.403407727369, 7460.216677248919, 7476.738314158978, 7630.427717921067, 7643.121041080236, 7465.06686664167, 7516.398688105048, 7520.623968801648, 7527.661255243636, 7537.585432801248, 8289.751307460785, 8439.535825529409, 8443.113473085237, 8587.957060214909, 8626.39615226928, 8662.090480499708, 8683.305335573265, 8841.955790221007, 8877.0, 8898.243649289883, 7130.964345178241, 7183.173934997542, 7188.460865435009, 7191.460640452092, 7195.13658361, 6546.934530654633, 7714.267144621252, 7745.690172393267, 7748.535087894745, 7761.573113478813, 6441.355864413521, 6949.992251123457, 7234.02340684022, 7396.852062958603, 7398.630068496661, 6728.428083612947, 6779.35596118368, 6881.621510816954, 6882.483813714091, 7291.635418229173, 7029.332213439715, 7060.470464715269, 7070.71717131309, 7100.147982242164, 7116.323949224816, 6799.422049125879, 6813.080234168324, 6818.795436136924, 6820.590764553944, 6825.1127353443735, 6745.325467453215, 6778.830529236809, 6782.966085169543, 6785.864282714417, 6787.287334829772], "unit": "ms", "name": "mootools.html", "value": 4539.253181548323}, {"lowerIsBetter": false, "replicates": [347.69402925425624, 353.9858405663772, 354.90417587251426, 355.33906933104413, 361.117068766865, 6026.849328766783, 6096.481799047081, 6113.7860174893885, 6164.044573091167, 6165.969170154149, 5829.679367634779, 6006.639601623895, 6024.578279520435, 6064.0, 6076.848078798022, 4670.042641258542, 4671.229247174212, 4690.929636055462, 4699.553542413482, 4714.151452738506, 4504.099180163964, 4591.1965406053805, 4599.172149013176, 4708.952910470903, 4713.104510143079, 4613.584777370036, 4637.9072418551605, 4641.327007583898, 4650.093231819779, 4664.4402671679445, 4616.30755386693, 4632.606228470584, 4649.628029757611, 4681.88295292617, 4695.107929493385, 4111.280525907954, 4117.8970525736795, 4129.607687269705, 4131.8967025824295, 4154.646855017327, 5645.887082258332, 5764.913526297109, 5770.9422905770825, 5771.163181338682, 5776.913346299809, 5453.972730136324, 5456.7544460498975, 5466.0, 5466.262054622614, 5474.534664553478, 6391.424771770517, 6422.454091402236, 6423.357664233539, 6424.93575064248, 6429.2284925808735, 4508.211063063951, 4583.3125031245245, 4592.196365636, 4599.816007359702, 4613.0, 6673.9666301668185, 6674.566153200027, 6679.131712877295, 6679.198496180489, 6684.699188536528, 4713.057388522309, 4714.175019371596, 4716.976415117971, 4717.693349932243, 4720.787564559603, 4748.572628463386, 4772.0, 4780.995990841962, 4781.091592597395, 4781.593564546983, 5175.378954525481, 5343.6526625769975, 5441.918371224435, 5456.536194423518, 5457.317835270591, 6435.324290949383, 6493.31820158886, 6504.252011018793, 6504.674766261668, 6509.511786616023, 1629.8370162983606, 1645.2760785254688, 1649.4474351092279, 1651.9587010324838, 1655.5198992292342, 1079.6760971708457, 1096.3367162866512, 1101.3612104979093, 1117.9385133817555, 1121.5009320852305, 6280.340564240781, 6291.905621415683, 6294.118823364733, 6295.905561416583, 6298.905516417258, 6473.093766872642, 6679.098321726505, 6688.398044176048, 6700.195976482853, 6700.4639628830555, 6207.596506227081, 6269.749210031548, 6273.654948977759, 6329.651869147149, 6337.176167098248, 3602.27954409114, 3629.4011488104693, 3632.3098611263777, 3636.8363423646, 3639.5086663300117, 6784.76253331131, 6914.654267286615, 6923.792286231421, 6926.0, 6945.652717364112, 6870.381665650116, 6874.312568743086, 6875.862482750317, 6878.69045892936, 6884.070650462124, 6918.8962165567555, 6924.4114250288285, 6929.064576282238, 6942.20164681058, 6944.166699996033, 6564.704588293443, 6694.966525167343, 6712.832179195364, 6715.764948226984, 6716.899246511404, 6596.868062638816, 6621.602703837592, 6622.668866556556, 6634.0, 6637.103990961158, 6899.241083480913, 6912.066870972354, 6914.377706006484, 6916.377526022682, 6921.7231310747, 4475.843345482893, 4589.58693717567, 4604.240300350539, 4605.055963527536, 4609.516000819865, 6631.734730610721, 6633.2371777246235, 6642.800715978528, 6646.567973081927, 6652.368025037614, 6443.323451037761, 6457.225132984072, 6458.160439142881, 6469.320721324381, 6469.482441404771, 6346.397092276226, 6433.806985790434, 6435.163428754232, 6443.903341449788, 6456.677166141768, 6284.24589049317, 6318.336574659778, 6322.336154703874, 6326.620402775849, 6337.4613157882095, 6451.935480645134, 6453.290138084901, 6455.386738259858, 6458.257300410513, 6459.644719540471, 6149.508039356751, 6184.81445556634, 6250.718717657625, 6252.843678907881, 6286.622802631857], "unit": "ms", "name": "prototype.html", "value": 4895.661035768431}, {"lowerIsBetter": false, "replicates": [778.1673609238114, 785.2251094024277, 912.2246090822799, 919.6183583812718, 930.3394589841213, 13302.334883255835, 13516.391762370693, 13521.05352625318, 13540.187588744682, 13541.864581354184, 12024.879751202485, 12048.819267710991, 12050.57822976196, 12159.696007599814, 12316.692082697937, 880.6653471680752, 890.1054440287535, 895.2122132523402, 895.9552022398886, 896.0725648953335, 885.5572213893054, 886.8182022685367, 887.0951629338072, 887.5562218890555, 890.1321211818457, 920.6179435534245, 927.8608208768671, 928.8885333759958, 929.3866048408051, 929.9674511392103, 925.1673493855584, 931.3340961212732, 931.6692574136151, 931.7903471718843, 932.1563984593953, 679.2799632389683, 685.2736099734298, 686.5297271369078, 686.7836631461124, 687.1410736579276, 12754.553590624284, 12761.553345632858, 12887.484500619965, 12899.161554498927, 12919.031072669493, 12053.2165409249, 12355.567555135527, 12694.873051269555, 12722.554710585178, 12995.0, 10371.0, 10407.115395191418, 10449.895501045045, 10727.678169654922, 10814.35113893161, 3779.2063666630042, 3790.0714324990277, 3823.9044023899346, 3829.8659546915724, 3832.9808350958065, 41300.0, 41401.58598414037, 44921.0, 48784.0, 48959.755201223765, 10100.595976160872, 10231.897681023243, 10271.589136434459, 10448.68653940383, 10697.625583104555, 17845.28618855257, 17914.925104493774, 17929.551761206076, 17965.550861228312, 18489.445316640522, 7586.127595326498, 7693.230676932374, 7718.035245594301, 7758.883616745753, 7929.167437419103, 4680.672352935262, 4705.882352941136, 4768.332433459318, 4783.23468245086, 4869.099216644932, 2974.3902499987453, 2976.7172118648696, 2981.59748433963, 2991.491446454108, 3005.9849700751356, 561.5732043646776, 563.5266376243893, 563.7857614106613, 567.2625586737225, 596.260636810352, 643.359856942336, 685.6092027544352, 726.7093162734948, 732.3811379384412, 743.4869939741561, 8710.041895391501, 8880.955595222113, 9123.954380228057, 9234.215091717278, 9297.349185557081, 600.9519238460913, 656.6880731652523, 664.6410938093376, 720.7513407874275, 754.3211110001043, 4188.120494696148, 4218.578142185757, 4308.353746937984, 4316.589923957219, 4368.344748287782, 56934.14598781022, 57599.71200143972, 57689.711551442815, 58408.0, 63032.36967630265, 53153.0, 53417.0, 54097.72951135219, 54163.72918135384, 55034.44965550373, 46419.53580464152, 47228.52771472241, 56334.0, 58909.41090589125, 58915.41084589099, 8367.28878045373, 8896.777580560538, 9265.868850164365, 9343.53282335867, 9510.0, 35213.29573408466, 35562.0, 36224.00767957787, 36465.0, 36732.81633591815, 40938.79530602447, 44271.77864110659, 50710.23934641057, 51465.485345146066, 51952.740236298574, 12159.574414895436, 12237.510499579917, 12546.0, 12728.809067864175, 12732.490700371882, 13285.40215690277, 13416.195028298333, 13478.595642130751, 14009.789853152008, 14146.575602731935, 12171.208871423683, 12418.441170147546, 12465.439055242718, 12682.682932926751, 13225.272610006543, 11682.649520514398, 11793.941030295136, 11854.0, 12013.519459221534, 12292.201006934522, 11379.715507112389, 11759.76480470403, 11791.0, 11974.46114924813, 12085.577004805142, 10514.316569422963, 11114.110871130451, 11438.370889601152, 11486.94256528712, 11574.421278936188, 9535.713928582154, 9987.850182247126, 9990.850137247802, 10194.643187488698, 10228.181745460197], "unit": "ms", "name": "yui.html", "value": 6633.591068107677}], "name": "dromaeo_css", "value": 7281.868598595043}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 104.0, 109.0, 110.0, 110.0, 99.0, 109.0, 110.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [153.0, 120.0, 147.0, 158.0, 122.0, 158.0, 145.0, 120.0, 160.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 159.0, 160.0, 159.0, 161.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [77.0, 71.0, 72.0, 143.0, 72.0, 73.0, 73.0, 72.0, 150.0, 77.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 139.0, 92.0, 93.0, 93.0, 139.0, 93.0, 93.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 145.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 57.0, 58.0, 60.0, 57.0, 56.0, 60.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 88.0, 80.0, 80.0, 82.0, 80.0, 82.0, 81.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [117.0, 111.0, 112.0, 110.0, 118.0, 118.0, 121.0, 117.0, 112.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [143.0, 149.0, 145.0, 148.0, 149.0, 133.0, 158.0, 141.0, 145.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 64.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1481.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.90765171503958], "unit": "score", "name": "Richards", "value": 214.07132799999994}, {"lowerIsBetter": false, "replicates": [174.33751743375174], "unit": "score", "name": "DeltaBlue", "value": 379.2528480000002}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [995.0248756218906], "unit": "score", "name": "RayTrace", "value": 743.6889449999996}, {"lowerIsBetter": false, "replicates": [555.864369093941], "unit": "score", "name": "Earley", "value": 1198.9669370000004}, {"lowerIsBetter": false, "replicates": [10891.304347826086], "unit": "score", "name": "Boyer", "value": 61.19221157684634}, {"lowerIsBetter": false, "replicates": [24095.238095238095], "unit": "score", "name": "RegExp", "value": 37.80767786561265}, {"lowerIsBetter": false, "replicates": [520.0208008320333], "unit": "score", "name": "Splay", "value": 156.70719299999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22986.348315685693}]} 09:06:29 INFO - RETURN: dromaeo_css: 7281.87 09:06:29 INFO - RETURN: kraken: 1481.20 09:06:29 INFO - RETURN: v8_7: 22986.35 09:06:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "22986.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1481.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7281.87"}}} 09:06:29 INFO - Return code: 0 09:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:06:29 INFO - # TBPL SUCCESS # 09:06:29 INFO - Running post-action listener: _resource_record_post_action 09:06:29 INFO - Running post-run listener: _resource_record_post_run 09:06:30 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 339968; Write bytes: 508600320; Read time: 392; Write time: 425164 09:06:30 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246231040; Read time: 192; Write time: 244392 09:06:30 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 335872; Write bytes: 262029312; Read time: 200; Write time: 180748 09:06:30 INFO - Running post-run listener: _upload_blobber_files 09:06:30 INFO - Blob upload gear active. 09:06:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:06:30 INFO - Copying logs to upload dir... 09:06:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.105892 ========= master_lag: 4.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-21 09:06:35.025899) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:06:35.029059) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008827 build_url: 'https://queue.taskcluster.net/v1/task/sEc5pVHTQVKIZoJIlWwiZQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.06 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:06:35.099460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:06:35.099996) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453394729.243172-1904829934 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:06:35.276586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:06:35.276981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:06:35.277433) ========= ========= Total master_lag: 4.51 =========