builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1453336452.6 results: success (0) buildid: 20160120141227 builduid: 82cd0a92b2094cfc9694cc43819f8a42 revision: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.596250) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.596655) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.596948) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006422 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.626467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.626818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.665757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.666103) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.719281) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.719542) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.720180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.720449) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 16:34:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2016-01-20 16:34:13 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.834223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.834524) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022160 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.888140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:12.888688) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 16:34:13,266 truncating revision to first 12 chars 2016-01-20 16:34:13,266 Setting DEBUG logging. 2016-01-20 16:34:13,266 attempt 1/10 2016-01-20 16:34:13,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7fc6b3d4c26f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 16:34:13,556 unpacking tar archive at: mozilla-aurora-7fc6b3d4c26f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.469525) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.469911) ========= echo 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 program finished with exit code 0 elapsedTime=0.003905 script_repo_revision: '7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.520377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.520692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.533788) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.534053) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 16:34:13.534404) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 5 secs) (at 2016-01-20 16:34:13.534679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:34:14 INFO - MultiFileLogger online at 20160120 16:34:14 in /builds/slave/test-pgo 16:34:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:34:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:34:14 INFO - {'append_to_log': False, 16:34:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:34:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:34:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:34:14 INFO - 'branch': 'Mozilla-Aurora', 16:34:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:14 INFO - 'config_files': ('talos/linux_config.py',), 16:34:14 INFO - 'default_actions': ('clobber', 16:34:14 INFO - 'read-buildbot-config', 16:34:14 INFO - 'download-and-extract', 16:34:14 INFO - 'populate-webroot', 16:34:14 INFO - 'create-virtualenv', 16:34:14 INFO - 'install', 16:34:14 INFO - 'run-tests'), 16:34:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:14 INFO - 'download_minidump_stackwalk': True, 16:34:14 INFO - 'download_symbols': 'ondemand', 16:34:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:14 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:14 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:14 INFO - 'installer_path': 'installer.exe', 16:34:14 INFO - 'log_level': 'info', 16:34:14 INFO - 'log_name': 'talos', 16:34:14 INFO - 'log_to_console': True, 16:34:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:34:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:34:14 INFO - 'opt_config_files': (), 16:34:14 INFO - 'pip_index': False, 16:34:14 INFO - 'sps_profile': False, 16:34:14 INFO - 'sps_profile_interval': 0, 16:34:14 INFO - 'suite': 'dromaeojs-e10s', 16:34:14 INFO - 'system_bits': '32', 16:34:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:14 INFO - 'title': 'talos-linux64-ix-056', 16:34:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:14 INFO - 'use_talos_json': True, 16:34:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:34:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:14 INFO - 'work_dir': 'build'} 16:34:14 INFO - ##### 16:34:14 INFO - ##### Running clobber step. 16:34:14 INFO - ##### 16:34:14 INFO - Running pre-action listener: _resource_record_pre_action 16:34:14 INFO - Running main action method: clobber 16:34:14 INFO - rmtree: /builds/slave/test-pgo/build 16:34:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:34:14 INFO - Running post-action listener: _resource_record_post_action 16:34:14 INFO - ##### 16:34:14 INFO - ##### Running read-buildbot-config step. 16:34:14 INFO - ##### 16:34:14 INFO - Running pre-action listener: _resource_record_pre_action 16:34:14 INFO - Running main action method: read_buildbot_config 16:34:14 INFO - Using buildbot properties: 16:34:14 INFO - { 16:34:14 INFO - "properties": { 16:34:14 INFO - "buildnumber": 65, 16:34:14 INFO - "product": "firefox", 16:34:14 INFO - "script_repo_revision": "production", 16:34:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:34:14 INFO - "repository": "", 16:34:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:34:14 INFO - "buildid": "20160120141227", 16:34:14 INFO - "slavename": "talos-linux64-ix-056", 16:34:14 INFO - "pgo_build": "True", 16:34:14 INFO - "basedir": "/builds/slave/test-pgo", 16:34:14 INFO - "project": "", 16:34:14 INFO - "platform": "ubuntu64_hw", 16:34:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:34:14 INFO - "slavebuilddir": "test", 16:34:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:34:14 INFO - "branch": "mozilla-aurora", 16:34:14 INFO - "repo_path": "releases/mozilla-aurora", 16:34:14 INFO - "stage_platform": "linux64-pgo", 16:34:14 INFO - "builduid": "82cd0a92b2094cfc9694cc43819f8a42", 16:34:14 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 16:34:14 INFO - }, 16:34:14 INFO - "sourcestamp": { 16:34:14 INFO - "repository": "", 16:34:14 INFO - "hasPatch": false, 16:34:14 INFO - "project": "", 16:34:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:34:14 INFO - "changes": [ 16:34:14 INFO - { 16:34:14 INFO - "category": null, 16:34:14 INFO - "files": [ 16:34:14 INFO - { 16:34:14 INFO - "url": null, 16:34:14 INFO - "name": "https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:34:14 INFO - } 16:34:14 INFO - ], 16:34:14 INFO - "repository": "", 16:34:14 INFO - "rev": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7", 16:34:14 INFO - "who": "kwierso@gmail.com", 16:34:14 INFO - "when": 1453336405, 16:34:14 INFO - "number": 7489532, 16:34:14 INFO - "comments": "Bug 1221976 - Use -moz-appearance:none on textarea and input elements in mochitest test_input_textarea_set_value_no_scroll.html to work around unreliable Gtk3 themed-widget rendering. r=dholbert a=testonly", 16:34:14 INFO - "project": "", 16:34:14 INFO - "at": "Wed 20 Jan 2016 16:33:25", 16:34:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:34:14 INFO - "revlink": "", 16:34:14 INFO - "properties": [ 16:34:14 INFO - [ 16:34:14 INFO - "buildid", 16:34:14 INFO - "20160120141227", 16:34:14 INFO - "Change" 16:34:14 INFO - ], 16:34:14 INFO - [ 16:34:14 INFO - "builduid", 16:34:14 INFO - "82cd0a92b2094cfc9694cc43819f8a42", 16:34:14 INFO - "Change" 16:34:14 INFO - ], 16:34:14 INFO - [ 16:34:14 INFO - "pgo_build", 16:34:14 INFO - "True", 16:34:14 INFO - "Change" 16:34:14 INFO - ] 16:34:14 INFO - ], 16:34:14 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 16:34:14 INFO - } 16:34:14 INFO - ], 16:34:14 INFO - "revision": "7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7" 16:34:14 INFO - } 16:34:14 INFO - } 16:34:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:34:14 INFO - Running post-action listener: _resource_record_post_action 16:34:14 INFO - ##### 16:34:14 INFO - ##### Running download-and-extract step. 16:34:14 INFO - ##### 16:34:14 INFO - Running pre-action listener: _resource_record_pre_action 16:34:14 INFO - Running main action method: download_and_extract 16:34:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:34:14 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')]} 16:34:14 INFO - https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:34:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/test_packages.json 16:34:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/test_packages.json 16:34:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:34:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:34:17 INFO - Downloaded 1302 bytes. 16:34:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:34:17 INFO - Using the following test package requirements: 16:34:17 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:34:17 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:34:17 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'jsshell-linux-x86_64.zip'], 16:34:17 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:34:17 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:34:17 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:34:17 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:34:17 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:34:17 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:34:17 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:34:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:34:17 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:34:17 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')]} 16:34:17 INFO - https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:34:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:18 INFO - Downloaded 23160445 bytes. 16:34:18 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 16:34:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:18 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 16:34:19 INFO - Return code: 0 16:34:19 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 16:34: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')]} 16:34:19 INFO - https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:25 INFO - Downloaded 23160445 bytes. 16:34:25 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 16:34:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:34:25 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 16:34:26 INFO - Return code: 0 16:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:26 INFO - https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:34:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:34:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:34:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:27 INFO - Downloaded 11132038 bytes. 16:34:27 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 16:34:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:34:27 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 16:34:27 INFO - Return code: 0 16:34:27 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')]} 16:34:27 INFO - https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:34:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:34:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:34:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0_COgSGkRpqoUMIimGVM8Q/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 16:34:29 INFO - Downloaded 58130506 bytes. 16:34:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:34:29 INFO - mkdir: /builds/slave/test-pgo/properties 16:34:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:34:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:34:29 INFO - Contents: 16:34:29 INFO - build_url:https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:34:29 INFO - Running post-action listener: _resource_record_post_action 16:34:29 INFO - Running post-action listener: set_extra_try_arguments 16:34:29 INFO - ##### 16:34:29 INFO - ##### Running populate-webroot step. 16:34:29 INFO - ##### 16:34:29 INFO - Running pre-action listener: _resource_record_pre_action 16:34:29 INFO - Running main action method: populate_webroot 16:34:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:34:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:34:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:34:29 INFO - '--tppagecycles', 16:34:29 INFO - '7'], 16:34:29 INFO - 'tests': ['tsvgm']}}, 16:34:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:34:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:34:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:34:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:34:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'tests': ['damp', 'tps']}, 16:34:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['damp', 'tps']}, 16:34:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:34:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:34:29 INFO - 'other': {'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'other_l64': {'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'other_nol64': {'tests': ['a11yr', 16:34:29 INFO - 'ts_paint', 16:34:29 INFO - 'tpaint', 16:34:29 INFO - 'sessionrestore', 16:34:29 INFO - 'sessionrestore_no_auto_restore']}, 16:34:29 INFO - 'svgr': {'tests': ['tsvgx', 16:34:29 INFO - 'tsvgr_opacity', 16:34:29 INFO - 'tart', 16:34:29 INFO - 'tscrollx', 16:34:29 INFO - 'cart']}, 16:34:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['tsvgx', 16:34:29 INFO - 'tsvgr_opacity', 16:34:29 INFO - 'tart', 16:34:29 INFO - 'tscrollx', 16:34:29 INFO - 'cart']}, 16:34:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'tests': ['tp5o']}, 16:34:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'talos_options': ['--e10s'], 16:34:29 INFO - 'tests': ['tp5o']}, 16:34:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'talos_options': ['--xperf_path', 16:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:29 INFO - 'tests': ['tp5n']}, 16:34:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:34:29 INFO - 'talos_options': ['--e10s', 16:34:29 INFO - '--xperf_path', 16:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:34:29 INFO - 'tests': ['tp5n']}}, 16:34:29 INFO - 'talos.zip': {'path': '', 16:34:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:34:29 INFO - Running post-action listener: _resource_record_post_action 16:34:29 INFO - ##### 16:34:29 INFO - ##### Running create-virtualenv step. 16:34:29 INFO - ##### 16:34:29 INFO - Running pre-action listener: _resource_record_pre_action 16:34:29 INFO - Running main action method: create_virtualenv 16:34:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:34:29 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 16:34:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:34:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:34:29 INFO - Using real prefix '/usr' 16:34:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:34:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:34:32 INFO - Installing pip.................done. 16:34:32 INFO - Return code: 0 16:34:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:34: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')]} 16:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:32 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:32 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 16:34:32 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 16:34:32 INFO - Using env: {'DISPLAY': ':0', 16:34:32 INFO - 'HOME': '/home/cltbld', 16:34:32 INFO - 'LANG': 'en_US.UTF-8', 16:34:32 INFO - 'LANGUAGE': 'en_US:en', 16:34:32 INFO - 'LOGNAME': 'cltbld', 16:34:32 INFO - 'MAIL': '/var/mail/cltbld', 16:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:32 INFO - 'MOZ_NO_REMOTE': '1', 16:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:32 INFO - 'NO_EM_RESTART': '1', 16:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:32 INFO - 'SHELL': '/bin/bash', 16:34:32 INFO - 'SHLVL': '1', 16:34:32 INFO - 'TERM': 'linux', 16:34:32 INFO - 'TMOUT': '86400', 16:34:32 INFO - 'USER': 'cltbld', 16:34:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:32 INFO - '_': '/tools/buildbot/bin/python'} 16:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:32 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 16:34:32 INFO - Cleaning up... 16:34:32 INFO - Return code: 0 16:34:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:34: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')]} 16:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:32 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:32 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 16:34:32 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 16:34:32 INFO - Using env: {'DISPLAY': ':0', 16:34:32 INFO - 'HOME': '/home/cltbld', 16:34:32 INFO - 'LANG': 'en_US.UTF-8', 16:34:32 INFO - 'LANGUAGE': 'en_US:en', 16:34:32 INFO - 'LOGNAME': 'cltbld', 16:34:32 INFO - 'MAIL': '/var/mail/cltbld', 16:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:32 INFO - 'MOZ_NO_REMOTE': '1', 16:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:32 INFO - 'NO_EM_RESTART': '1', 16:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:32 INFO - 'SHELL': '/bin/bash', 16:34:32 INFO - 'SHLVL': '1', 16:34:32 INFO - 'TERM': 'linux', 16:34:32 INFO - 'TMOUT': '86400', 16:34:32 INFO - 'USER': 'cltbld', 16:34:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:32 INFO - '_': '/tools/buildbot/bin/python'} 16:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:32 INFO - Downloading/unpacking psutil>=0.7.1 16:34:32 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 16:34:32 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 16:34:32 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 16:34:32 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 16:34:32 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 16:34:32 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 16:34:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:34 INFO - Installing collected packages: psutil 16:34:34 INFO - Running setup.py install for psutil 16:34:34 INFO - building 'psutil._psutil_linux' extension 16:34:34 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 16:34:34 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 16:34:34 INFO - building 'psutil._psutil_posix' extension 16:34:34 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 16:34:34 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 16:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:34:34 INFO - Successfully installed psutil 16:34:34 INFO - Cleaning up... 16:34:34 INFO - Return code: 0 16:34:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:34: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')]} 16:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:34 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:34 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 16:34:34 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 16:34:34 INFO - Using env: {'DISPLAY': ':0', 16:34:34 INFO - 'HOME': '/home/cltbld', 16:34:34 INFO - 'LANG': 'en_US.UTF-8', 16:34:34 INFO - 'LANGUAGE': 'en_US:en', 16:34:34 INFO - 'LOGNAME': 'cltbld', 16:34:34 INFO - 'MAIL': '/var/mail/cltbld', 16:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:34 INFO - 'MOZ_NO_REMOTE': '1', 16:34:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:34 INFO - 'NO_EM_RESTART': '1', 16:34:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:34 INFO - 'SHELL': '/bin/bash', 16:34:34 INFO - 'SHLVL': '1', 16:34:34 INFO - 'TERM': 'linux', 16:34:34 INFO - 'TMOUT': '86400', 16:34:34 INFO - 'USER': 'cltbld', 16:34:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:34 INFO - '_': '/tools/buildbot/bin/python'} 16:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:34:35 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 16:34:35 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 16:34:35 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 16:34:35 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 16:34:35 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 16:34:35 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 16:34:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:34:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:34:37 INFO - Installing collected packages: mozsystemmonitor 16:34:37 INFO - Running setup.py install for mozsystemmonitor 16:34:37 INFO - Successfully installed mozsystemmonitor 16:34:37 INFO - Cleaning up... 16:34:37 INFO - Return code: 0 16:34:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:37 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:37 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 16:34:37 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 16:34:37 INFO - Using env: {'DISPLAY': ':0', 16:34:37 INFO - 'HOME': '/home/cltbld', 16:34:37 INFO - 'LANG': 'en_US.UTF-8', 16:34:37 INFO - 'LANGUAGE': 'en_US:en', 16:34:37 INFO - 'LOGNAME': 'cltbld', 16:34:37 INFO - 'MAIL': '/var/mail/cltbld', 16:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:37 INFO - 'MOZ_NO_REMOTE': '1', 16:34:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:37 INFO - 'NO_EM_RESTART': '1', 16:34:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:37 INFO - 'SHELL': '/bin/bash', 16:34:37 INFO - 'SHLVL': '1', 16:34:37 INFO - 'TERM': 'linux', 16:34:37 INFO - 'TMOUT': '86400', 16:34:37 INFO - 'USER': 'cltbld', 16:34:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:37 INFO - '_': '/tools/buildbot/bin/python'} 16:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:34:37 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 16:34:37 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 16:34:37 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 16:34:37 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 16:34:37 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 16:34:37 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 16:34:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:34:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:34:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 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 16:34:39 INFO - Downloading docopt-0.6.1.tar.gz 16:34:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:34:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:34:39 INFO - Running setup.py install for blobuploader 16:34:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:34:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:34:39 INFO - Running setup.py install for requests 16:34:40 INFO - Running setup.py install for docopt 16:34:40 INFO - Successfully installed blobuploader requests docopt 16:34:40 INFO - Cleaning up... 16:34:40 INFO - Return code: 0 16:34:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:40 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:40 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 16:34:40 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 16:34:40 INFO - Using env: {'DISPLAY': ':0', 16:34:40 INFO - 'HOME': '/home/cltbld', 16:34:40 INFO - 'LANG': 'en_US.UTF-8', 16:34:40 INFO - 'LANGUAGE': 'en_US:en', 16:34:40 INFO - 'LOGNAME': 'cltbld', 16:34:40 INFO - 'MAIL': '/var/mail/cltbld', 16:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:40 INFO - 'MOZ_NO_REMOTE': '1', 16:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:40 INFO - 'NO_EM_RESTART': '1', 16:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:40 INFO - 'SHELL': '/bin/bash', 16:34:40 INFO - 'SHLVL': '1', 16:34:40 INFO - 'TERM': 'linux', 16:34:40 INFO - 'TMOUT': '86400', 16:34:40 INFO - 'USER': 'cltbld', 16:34:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:40 INFO - '_': '/tools/buildbot/bin/python'} 16:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:34:40 INFO - Running setup.py (path:/tmp/pip-QWCs_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:34:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:34:40 INFO - Running setup.py (path:/tmp/pip-vMVDHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:34:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:34:40 INFO - Running setup.py (path:/tmp/pip-todxmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:34:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:34:40 INFO - Running setup.py (path:/tmp/pip-qcltjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:34:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:34:40 INFO - Running setup.py (path:/tmp/pip-50oiVT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:34:41 INFO - Running setup.py (path:/tmp/pip-XZ7VXX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:34:41 INFO - Running setup.py (path:/tmp/pip-33agLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:34:41 INFO - Running setup.py (path:/tmp/pip-zjgF1M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:34:41 INFO - Running setup.py (path:/tmp/pip-qD8TfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:34:41 INFO - Running setup.py (path:/tmp/pip-5khjfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:34:41 INFO - Running setup.py (path:/tmp/pip-iUiJXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:34:41 INFO - Running setup.py (path:/tmp/pip-t46CmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:34:41 INFO - Running setup.py (path:/tmp/pip-PuU3DP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:34:41 INFO - Running setup.py (path:/tmp/pip-EQtlkD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:34:41 INFO - Running setup.py (path:/tmp/pip-LZeH2V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:34:41 INFO - Running setup.py (path:/tmp/pip-a7a98a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:34:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:34:41 INFO - Running setup.py (path:/tmp/pip-msMQvQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:34:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:34:41 INFO - Running setup.py install for manifestparser 16:34:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for mozcrash 16:34:42 INFO - Running setup.py install for mozdebug 16:34:42 INFO - Running setup.py install for mozdevice 16:34:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for mozfile 16:34:42 INFO - Running setup.py install for mozhttpd 16:34:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for mozinfo 16:34:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for mozInstall 16:34:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for mozleak 16:34:42 INFO - Running setup.py install for mozlog 16:34:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:34:42 INFO - Running setup.py install for moznetwork 16:34:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Running setup.py install for mozprocess 16:34:43 INFO - Running setup.py install for mozprofile 16:34:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Running setup.py install for mozrunner 16:34:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Running setup.py install for mozscreenshot 16:34:43 INFO - Running setup.py install for moztest 16:34:43 INFO - Running setup.py install for mozversion 16:34:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:34:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:34:43 INFO - Cleaning up... 16:34:43 INFO - Return code: 0 16:34:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:34: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')]} 16:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34: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')]} 16:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:43 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:43 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 16:34:43 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 16:34:43 INFO - Using env: {'DISPLAY': ':0', 16:34:43 INFO - 'HOME': '/home/cltbld', 16:34:43 INFO - 'LANG': 'en_US.UTF-8', 16:34:43 INFO - 'LANGUAGE': 'en_US:en', 16:34:43 INFO - 'LOGNAME': 'cltbld', 16:34:43 INFO - 'MAIL': '/var/mail/cltbld', 16:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:43 INFO - 'MOZ_NO_REMOTE': '1', 16:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:43 INFO - 'NO_EM_RESTART': '1', 16:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:43 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:43 INFO - 'SHELL': '/bin/bash', 16:34:43 INFO - 'SHLVL': '1', 16:34:43 INFO - 'TERM': 'linux', 16:34:43 INFO - 'TMOUT': '86400', 16:34:43 INFO - 'USER': 'cltbld', 16:34:43 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:43 INFO - '_': '/tools/buildbot/bin/python'} 16:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:34:43 INFO - Running setup.py (path:/tmp/pip-nNtexD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:34:44 INFO - Running setup.py (path:/tmp/pip-hlvaGe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:34:44 INFO - Running setup.py (path:/tmp/pip-_j8xD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:34:44 INFO - Running setup.py (path:/tmp/pip-acYVBu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:34:44 INFO - Running setup.py (path:/tmp/pip-6GrnPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:34:44 INFO - Running setup.py (path:/tmp/pip-wIKskZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:34:44 INFO - Running setup.py (path:/tmp/pip-jxo53O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:34:44 INFO - Running setup.py (path:/tmp/pip-NUllOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:34:44 INFO - Running setup.py (path:/tmp/pip-4IA2CQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:34:44 INFO - Running setup.py (path:/tmp/pip-ElO_Ik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:34:44 INFO - Running setup.py (path:/tmp/pip-Sb8Zua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:34:44 INFO - Running setup.py (path:/tmp/pip-2KDrC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:34:44 INFO - Running setup.py (path:/tmp/pip-bjEHPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:34:44 INFO - Running setup.py (path:/tmp/pip-jDgoBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:34:44 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)) 16:34:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:34:44 INFO - Running setup.py (path:/tmp/pip-d4ULn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:34:45 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)) 16:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:34:45 INFO - Running setup.py (path:/tmp/pip-rOUiDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:34:45 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)) 16:34:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:34:45 INFO - Running setup.py (path:/tmp/pip-mYWaUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:34:45 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)) 16:34:45 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)) 16:34:45 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)) 16:34:45 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)) 16:34:45 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)) 16:34:45 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)) 16:34:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:34:45 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 16:34:45 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 16:34:45 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 16:34:45 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 16:34:45 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 16:34:45 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 16:34:46 INFO - Downloading blessings-1.6.tar.gz 16:34:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:34:46 INFO - Installing collected packages: blessings 16:34:46 INFO - Running setup.py install for blessings 16:34:47 INFO - Successfully installed blessings 16:34:47 INFO - Cleaning up... 16:34:47 INFO - Return code: 0 16:34:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:34:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:34:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:34:47 INFO - Reading from file tmpfile_stdout 16:34:47 INFO - Current package versions: 16:34:47 INFO - argparse == 1.2.1 16:34:47 INFO - blessings == 1.6 16:34:47 INFO - blobuploader == 1.2.4 16:34:47 INFO - docopt == 0.6.1 16:34:47 INFO - manifestparser == 1.1 16:34:47 INFO - mozInstall == 1.12 16:34:47 INFO - mozcrash == 0.16 16:34:47 INFO - mozdebug == 0.1 16:34:47 INFO - mozdevice == 0.47 16:34:47 INFO - mozfile == 1.2 16:34:47 INFO - mozhttpd == 0.7 16:34:47 INFO - mozinfo == 0.9 16:34:47 INFO - mozleak == 0.1 16:34:47 INFO - mozlog == 3.1 16:34:47 INFO - moznetwork == 0.27 16:34:47 INFO - mozprocess == 0.22 16:34:47 INFO - mozprofile == 0.27 16:34:47 INFO - mozrunner == 6.11 16:34:47 INFO - mozscreenshot == 0.1 16:34:47 INFO - mozsystemmonitor == 0.0 16:34:47 INFO - moztest == 0.7 16:34:47 INFO - mozversion == 1.4 16:34:47 INFO - psutil == 3.1.1 16:34:47 INFO - requests == 1.2.3 16:34:47 INFO - wsgiref == 0.1.2 16:34:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:34:47 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')]} 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:47 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')]} 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:47 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:47 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 16:34:47 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 16:34:47 INFO - Using env: {'DISPLAY': ':0', 16:34:47 INFO - 'HOME': '/home/cltbld', 16:34:47 INFO - 'LANG': 'en_US.UTF-8', 16:34:47 INFO - 'LANGUAGE': 'en_US:en', 16:34:47 INFO - 'LOGNAME': 'cltbld', 16:34:47 INFO - 'MAIL': '/var/mail/cltbld', 16:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:47 INFO - 'MOZ_NO_REMOTE': '1', 16:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:47 INFO - 'NO_EM_RESTART': '1', 16:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:47 INFO - 'SHELL': '/bin/bash', 16:34:47 INFO - 'SHLVL': '1', 16:34:47 INFO - 'TERM': 'linux', 16:34:47 INFO - 'TMOUT': '86400', 16:34:47 INFO - 'USER': 'cltbld', 16:34:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:47 INFO - '_': '/tools/buildbot/bin/python'} 16:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 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)) 16:34:47 INFO - Cleaning up... 16:34:47 INFO - Return code: 0 16:34:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:34:47 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')]} 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:47 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')]} 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:47 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 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:47 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 16:34:47 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 16:34:47 INFO - Using env: {'DISPLAY': ':0', 16:34:47 INFO - 'HOME': '/home/cltbld', 16:34:47 INFO - 'LANG': 'en_US.UTF-8', 16:34:47 INFO - 'LANGUAGE': 'en_US:en', 16:34:47 INFO - 'LOGNAME': 'cltbld', 16:34:47 INFO - 'MAIL': '/var/mail/cltbld', 16:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:47 INFO - 'MOZ_NO_REMOTE': '1', 16:34:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:47 INFO - 'NO_EM_RESTART': '1', 16:34:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:47 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:47 INFO - 'SHELL': '/bin/bash', 16:34:47 INFO - 'SHLVL': '1', 16:34:47 INFO - 'TERM': 'linux', 16:34:47 INFO - 'TMOUT': '86400', 16:34:47 INFO - 'USER': 'cltbld', 16:34:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:47 INFO - '_': '/tools/buildbot/bin/python'} 16:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:47 INFO - Downloading/unpacking jsonschema 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:34:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:34:49 INFO - Downloading/unpacking functools32 (from jsonschema) 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:34:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:34:49 INFO - warning: no files found matching '*.txt' 16:34:49 INFO - no previously-included directories found matching 'build' 16:34:49 INFO - no previously-included directories found matching 'dist' 16:34:49 INFO - no previously-included directories found matching '.git*' 16:34:49 INFO - Installing collected packages: jsonschema, functools32 16:34:49 INFO - Running setup.py install for functools32 16:34:50 INFO - warning: no files found matching '*.txt' 16:34:50 INFO - no previously-included directories found matching 'build' 16:34:50 INFO - no previously-included directories found matching 'dist' 16:34:50 INFO - no previously-included directories found matching '.git*' 16:34:50 INFO - Successfully installed jsonschema functools32 16:34:50 INFO - Cleaning up... 16:34:50 INFO - Return code: 0 16:34:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdb71cbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a15450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, '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': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', '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 16:34:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:34:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:34:50 INFO - Using env: {'DISPLAY': ':0', 16:34:50 INFO - 'HOME': '/home/cltbld', 16:34:50 INFO - 'LANG': 'en_US.UTF-8', 16:34:50 INFO - 'LANGUAGE': 'en_US:en', 16:34:50 INFO - 'LOGNAME': 'cltbld', 16:34:50 INFO - 'MAIL': '/var/mail/cltbld', 16:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:50 INFO - 'MOZ_NO_REMOTE': '1', 16:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:50 INFO - 'NO_EM_RESTART': '1', 16:34:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:34:50 INFO - 'PWD': '/builds/slave/test-pgo', 16:34:50 INFO - 'SHELL': '/bin/bash', 16:34:50 INFO - 'SHLVL': '1', 16:34:50 INFO - 'TERM': 'linux', 16:34:50 INFO - 'TMOUT': '86400', 16:34:50 INFO - 'USER': 'cltbld', 16:34:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:50 INFO - '_': '/tools/buildbot/bin/python'} 16:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:34:50 INFO - Downloading/unpacking flake8 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34: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 16:34:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:34:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:34:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 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 16:34:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:34:52 INFO - no previously-included directories found matching 'docs/_build' 16:34:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:34:52 INFO - Running setup.py install for pep8 16:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:34:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:34:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:34:52 INFO - no previously-included directories found matching 'docs/_build' 16:34:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:34:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:34:52 INFO - Cleaning up... 16:34:52 INFO - Return code: 0 16:34:52 INFO - Running post-action listener: _resource_record_post_action 16:34:52 INFO - Running post-action listener: _start_resource_monitoring 16:34:53 INFO - Starting resource monitoring. 16:34:53 INFO - ##### 16:34:53 INFO - ##### Running install step. 16:34:53 INFO - ##### 16:34:53 INFO - Running pre-action listener: _resource_record_pre_action 16:34:53 INFO - Running main action method: install 16:34:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:34:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:34:53 INFO - Reading from file tmpfile_stdout 16:34:53 INFO - Detecting whether we're running mozinstall >=1.0... 16:34:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:34:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:34:53 INFO - Reading from file tmpfile_stdout 16:34:53 INFO - Output received: 16:34:53 INFO - Usage: mozinstall [options] installer 16:34:53 INFO - Options: 16:34:53 INFO - -h, --help show this help message and exit 16:34:53 INFO - -d DEST, --destination=DEST 16:34:53 INFO - Directory to install application into. [default: 16:34:53 INFO - "/builds/slave/test-pgo"] 16:34:53 INFO - --app=APP Application being installed. [default: firefox] 16:34:53 INFO - mkdir: /builds/slave/test-pgo/build/application 16:34:53 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'] 16:34:53 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 16:35:07 INFO - Reading from file tmpfile_stdout 16:35:07 INFO - Output received: 16:35:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:35:07 INFO - Running post-action listener: _resource_record_post_action 16:35:07 INFO - ##### 16:35:07 INFO - ##### Running run-tests step. 16:35:07 INFO - ##### 16:35:07 INFO - Running pre-action listener: _resource_record_pre_action 16:35:07 INFO - Running main action method: run_tests 16:35:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:35:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:35:07 INFO - Python 2.7.3 16:35:07 INFO - Return code: 0 16:35:07 INFO - grabbing minidump binary from tooltool 16:35:07 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')]} 16:35:07 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 0x1aa7a50>, '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 0x1a13550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a139e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:35:07 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 16:35:07 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 16:35:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:35:07 INFO - Return code: 0 16:35:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:35:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:35:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:35:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:35:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:35:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:35:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:35:08 INFO - Return code: 0 16:35:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:35:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 16:35:08 INFO - Using env: {'DISPLAY': ':0', 16:35:08 INFO - 'HOME': '/home/cltbld', 16:35:08 INFO - 'LANG': 'en_US.UTF-8', 16:35:08 INFO - 'LANGUAGE': 'en_US:en', 16:35:08 INFO - 'LOGNAME': 'cltbld', 16:35:08 INFO - 'MAIL': '/var/mail/cltbld', 16:35:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:35:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:08 INFO - 'MOZ_NO_REMOTE': '1', 16:35:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:35:08 INFO - 'NO_EM_RESTART': '1', 16:35:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:35:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:35:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:35:08 INFO - 'SHELL': '/bin/bash', 16:35:08 INFO - 'SHLVL': '1', 16:35:08 INFO - 'TERM': 'linux', 16:35:08 INFO - 'TMOUT': '86400', 16:35:08 INFO - 'USER': 'cltbld', 16:35:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1453334567.187015-306003937', 16:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:08 INFO - '_': '/tools/buildbot/bin/python'} 16:35:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 16:35:09 INFO - mozversion INFO | application_buildid: 20160120141227 16:35:09 INFO - mozversion INFO | application_changeset: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 16:35:09 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:35:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:35:09 INFO - mozversion INFO | application_name: Firefox 16:35:09 INFO - mozversion INFO | application_remotingname: firefox-dev 16:35:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:35:09 INFO - mozversion INFO | application_vendor: Mozilla 16:35:09 INFO - mozversion INFO | application_version: 45.0a2 16:35:09 INFO - mozversion INFO | platform_buildid: 20160120141227 16:35:09 INFO - mozversion INFO | platform_changeset: 7fc6b3d4c26f654144e4c7b90702b91f3ad31ea7 16:35:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:35:09 INFO - mozversion INFO | platform_version: 45.0a2 16:35:09 INFO - 2016-01-20 16:35:09,099 DEBUG : using testdate: 1453336509 16:35:09 INFO - 2016-01-20 16:35:09,100 DEBUG : actual date: 1453336509 16:35:09 INFO - 2016-01-20 16:35:09,146 INFO : starting webserver on 'localhost:55634' 16:35:09 INFO - 2016-01-20 16:35:09,148 INFO : Starting test suite talos-linux64-ix-056.e 16:35:09 INFO - 2016-01-20 16:35:09,148 INFO : Starting test dromaeo_css 16:35:09 INFO - 2016-01-20 16:35:09,148 DEBUG : operating with platform_type : linux_ 16:35:09 INFO - 2016-01-20 16:35:09,148 INFO : Initialising browser for dromaeo_css test... 16:35:09 INFO - 2016-01-20 16:35:09,165 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv_wMZA/profile http://localhost:55634/getInfo.html 16:35:13 INFO - 2016-01-20 16:35:13,012 DEBUG : BROWSER_OUTPUT: 16:35:13 INFO - 2016-01-20 16:35:13,012 DEBUG : BROWSER_OUTPUT: (process:3888): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:35:13 INFO - 2016-01-20 16:35:13,855 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:35:13 INFO - 2016-01-20 16:35:13,856 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:35:13 INFO - 2016-01-20 16:35:13,856 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:35:13 INFO - 2016-01-20 16:35:13,856 DEBUG : BROWSER_OUTPUT: __metrics 16:35:14 INFO - 2016-01-20 16:35:14,757 INFO : Browser initialized. 16:35:14 INFO - 2016-01-20 16:35:14,758 INFO : Running cycle 1/1 for dromaeo_css test... 16:35:14 INFO - 2016-01-20 16:35:14,758 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv_wMZA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:35:16 INFO - 2016-01-20 16:35:16,091 DEBUG : BROWSER_OUTPUT: 16:35:16 INFO - 2016-01-20 16:35:16,091 DEBUG : BROWSER_OUTPUT: (process:4005): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:35:26 INFO - 2016-01-20 16:35:26,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 136425472 16:35:26 INFO - 2016-01-20 16:35:26,595 DEBUG : BROWSER_OUTPUT: 16:36:16 INFO - 2016-01-20 16:36:16,184 DEBUG : BROWSER_OUTPUT: 1453336576182 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] 16:38:23 INFO - 2016-01-20 16:38:23,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55634/tests/dromaeo/cssquery-ext.html) 16:38:24 INFO - 2016-01-20 16:38:24,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 141361152 16:38:24 INFO - 2016-01-20 16:38:24,955 DEBUG : BROWSER_OUTPUT: 16:41:26 INFO - 2016-01-20 16:41:26,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-ext.html (next: http://localhost:55634/tests/dromaeo/cssquery-jquery.html) 16:41:27 INFO - 2016-01-20 16:41:27,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 139378688 16:41:27 INFO - 2016-01-20 16:41:27,229 DEBUG : BROWSER_OUTPUT: 16:44:28 INFO - 2016-01-20 16:44:28,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55634/tests/dromaeo/cssquery-mootools.html) 16:44:29 INFO - 2016-01-20 16:44:29,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 138174464 16:44:29 INFO - 2016-01-20 16:44:29,430 DEBUG : BROWSER_OUTPUT: 16:47:30 INFO - 2016-01-20 16:47:30,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55634/tests/dromaeo/cssquery-prototype.html) 16:47:31 INFO - 2016-01-20 16:47:31,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 139644928 16:47:31 INFO - 2016-01-20 16:47:31,566 DEBUG : BROWSER_OUTPUT: 16:50:33 INFO - 2016-01-20 16:50:33,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55634/tests/dromaeo/cssquery-yui.html) 16:50:34 INFO - 2016-01-20 16:50:34,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 140115968 16:50:34 INFO - 2016-01-20 16:50:34,464 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/dromaeo/cssquery-yui.html (next: http://localhost:55634/tests/dromaeo/cssquery-dojo.html) 16:53:36 INFO - 2016-01-20 16:53:36,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 16:53:36 INFO - 2016-01-20 16:53:36,611 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,612 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:53:36 INFO - 2016-01-20 16:53:36,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:53:36 INFO - 2016-01-20 16:53:36,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:53:36 INFO - 2016-01-20 16:53:36,613 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:53:36 INFO - 2016-01-20 16:53:36,614 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3215.276562773376;3219.905232221046;3252.2682396460814;3281.048495936178;3285.1622836176784;5437.53780928621;5482.479164479378;5494.7527361268785;5523.6409633373805;5587.05020146575;5472.315960504937;5537.723113844312;5553.750081246343;5564.749586268617;5604.579656525756;5045.117104506706;5075.340205773245;5082.16144336186;5104.77028533715;5125.231215317714;5078.136716758141;5079.669821461612;5230.660007099526;5278.788848446057;5300;5018.322526458936;5091.694498330094;5142.845714628567;5159.019786240621;5227.47725227478;5218.086834803932;5228.947710522903;5240.502152295545;5244.711540865251;5277.577793776489;4864.173090574611;4866.3673722416215;5015.247712843066;5114.130597798383;5135.563477104451;5318.5213330800025;5370.3287089113865;5393.514583687448;5407.297051383334;5444.836654900319;5914.260717410324;5945.910811337833;5948.345681974979;5948.613340132878;6032.42691944269;5951.137085122677;6028.668423236721;6057.787977420813;6076.301225359096;6083.878322433571;5558.722063896789;5571.387147413781;5574.693391863446;5585.3297604287745;5611.523020543259;5943.286805583271;5980.760769569256;6018.398160183947;6025.6685882276015;6136.29432615255;5826.300843898674;5836.1245813127525;5838.153467747238;5847.093700476433;5856.472917437451;5809.535237181015;5829.067349224104;5897.5871688982215;6030.487408570233;6058.1518587397795;5859.736311865891;5892.970535147297;5913.58604897653;5926.703664816742;5927.407259274124;5874.295084589877;5945.019071853182;5958.553108516879;5962.701864906738;5974.133750606138;4541.364209010741;4570.65720070996;4571.131485017836;4626.722396656144;4632.722036677743;4114.177164567099;4120.649744771728;4123.175364927027;4151.46031015966;4153.709240353207;5433.0763770159165;5809.8547536311935;5810.331811841608;5813.680247586339;5823.155642431909;5984.850378740566;6125.082842094287;6229.563930524911;6246.6876656167005;6253.812385628438;5814.563907706939;5815.73829177688;5826.547474465878;5853.707314634251;5900.64596124234;5249.737513124329;5288;5313.734313284321;5314.548263397577;5338.679679219259;6112.144299798032;6149;6167.321594624587;6183.598066125687;6240.219972503437;6033.064874944391;6191.628502289877;6199.225096862892;6201;6295.118683384421;6140;6196.194494715838;6246.437820596168;6293.874122517433;6326.2092238470195;5934.554908381975;5986.730597123227;6038.275406951194;6048.123022161674;6054.061620448838;6134.110553969738;6152.507799376129;6154.476869466145;6165.260168779596;6181.690915454119;5854.121881717776;5867.354590995073;5938.851528711817;5952.851178720567;5969.4627483524955;5926.940730592812;6022.608530445507;6037.516998640011;6044.365341639241;6052.092186172109;5900.822975310747;5919.763209471573;5920.052791553331;5921.082232254007;5940.079287710412;5816.796412125555;5930.52555795544;5937.406259374028;6024;6055.757769689163;5906.557008224487;5907.2911250650195;5918.674472904032;5922.644641321534;5942.049272116441 16:53:36 INFO - 2016-01-20 16:53:36,618 DEBUG : BROWSER_OUTPUT: |1;ext.html;598.488292509904;630.9495240380769;636.4621894499148;669.2704951602755;669.5079116849118;40798.18403631929;41073.7946310268;41364;41406.378904316385;41455.17089658209;44394.77802610982;44887;44956.3256551152;45070.09859802802;45164.548354516446;9083.50040747757;9211;9234.907650923506;9262;9283.303752218577;8944.463332200055;8984.640614375417;8998.28013758901;9039.27685785139;9045.864312035324;8901.154390332907;8909.376343655947;8941.95529022354;8972;9070.954645226764;8877.822443551126;8967.192952634294;9007.639694412248;9039.774005649879;9060.77348066297;8849.115088491164;8997.460152390811;9024.684136055206;9031.412958157698;9056.275497960147;41628.58371416277;41996.58003419988;42298;42351.788241058595;42367.788161059;3528.6118526962014;3533.5406397168204;3545.85816567337;3572.7856328620364;3600.0459878132315;31392.843035784903;32022.199445013826;32068;32119;32155;3604.098975256186;3652.4156135018534;3657.9085522861874;3714.4428335749585;3764.623537646241;281912;283262;283423;283837.99999999796;286972;44268;44467;44692.3296150558;44881.775591121834;45011.324830127574;42525.57474425278;42609.78695106505;42890.14219715651;43066.56933430626;43205;14909.776353354708;14964.251787410585;15059.849401506064;15096.924515377572;15104;12299.569515066929;12308.630741077783;12340.938295308466;12472;12705.809412858815;14964.625884352761;15049.699006019819;15078.321475533627;15109.39562417491;15185.240737963057;5929.792457264061;6086.756529738761;6098.54260930432;6111.938880611226;6164.349329788144;1006.8036732837173;1053.068034789217;1113.969578140217;1164.7554013657057;1196.2463647901766;33744.83127584346;33821.66178338185;34162.14594635154;34234.82882585571;34294.657053429146;1094.1738987064716;1094.87408947972;1150.2753265442884;1155.3299086529792;1198.3888217009214;15338.539843804481;15743.68512629741;17601.29594816193;17605.383811566535;17920.193591288422;435881;536901;537387;544388;838446;56827.14759278614;57630.42369576335;57734.422655772905;57867.710661447265;58048;1488.2186851903055;1490.4932323010228;1491.6121808329913;1501.4369611395728;1589.6343840916654;29965.70034299629;30053.69946300509;30947.226319342197;31109.68890311068;31237.375252494367;47558;48050.27924581064;48177.75911120422;48195;48377;331129;333336;334465;334781;334989;32939;33073;33474.49364778542;33587.49618755769;33769.83115084409;44321.33517997297;44618.553814462735;44762.10475790401;45309.32036019397;45796.77101614604;37054;37587;38196.23607527778;38514.614853851104;38771.6122838768;37970.721756694686;38127.23745525129;38152.61847381491;38301.23397531978;38883.222335552564;37643.43534846925;38282.61717382902;38370;38468.6153138465;38475;33169;33841.15397115092;33899;33932;34120.48819267663;25891.352716182246;26622.866885665448;26676.333091672088;26690.733092668826;26721.732782671923 16:53:36 INFO - 2016-01-20 16:53:36,618 DEBUG : BROWSER_OUTPUT: |2;jquery.html;386.65973942930236;392.1822999046987;392.397669577199;393.26655786957315;393.94484772131887;16196.75704864428;17027;18499.722504162433;20032.19871205152;20267.290644827433;12163.817542736844;12169.817452738194;12372.319522426264;12384.752304953896;12435;5021.422536408305;5179.2749015137915;5184.688918664892;5189.377274727038;5265.736713164346;5493.505584497394;5587.692676902769;5615.9157612635845;5625.8593535161535;5637;5370.140777475604;5499.092649712793;5585.134304182858;5590.804321848736;5593.664380137185;5432.076546987022;5445;5461.9453805462035;5467.589930755189;5477.780888764445;5157.793688252503;5308.124159513675;5324.1215199492035;5326.387465441447;5330.840074797762;13207.273599952;13235.338233088307;13238.205707657571;13385.66535836612;13537.52618658352;2211.5024119572968;2218.256883943881;2223.155201023617;2232.229880691159;2277.35095497784;10381.740456488647;10483.633072842415;10673.466326683712;12405.25568465886;12796.848283654423;1908.0841196225751;1939.94180174595;1962.8724132931313;1993.2126809910148;2030.2691031228746;65076.3492365075;67325;67835;68663.31336686619;68842.65578672074;10943.233973621771;11124.110071194285;11295.887041129483;11301.491432885376;11402.087832973508;14694;14748.262586870613;14801.555953321418;14814.777778333333;14860.851391486163;8267.586620668942;8331.583420828934;8388.412811103164;8426.452280601741;8454.66181352739;7897.960510197412;7934.087579928267;7964.2433968772875;7965.362770978308;7984.40116991228;4758.405199350082;4801.567858892717;4806.831760888422;4915.975420122948;4945.9258111128365;1990.7611086669692;1995.4013795861183;2014.6575082236054;2035.877847329165;2040.2858999350108;954.236610711428;1060.7666313411037;1067.380919066955;1070.7590792071878;1133.4785998440645;17294.394696185573;17383.91308043477;17610.64778704419;17784.110794460226;18825.152868120967;1002.8746406699163;1014.9035841595037;1023.1558963854701;1041.4063983529315;1069.7111779819404;10088.798224035625;10381.9480902595;10445.373277603368;10455.94772026135;10465.372077675363;607555;613631;616031;630544;637126;82245;83268.58365708133;85176.14823851806;85408.57295713606;86895;1188.5958774016876;1209.3469526455792;1209.661294837447;1213.805791073424;1217.7077501399776;16387.34450621962;16424.83575164233;16467.505974820775;16474.012845795445;16487;37907;38083.23833523369;38568.80715596404;38681.22637547177;38904.416433754086;50804.491955079975;51972;52060.73969630127;52761.736191320335;54932.45067549433;10074.597016119273;10383.117435018108;10418.791624167627;10550.630727924487;10564.84152737725;13617.727645446837;14166;17725.202365893823;18000.729989049913;18298.26806927708;14724;14819.33313000896;15496.767548486556;15709.45016924402;15876.285567149736;14868.851311486747;14910.77633835515;14980.625484362978;15609.141497217763;15748;15657.295421706278;15678.372865085268;15817;15981.280842362354;15982.200889955688;10149.898501014895;10508.947455262674;10572.41851698164;10765.515551800345;10935.45322733876;12421.813672795097;15967.920160399124;16102.43641472543;16310.532052115366;16321 16:53:36 INFO - 2016-01-20 16:53:36,619 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1592.004996876952;1606.863416609588;1643.3590899549174;1850.4448665400378;1911.789703132656;8414.410991230616;8531.95734021329;8639.481631102139;8716.477011379313;8760.561971901412;8700.129987001297;8756.430831995916;8761.649534018632;8785.253253473462;8803.911960880405;2444;2484.925452236436;2485.2420011896365;2493.127405408111;2494.6756921600168;2449.8775061246956;2503.2615378463397;2514.88683009265;2515.5723527000455;2520.243926821955;2381.2141993142222;2410.662507248978;2421.128393778238;2443.8778061096964;2455.656208130863;2396.424858034059;2409.578323793338;2415.070197973784;2417;2440.487497625492;2388.737238903719;2413.505231427553;2436.6710494083427;2441.206607852437;2444.8777561121874;8484.32125429964;8525.957370213171;8569.271611912995;8572;8612.655493780241;4891.510848915115;4955.4796746341835;4993.0263598598285;5016.824411145592;5018.197088465828;3168.3821654777325;3195.680431956786;3244.4160051190775;3254.3653987472453;3255.332656805373;987.0721521769585;998.1166667499243;999.9950000250025;1008.2841182760249;1027.363034918348;11915.344656043913;11926.522939082426;11983.400829958555;12022.27866328023;12075.033997280108;4333.458317710286;4368.126374725004;4396.472423309224;4408.316710909814;4457.710248833815;9587.616495340248;9589.808203836024;9671.90328096724;9688.806223875483;9730.805383892282;4982.128127577659;5010.699358038456;5038.748062596856;5061.34202553673;5061.44324124346;4563.520830312769;4650.09323181983;4651.186042442559;4652;4657.3246879202325;3517.120719820045;3587.1749497615697;3597.1546686528645;3613.403788374941;3625.818709064536;1136.4147464056018;1143.279733767721;1150.5397840863554;1151.7638884028754;1167.988320116805;1111.5442668506034;1127.656064900197;1185.324365111878;1350.473315406992;1403.9578812635636;7940.444168908121;7948.324392426708;8045.758627241192;8135.267825895698;8139.186081391814;1182.3083496154845;1190.8630507491575;1199.9520019199308;1212.1393810394543;1226.7546490701895;6311.936880631227;6323.177986861679;6360.14138091361;6386.680665966776;6424.486041116699;9843.310968232156;9884.901150988542;9911.45486998222;10036.197104231644;10097.798044039226;9585.712428627152;9773.364731292444;9800.411975281506;9878.506074696237;9880.110790028788;7896.881546776803;7968.681252749825;7995;8007.239312265326;8043.235892590077;7731.6520756567215;7779.57212353326;7814.531128132103;7853.489523180975;7880.093789214085;8870.911290887267;9120.771980700536;9223.12380323895;9309.394889332172;9311.953440232755;8959.686410975584;9212.263018958602;9346.20557252641;9443.622255109993;9516.19112375428;7197.71209151628;7252.927470725436;7291.197968223385;7300.598467084362;7345.045144131229;7842.725504607311;7975.5613441261285;8049.879251811345;8147.063087744985;8157.8368432632205;7249.637518123967;7334.4132469403385;7392.704291828267;7483.363914067365;7818.257265559762;7534.35957943581;7540;7607.391408687403;7636.198199189227;7678.692852285846;7589.051368578927;7640.885386719315;7658.617069146632;7674;7694.499857509244;6980.825479363057;6998.020277161303;7040;7178.28217178278;7207.783766487014;6971.477139214478;6977.441804655514;7002.229754727078;7004.509684322048;7011.298870112948 16:53:36 INFO - 2016-01-20 16:53:36,620 DEBUG : BROWSER_OUTPUT: |4;prototype.html;367.8252829905795;368.8321813574824;372.0327149411532;372.07168115551696;378.4229050697687;6312.905306420402;6335.714892829822;6369.07648390983;6445.226572811258;6460.870782584358;6284.214473190851;6380.649064301461;6397.712102955366;6400.231972163347;6403.743850245996;4849.975750121244;4863.294822250771;4870.975645121769;4873.293372460991;4886.682365646239;4891.14404979129;4891.828785992491;4894.608431325485;4896.853094407174;4903.926441103386;4688.671792974493;4713.905721885578;4805.543473370024;4814.759262036901;4877.634177436688;4783.784729687172;4805.495422980589;4811.711297322172;4819.0602832447685;4843.4187897452175;4179.226843034048;4215.409842622035;4217.894552636178;4220.261454245526;4223.450951376332;5990.1314309425325;6006.249218847644;6016;6030.879382412327;6036.0945858121195;5522.972385138049;5564.749586268587;5567.081431563787;5584.385717571064;5620.690862002588;6663.833404164886;6666.866662666719;6672.966635166842;6675.766348177839;6693.531452798306;4594.379758732562;4596.7931443085145;4605.263157894721;4608.493065762764;4610.723356598614;6898.620575868325;6945.791626251221;6948.096747422853;6983.860322793566;7009.509334346598;4778.37881075458;4785.641076919245;4785.95214047862;4795.712257264575;4807.95192048075;4842.903141937212;4852.490488498727;4853.708777473363;4859.2954021667365;4866.562009419169;5596.664200148004;5597.272354593877;5603;5625.971870140623;5628.0713682242795;6607.108040414482;6774.153230846145;6829.692663830139;6831.829204269933;6849.760258390932;1693;1731.3420900057897;1732.8786984910935;1733.081466822586;1736.426979096895;1152.6311580294225;1157.9710507237219;1162.2619636530694;1175.494537348931;1192.0880526397314;6581.3747693969;6586.5389422739945;6595.97762346837;6614.735410583619;6650.600963942179;7030.226675065739;7070.186928503288;7074.929250707427;7087.858242835217;7088.432925366062;6505.349465053551;6576.473882089422;6601.900971485432;6676.699548520328;6685.79942601713;3839.4816699745734;3845.250176215611;3860.1507668312925;3860.3823388257742;3877.1470276539117;7296.8175795604475;7297.3432391084;7312.1591017033725;7313.561186328838;7327.523710958771;7101.431885449255;7257.637118144072;7285.817854553678;7291.598962057138;7304.561726296333;7318.707251709872;7320;7325.597092159983;7328.303811137826;7330.486865919334;7140.178879428932;7143.571385716874;7148.142222933281;7152.855543113077;7153.141623005273;6830.692618832065;7010.404115650227;7016.1580610325045;7021.964890175516;7036.683349249193;7315.780526584211;7328.523645963209;7337.046183996046;7340.265973402617;7345.963270183829;4851.223804191312;4866.756662166807;4888.486708895657;4889.877753056202;4909.3372394727685;6955.513114081966;7162.964185179041;7170.605616691132;7182.6408679564765;7190.101237345332;6927.238003819677;6940.583564986117;6959.478039146983;6964.26875178099;6965.930340696731;6669.733210671713;6894.931050689429;6913.412359949461;6941.271166527442;6947.756828510978;6784.118064651564;6824.146981627297;6834.589924604539;6838.487113466609;6845.623490708059;6852.6916288768125;6912.516123871281;6935.687894044881;6950.826229344307;6985.406240469617;6610.504212184202;6741.2921643226755;6769.323067693192;6798.286179951034;6834.760783372558 16:53:36 INFO - 2016-01-20 16:53:36,620 DEBUG : BROWSER_OUTPUT: |5;yui.html;760.6957217113156;796.5499492786576;798.7284323330067;817.8405210983857;825.7605294464605;14369.928150359247;14628.853711462882;14664.193469359181;14700.852991470096;14744.115353078809;13919;14137.57587272381;14156.858431415683;14168.574942751708;14170.50403235887;888.3515034025165;928.9581968811386;943.8395472769646;946.2477330522252;949.4066208619613;907.841127802632;919.9724008279762;923.8752768376283;923.8937522184967;924.8289066522715;965.7392504023909;979.8481235408487;986.7483791633124;990.2127808392345;990.7077412163393;962.451402700461;969.2682025071097;971.1453920549942;976.2824324121765;979.0111986893218;718.9029481020048;724.0551080839502;724.8840185570283;725.876600977835;728.4645785347765;14420.278986050656;14432.92783536086;14568.198749068797;14597.854021459756;14637.853621463755;12697.111202215849;12895.484180632764;12980.480780768758;13039;13327.00047496432;10719;10853.956881131584;10896.61861834832;10944.671659850137;10979.560817567288;3772.4152756322815;3789;3867.245887052026;3881.9029524261837;3896.337622604136;49457.25814112791;49873.25190122151;50287.74856125732;50323.49676503225;50429;10088.293819432569;10264.743381415525;10294.948525257325;10296.536655850505;10332.121769649513;18970;18983.62032759337;18992.52518687044;19002.1449034791;19009.429717108233;7370.520916140434;7512.474126811071;7535.73624923125;7550.7541255693295;7713.691452341844;4355.769278634855;4369.6722745794195;4408.713433626804;4428.977855110768;4450.821967121344;2977.8064425812254;3004.6244219472565;3028.6365636123805;3030;3040.969590304069;573.9799107031234;579.0677010013874;579.6406228138582;580.901246788047;591.8964181268261;528.8651393894609;536.6699479819882;544.104947361588;588.0825911577953;650.3334082565408;8462.36532260083;8559.358048146414;8628.266597339296;8630.611622477003;8770.3422243332;621.6798348850346;670.1857243449233;693.6046453521545;696.9686364113627;701.2776839854957;4091.284025295561;4127.876163715094;4143.482064741907;4180.623743863067;4200.85297014603;59448.10827837586;59870;60423.697881510314;60587.69706151441;60862.087068694;54176.45823541793;54645;55803;55822.720886395306;56506;50859.237111443355;54144.72927635337;54289.72855135699;54588;55158.72420637871;9130.406523575946;9330.113639204264;9345.953270233606;9493.430394176372;9496.667616633385;37591.87224383273;37935.43096853605;38893.611063889;39292.21415571615;39676.60323396729;49316.2602560969;49325.28710920934;49710;49736;50113.498865010886;10795.892041079489;10876.293040952312;10928.781424371628;11389.487473063899;11807.642121156177;11620;12094.697632558904;12192.51229950792;12445.875541244472;12667.619971400873;11828.763424731285;12106.636800895987;12172.208806427554;12197.634070977885;12221.816672750094;11881.346525940811;11882.762344752884;11983.221090629082;12031.338276394532;12089.75820483603;11403.973642371895;11506.137039722222;11951.462184201906;11961.461734222155;12042.21725587834;10002.899971000488;10304.896951030694;10403;10941.45292735376;11072.612458563912;9865.358751681119;10037.247206459691;10214.54034568461;10431.791364172826;10445.791084178425 16:53:36 INFO - 2016-01-20 16:53:36,620 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: __startTimestamp1453337616611__endTimestamp 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:53:36 INFO - 2016-01-20 16:53:36,621 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,622 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5600.33 Median:5856.47 stddev:642.45 (11.0%) stddev-sans-first:616.58 16:53:36 INFO - 2016-01-20 16:53:36,622 DEBUG : BROWSER_OUTPUT: Values: 3215.3 3219.9 3252.3 3281.0 3285.2 5437.5 5482.5 5494.8 5523.6 5587.1 5472.3 5537.7 5553.8 5564.7 5604.6 5045.1 5075.3 5082.2 5104.8 5125.2 5078.1 5079.7 5230.7 5278.8 5300.0 5018.3 5091.7 5142.8 5159.0 5227.5 5218.1 5228.9 5240.5 5244.7 5277.6 4864.2 4866.4 5015.2 5114.1 5135.6 5318.5 5370.3 5393.5 5407.3 5444.8 5914.3 5945.9 5948.3 5948.6 6032.4 5951.1 6028.7 6057.8 6076.3 6083.9 5558.7 5571.4 5574.7 5585.3 5611.5 5943.3 5980.8 6018.4 6025.7 6136.3 5826.3 5836.1 5838.2 5847.1 5856.5 5809.5 5829.1 5897.6 6030.5 6058.2 5859.7 5893.0 5913.6 5926.7 5927.4 5874.3 5945.0 5958.6 5962.7 5974.1 4541.4 4570.7 4571.1 4626.7 4632.7 4114.2 4120.6 4123.2 4151.5 4153.7 5433.1 5809.9 5810.3 5813.7 5823.2 5984.9 6125.1 6229.6 6246.7 6253.8 5814.6 5815.7 5826.5 5853.7 5900.6 5249.7 5288.0 5313.7 5314.5 5338.7 6112.1 6149.0 6167.3 6183.6 6240.2 6033.1 6191.6 6199.2 6201.0 6295.1 6140.0 6196.2 6246.4 6293.9 6326.2 5934.6 5986.7 6038.3 6048.1 6054.1 6134.1 6152.5 6154.5 6165.3 6181.7 5854.1 5867.4 5938.9 5952.9 5969.5 5926.9 6022.6 6037.5 6044.4 6052.1 5900.8 5919.8 5920.1 5921.1 5940.1 5816.8 5930.5 5937.4 6024.0 6055.8 5906.6 5907.3 5918.7 5922.6 5942.0 16:53:36 INFO - 2016-01-20 16:53:36,622 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,623 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55272.01 Median:38174.43 stddev:113854.84 (298.2%) stddev-sans-first:114100.23 16:53:36 INFO - 2016-01-20 16:53:36,623 DEBUG : BROWSER_OUTPUT: Values: 598.5 630.9 636.5 669.3 669.5 40798.2 41073.8 41364.0 41406.4 41455.2 44394.8 44887.0 44956.3 45070.1 45164.5 9083.5 9211.0 9234.9 9262.0 9283.3 8944.5 8984.6 8998.3 9039.3 9045.9 8901.2 8909.4 8942.0 8972.0 9071.0 8877.8 8967.2 9007.6 9039.8 9060.8 8849.1 8997.5 9024.7 9031.4 9056.3 41628.6 41996.6 42298.0 42351.8 42367.8 3528.6 3533.5 3545.9 3572.8 3600.0 31392.8 32022.2 32068.0 32119.0 32155.0 3604.1 3652.4 3657.9 3714.4 3764.6 281912.0 283262.0 283423.0 283838.0 286972.0 44268.0 44467.0 44692.3 44881.8 45011.3 42525.6 42609.8 42890.1 43066.6 43205.0 14909.8 14964.3 15059.8 15096.9 15104.0 12299.6 12308.6 12340.9 12472.0 12705.8 14964.6 15049.7 15078.3 15109.4 15185.2 5929.8 6086.8 6098.5 6111.9 6164.3 1006.8 1053.1 1114.0 1164.8 1196.2 33744.8 33821.7 34162.1 34234.8 34294.7 1094.2 1094.9 1150.3 1155.3 1198.4 15338.5 15743.7 17601.3 17605.4 17920.2 435881.0 536901.0 537387.0 544388.0 838446.0 56827.1 57630.4 57734.4 57867.7 58048.0 1488.2 1490.5 1491.6 1501.4 1589.6 29965.7 30053.7 30947.2 31109.7 31237.4 47558.0 48050.3 48177.8 48195.0 48377.0 331129.0 333336.0 334465.0 334781.0 334989.0 32939.0 33073.0 33474.5 33587.5 33769.8 44321.3 44618.6 44762.1 45309.3 45796.8 37054.0 37587.0 38196.2 38514.6 38771.6 37970.7 38127.2 38152.6 38301.2 38883.2 37643.4 38282.6 38370.0 38468.6 38475.0 33169.0 33841.2 33899.0 33932.0 34120.5 25891.4 26622.9 26676.3 26690.7 26721.7 16:53:36 INFO - 2016-01-20 16:53:36,623 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,624 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31868.86 Median:18662.44 stddev:101489.05 (543.8%) stddev-sans-first:101746.22 16:53:36 INFO - 2016-01-20 16:53:36,624 DEBUG : BROWSER_OUTPUT: Values: 386.7 392.2 392.4 393.3 393.9 16196.8 17027.0 18499.7 20032.2 20267.3 12163.8 12169.8 12372.3 12384.8 12435.0 5021.4 5179.3 5184.7 5189.4 5265.7 5493.5 5587.7 5615.9 5625.9 5637.0 5370.1 5499.1 5585.1 5590.8 5593.7 5432.1 5445.0 5461.9 5467.6 5477.8 5157.8 5308.1 5324.1 5326.4 5330.8 13207.3 13235.3 13238.2 13385.7 13537.5 2211.5 2218.3 2223.2 2232.2 2277.4 10381.7 10483.6 10673.5 12405.3 12796.8 1908.1 1939.9 1962.9 1993.2 2030.3 65076.3 67325.0 67835.0 68663.3 68842.7 10943.2 11124.1 11295.9 11301.5 11402.1 14694.0 14748.3 14801.6 14814.8 14860.9 8267.6 8331.6 8388.4 8426.5 8454.7 7898.0 7934.1 7964.2 7965.4 7984.4 4758.4 4801.6 4806.8 4916.0 4945.9 1990.8 1995.4 2014.7 2035.9 2040.3 954.2 1060.8 1067.4 1070.8 1133.5 17294.4 17383.9 17610.6 17784.1 18825.2 1002.9 1014.9 1023.2 1041.4 1069.7 10088.8 10381.9 10445.4 10455.9 10465.4 607555.0 613631.0 616031.0 630544.0 637126.0 82245.0 83268.6 85176.1 85408.6 86895.0 1188.6 1209.3 1209.7 1213.8 1217.7 16387.3 16424.8 16467.5 16474.0 16487.0 37907.0 38083.2 38568.8 38681.2 38904.4 50804.5 51972.0 52060.7 52761.7 54932.5 10074.6 10383.1 10418.8 10550.6 10564.8 13617.7 14166.0 17725.2 18000.7 18298.3 14724.0 14819.3 15496.8 15709.5 15876.3 14868.9 14910.8 14980.6 15609.1 15748.0 15657.3 15678.4 15817.0 15981.3 15982.2 10149.9 10508.9 10572.4 10765.5 10935.5 12421.8 15967.9 16102.4 16310.5 16321.0 16:53:36 INFO - 2016-01-20 16:53:36,624 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,624 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5901.65 Median:6979.13 stddev:3096.40 (44.4%) stddev-sans-first:3088.15 16:53:36 INFO - 2016-01-20 16:53:36,625 DEBUG : BROWSER_OUTPUT: Values: 1592.0 1606.9 1643.4 1850.4 1911.8 8414.4 8532.0 8639.5 8716.5 8760.6 8700.1 8756.4 8761.6 8785.3 8803.9 2444.0 2484.9 2485.2 2493.1 2494.7 2449.9 2503.3 2514.9 2515.6 2520.2 2381.2 2410.7 2421.1 2443.9 2455.7 2396.4 2409.6 2415.1 2417.0 2440.5 2388.7 2413.5 2436.7 2441.2 2444.9 8484.3 8526.0 8569.3 8572.0 8612.7 4891.5 4955.5 4993.0 5016.8 5018.2 3168.4 3195.7 3244.4 3254.4 3255.3 987.1 998.1 1000.0 1008.3 1027.4 11915.3 11926.5 11983.4 12022.3 12075.0 4333.5 4368.1 4396.5 4408.3 4457.7 9587.6 9589.8 9671.9 9688.8 9730.8 4982.1 5010.7 5038.7 5061.3 5061.4 4563.5 4650.1 4651.2 4652.0 4657.3 3517.1 3587.2 3597.2 3613.4 3625.8 1136.4 1143.3 1150.5 1151.8 1168.0 1111.5 1127.7 1185.3 1350.5 1404.0 7940.4 7948.3 8045.8 8135.3 8139.2 1182.3 1190.9 1200.0 1212.1 1226.8 6311.9 6323.2 6360.1 6386.7 6424.5 9843.3 9884.9 9911.5 10036.2 10097.8 9585.7 9773.4 9800.4 9878.5 9880.1 7896.9 7968.7 7995.0 8007.2 8043.2 7731.7 7779.6 7814.5 7853.5 7880.1 8870.9 9120.8 9223.1 9309.4 9312.0 8959.7 9212.3 9346.2 9443.6 9516.2 7197.7 7252.9 7291.2 7300.6 7345.0 7842.7 7975.6 8049.9 8147.1 8157.8 7249.6 7334.4 7392.7 7483.4 7818.3 7534.4 7540.0 7607.4 7636.2 7678.7 7589.1 7640.9 7658.6 7674.0 7694.5 6980.8 6998.0 7040.0 7178.3 7207.8 6971.5 6977.4 7002.2 7004.5 7011.3 16:53:36 INFO - 2016-01-20 16:53:36,626 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,626 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5702.21 Median:6540.91 stddev:1736.63 (26.6%) stddev-sans-first:1694.72 16:53:36 INFO - 2016-01-20 16:53:36,626 DEBUG : BROWSER_OUTPUT: Values: 367.8 368.8 372.0 372.1 378.4 6312.9 6335.7 6369.1 6445.2 6460.9 6284.2 6380.6 6397.7 6400.2 6403.7 4850.0 4863.3 4871.0 4873.3 4886.7 4891.1 4891.8 4894.6 4896.9 4903.9 4688.7 4713.9 4805.5 4814.8 4877.6 4783.8 4805.5 4811.7 4819.1 4843.4 4179.2 4215.4 4217.9 4220.3 4223.5 5990.1 6006.2 6016.0 6030.9 6036.1 5523.0 5564.7 5567.1 5584.4 5620.7 6663.8 6666.9 6673.0 6675.8 6693.5 4594.4 4596.8 4605.3 4608.5 4610.7 6898.6 6945.8 6948.1 6983.9 7009.5 4778.4 4785.6 4786.0 4795.7 4808.0 4842.9 4852.5 4853.7 4859.3 4866.6 5596.7 5597.3 5603.0 5626.0 5628.1 6607.1 6774.2 6829.7 6831.8 6849.8 1693.0 1731.3 1732.9 1733.1 1736.4 1152.6 1158.0 1162.3 1175.5 1192.1 6581.4 6586.5 6596.0 6614.7 6650.6 7030.2 7070.2 7074.9 7087.9 7088.4 6505.3 6576.5 6601.9 6676.7 6685.8 3839.5 3845.3 3860.2 3860.4 3877.1 7296.8 7297.3 7312.2 7313.6 7327.5 7101.4 7257.6 7285.8 7291.6 7304.6 7318.7 7320.0 7325.6 7328.3 7330.5 7140.2 7143.6 7148.1 7152.9 7153.1 6830.7 7010.4 7016.2 7022.0 7036.7 7315.8 7328.5 7337.0 7340.3 7346.0 4851.2 4866.8 4888.5 4889.9 4909.3 6955.5 7163.0 7170.6 7182.6 7190.1 6927.2 6940.6 6959.5 6964.3 6965.9 6669.7 6894.9 6913.4 6941.3 6947.8 6784.1 6824.1 6834.6 6838.5 6845.6 6852.7 6912.5 6935.7 6950.8 6985.4 6610.5 6741.3 6769.3 6798.3 6834.8 16:53:36 INFO - 2016-01-20 16:53:36,626 DEBUG : BROWSER_OUTPUT: 16:53:36 INFO - 2016-01-20 16:53:36,628 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14784.42 Median:4389.19 stddev:17348.46 (395.3%) stddev-sans-first:17365.16 16:53:36 INFO - 2016-01-20 16:53:36,628 DEBUG : BROWSER_OUTPUT: Values: 760.7 796.5 798.7 817.8 825.8 14369.9 14628.9 14664.2 14700.9 14744.1 13919.0 14137.6 14156.9 14168.6 14170.5 888.4 929.0 943.8 946.2 949.4 907.8 920.0 923.9 923.9 924.8 965.7 979.8 986.7 990.2 990.7 962.5 969.3 971.1 976.3 979.0 718.9 724.1 724.9 725.9 728.5 14420.3 14432.9 14568.2 14597.9 14637.9 12697.1 12895.5 12980.5 13039.0 13327.0 10719.0 10854.0 10896.6 10944.7 10979.6 3772.4 3789.0 3867.2 3881.9 3896.3 49457.3 49873.3 50287.7 50323.5 50429.0 10088.3 10264.7 10294.9 10296.5 10332.1 18970.0 18983.6 18992.5 19002.1 19009.4 7370.5 7512.5 7535.7 7550.8 7713.7 4355.8 4369.7 4408.7 4429.0 4450.8 2977.8 3004.6 3028.6 3030.0 3041.0 574.0 579.1 579.6 580.9 591.9 528.9 536.7 544.1 588.1 650.3 8462.4 8559.4 8628.3 8630.6 8770.3 621.7 670.2 693.6 697.0 701.3 4091.3 4127.9 4143.5 4180.6 4200.9 59448.1 59870.0 60423.7 60587.7 60862.1 54176.5 54645.0 55803.0 55822.7 56506.0 50859.2 54144.7 54289.7 54588.0 55158.7 9130.4 9330.1 9346.0 9493.4 9496.7 37591.9 37935.4 38893.6 39292.2 39676.6 49316.3 49325.3 49710.0 49736.0 50113.5 10795.9 10876.3 10928.8 11389.5 11807.6 11620.0 12094.7 12192.5 12445.9 12667.6 11828.8 12106.6 12172.2 12197.6 12221.8 11881.3 11882.8 11983.2 12031.3 12089.8 11404.0 11506.1 11951.5 11961.5 12042.2 10002.9 10304.9 10403.0 10941.5 11072.6 9865.4 10037.2 10214.5 10431.8 10445.8 16:53:36 INFO - 2016-01-20 16:53:36,628 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:53:36 INFO - 2016-01-20 16:53:36,628 DEBUG : BROWSER_OUTPUT: 16:53:37 INFO - 2016-01-20 16:53:37,241 INFO : Browser exited with error code: 0 16:53:37 INFO - 2016-01-20 16:53:37,260 INFO : Completed test dromaeo_css (00:18:28) 16:53:37 INFO - 2016-01-20 16:53:37,260 INFO : Starting test kraken 16:53:37 INFO - 2016-01-20 16:53:37,260 DEBUG : operating with platform_type : linux_ 16:53:37 INFO - 2016-01-20 16:53:37,260 INFO : Initialising browser for kraken test... 16:53:37 INFO - 2016-01-20 16:53:37,267 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7fBzw1/profile http://localhost:55634/getInfo.html 16:53:40 INFO - 2016-01-20 16:53:40,830 DEBUG : BROWSER_OUTPUT: 16:53:40 INFO - 2016-01-20 16:53:40,831 DEBUG : BROWSER_OUTPUT: (process:4269): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:53:41 INFO - 2016-01-20 16:53:41,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:53:41 INFO - 2016-01-20 16:53:41,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:53:41 INFO - 2016-01-20 16:53:41,757 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:53:41 INFO - 2016-01-20 16:53:41,757 DEBUG : BROWSER_OUTPUT: __metrics 16:53:42 INFO - 2016-01-20 16:53:42,737 INFO : Browser initialized. 16:53:42 INFO - 2016-01-20 16:53:42,738 INFO : Running cycle 1/1 for kraken test... 16:53:42 INFO - 2016-01-20 16:53:42,738 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7fBzw1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:53:44 INFO - 2016-01-20 16:53:44,063 DEBUG : BROWSER_OUTPUT: 16:53:44 INFO - 2016-01-20 16:53:44,063 DEBUG : BROWSER_OUTPUT: (process:4383): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:53:54 INFO - 2016-01-20 16:53:54,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 136597504 16:53:54 INFO - 2016-01-20 16:53:54,566 DEBUG : BROWSER_OUTPUT: 16:53:57 INFO - 2016-01-20 16:53:57,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55634/tests/kraken/driver.html?testName=audio-beat-detection) 16:53:57 INFO - 2016-01-20 16:53:57,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 137711616 16:53:57 INFO - 2016-01-20 16:53:57,623 DEBUG : BROWSER_OUTPUT: 16:54:00 INFO - 2016-01-20 16:54:00,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55634/tests/kraken/driver.html?testName=audio-dft) 16:54:00 INFO - 2016-01-20 16:54:00,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568 16:54:00 INFO - 2016-01-20 16:54:00,847 DEBUG : BROWSER_OUTPUT: 16:54:03 INFO - 2016-01-20 16:54:03,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55634/tests/kraken/driver.html?testName=audio-fft) 16:54:04 INFO - 2016-01-20 16:54:04,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 139341824 16:54:04 INFO - 2016-01-20 16:54:04,268 DEBUG : BROWSER_OUTPUT: 16:54:06 INFO - 2016-01-20 16:54:06,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55634/tests/kraken/driver.html?testName=audio-oscillator) 16:54:06 INFO - 2016-01-20 16:54:06,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 138174464 16:54:06 INFO - 2016-01-20 16:54:06,866 DEBUG : BROWSER_OUTPUT: 16:54:09 INFO - 2016-01-20 16:54:09,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:54:09 INFO - 2016-01-20 16:54:09,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 16:54:09 INFO - 2016-01-20 16:54:09,631 DEBUG : BROWSER_OUTPUT: 16:54:12 INFO - 2016-01-20 16:54:12,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55634/tests/kraken/driver.html?testName=imaging-darkroom) 16:54:13 INFO - 2016-01-20 16:54:13,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 16:54:13 INFO - 2016-01-20 16:54:13,159 DEBUG : BROWSER_OUTPUT: 16:54:16 INFO - 2016-01-20 16:54:16,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55634/tests/kraken/driver.html?testName=imaging-desaturate) 16:54:17 INFO - 2016-01-20 16:54:17,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 139386880 16:54:17 INFO - 2016-01-20 16:54:17,110 DEBUG : BROWSER_OUTPUT: 16:54:19 INFO - 2016-01-20 16:54:19,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55634/tests/kraken/driver.html?testName=json-parse-financial) 16:54:20 INFO - 2016-01-20 16:54:20,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 137830400 16:54:20 INFO - 2016-01-20 16:54:20,480 DEBUG : BROWSER_OUTPUT: 16:54:22 INFO - 2016-01-20 16:54:22,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:54:22 INFO - 2016-01-20 16:54:22,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 16:54:22 INFO - 2016-01-20 16:54:22,642 DEBUG : BROWSER_OUTPUT: 16:54:24 INFO - 2016-01-20 16:54:24,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:54:25 INFO - 2016-01-20 16:54:25,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 137940992 16:54:25 INFO - 2016-01-20 16:54:25,027 DEBUG : BROWSER_OUTPUT: 16:54:27 INFO - 2016-01-20 16:54:27,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:54:27 INFO - 2016-01-20 16:54:27,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 139743232 16:54:27 INFO - 2016-01-20 16:54:27,616 DEBUG : BROWSER_OUTPUT: 16:54:30 INFO - 2016-01-20 16:54:30,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:54:30 INFO - 2016-01-20 16:54:30,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 16:54:30 INFO - 2016-01-20 16:54:30,635 DEBUG : BROWSER_OUTPUT: 16:54:33 INFO - 2016-01-20 16:54:33,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:54:33 INFO - 2016-01-20 16:54:33,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 139583488 16:54:33 INFO - 2016-01-20 16:54:33,802 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55634/tests/kraken/driver.html?testName=ai-astar) 16:54:35 INFO - 2016-01-20 16:54:35,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 138838016 16:54:35 INFO - 2016-01-20 16:54:35,767 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;110;112;111;121;112;110;110;111 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;133;156;155;127;155;157;131;164;129 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;163;164;164;165;163;163;162 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;73;73;144;71;73;74;73;152;72 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;134;93;93;94;138;93;94;136 16:54:35 INFO - 2016-01-20 16:54:35,768 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;111;110;110;110;111;110;110 16:54:35 INFO - 2016-01-20 16:54:35,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;152;147;148;148;148;146;148;149;147;148 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;97;96;97;99;96;96;96 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;61;63;63;60;60;61;65;61 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;63;63;65;64;66;65;64;65 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;82;82;82;82;84;82;83;82 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;118;113;117;120;127;125;124;114;122 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;150;156;152;156;135;148;149;148;152 16:54:35 INFO - 2016-01-20 16:54:35,770 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;70;67;66;68;68;76;66;68;68 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,709 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: __startTimestamp1453337675767__endTimestamp 16:54:35 INFO - 2016-01-20 16:54:35,771 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,775 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:54:35 INFO - 2016-01-20 16:54:35,775 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:54:35 INFO - 2016-01-20 16:54:35,775 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,775 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.95 (3.6%) stddev-sans-first:4.18 16:54:35 INFO - 2016-01-20 16:54:35,775 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 110.0 112.0 111.0 121.0 112.0 110.0 110.0 111.0 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:155.00 stddev:14.20 (9.2%) stddev-sans-first:14.77 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: Values: 154.0 133.0 156.0 155.0 127.0 155.0 157.0 131.0 164.0 129.0 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 163.0 164.0 164.0 165.0 163.0 163.0 162.0 16:54:35 INFO - 2016-01-20 16:54:35,776 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:73.00 stddev:31.54 (43.2%) stddev-sans-first:33.27 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: Values: 79.0 73.0 73.0 144.0 71.0 73.0 74.0 73.0 152.0 72.0 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:20.66 (22.2%) stddev-sans-first:21.36 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 134.0 93.0 93.0 94.0 138.0 93.0 94.0 136.0 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:0.87 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: Values: 152.0 147.0 148.0 148.0 148.0 146.0 148.0 149.0 147.0 148.0 16:54:35 INFO - 2016-01-20 16:54:35,777 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.01 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 97.0 96.0 97.0 99.0 96.0 96.0 96.0 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.00 stddev:1.71 (2.8%) stddev-sans-first:1.74 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 61.0 63.0 63.0 60.0 60.0 61.0 65.0 61.0 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 63.0 63.0 65.0 64.0 66.0 65.0 64.0 65.0 16:54:35 INFO - 2016-01-20 16:54:35,778 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 82.0 82.0 82.0 82.0 84.0 82.0 83.0 82.0 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:121.00 stddev:4.62 (3.8%) stddev-sans-first:4.90 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: Values: 120.0 118.0 113.0 117.0 120.0 127.0 125.0 124.0 114.0 122.0 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:151.00 stddev:5.89 (3.9%) stddev-sans-first:6.25 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 156.0 152.0 156.0 135.0 148.0 149.0 148.0 152.0 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.91 (4.3%) stddev-sans-first:3.05 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 67.0 66.0 68.0 68.0 76.0 66.0 68.0 68.0 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:54:35 INFO - 2016-01-20 16:54:35,779 DEBUG : BROWSER_OUTPUT: 16:54:36 INFO - 2016-01-20 16:54:36,585 INFO : Browser exited with error code: 0 16:54:36 INFO - 2016-01-20 16:54:36,641 INFO : Completed test kraken (00:00:59) 16:54:36 INFO - 2016-01-20 16:54:36,641 INFO : Starting test v8_7 16:54:36 INFO - 2016-01-20 16:54:36,641 DEBUG : operating with platform_type : linux_ 16:54:36 INFO - 2016-01-20 16:54:36,641 INFO : Initialising browser for v8_7 test... 16:54:36 INFO - 2016-01-20 16:54:36,647 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJ_8xf/profile http://localhost:55634/getInfo.html 16:54:40 INFO - 2016-01-20 16:54:40,370 DEBUG : BROWSER_OUTPUT: 16:54:40 INFO - 2016-01-20 16:54:40,370 DEBUG : BROWSER_OUTPUT: (process:4696): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:41 INFO - 2016-01-20 16:54:41,239 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:41 INFO - 2016-01-20 16:54:41,239 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:41 INFO - 2016-01-20 16:54:41,239 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:54:41 INFO - 2016-01-20 16:54:41,239 DEBUG : BROWSER_OUTPUT: __metrics 16:54:42 INFO - 2016-01-20 16:54:42,257 INFO : Browser initialized. 16:54:42 INFO - 2016-01-20 16:54:42,258 INFO : Running cycle 1/1 for v8_7 test... 16:54:42 INFO - 2016-01-20 16:54:42,258 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJ_8xf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:43 INFO - 2016-01-20 16:54:43,590 DEBUG : BROWSER_OUTPUT: 16:54:43 INFO - 2016-01-20 16:54:43,590 DEBUG : BROWSER_OUTPUT: (process:4808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:54 INFO - 2016-01-20 16:54:54,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 136409088 16:54:54 INFO - 2016-01-20 16:54:54,091 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55634/tests/v8_7/run.html (next: http://localhost:55634/tests/v8_7/run.html) 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 136462336 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: |0;Richards;163.55904481517828 16:55:15 INFO - 2016-01-20 16:55:15,712 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.6727028839705 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |4;RayTrace;917.4311926605504 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |5;Earley;549.4505494505495 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |6;Boyer;11000 16:55:15 INFO - 2016-01-20 16:55:15,713 DEBUG : BROWSER_OUTPUT: |7;RegExp;24000 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: |8;Splay;522.7391531625718 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1453337715710__endTimestamp 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,714 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.56 Median:163.56 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: Values: 163.6 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,715 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,716 DEBUG : BROWSER_OUTPUT: Values: 167.7 16:55:15 INFO - 2016-01-20 16:55:15,716 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,716 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,716 DEBUG : BROWSER_OUTPUT: Values: 279.2 16:55:15 INFO - 2016-01-20 16:55:15,716 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: Values: 5164.9 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:917.43 Median:917.43 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: Values: 917.4 16:55:15 INFO - 2016-01-20 16:55:15,717 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.45 Median:549.45 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: Values: 549.5 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11000.00 Median:11000.00 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: Values: 11000.0 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24000.00 Median:24000.00 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: Values: 24000.0 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:522.74 Median:522.74 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,718 DEBUG : BROWSER_OUTPUT: Values: 522.7 16:55:15 INFO - 2016-01-20 16:55:15,719 DEBUG : BROWSER_OUTPUT: 16:55:15 INFO - 2016-01-20 16:55:15,719 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:55:15 INFO - 2016-01-20 16:55:15,720 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:55:15 INFO - 2016-01-20 16:55:15,720 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:15 INFO - 2016-01-20 16:55:15,720 DEBUG : BROWSER_OUTPUT: 16:55:16 INFO - 2016-01-20 16:55:16,465 INFO : Browser exited with error code: 0 16:55:16 INFO - 2016-01-20 16:55:16,482 INFO : Completed test v8_7 (00:00:39) 16:55:16 INFO - 2016-01-20 16:55:16,771 INFO : Completed test suite (00:20:07) 16:55:16 INFO - 2016-01-20 16:55:16,771 DEBUG : Working with test: dromaeo_css 16:55:16 INFO - 2016-01-20 16:55:16,771 DEBUG : Generating results file: dromaeo_css 16:55:16 INFO - 2016-01-20 16:55:16,772 DEBUG : Working with test: kraken 16:55:16 INFO - 2016-01-20 16:55:16,772 DEBUG : Generating results file: kraken 16:55:16 INFO - 2016-01-20 16:55:16,773 INFO : javascript benchmark 16:55:16 INFO - 2016-01-20 16:55:16,773 DEBUG : Working with test: v8_7 16:55:16 INFO - 2016-01-20 16:55:16,773 DEBUG : Generating results file: v8_7 16:55:16 INFO - 2016-01-20 16:55:16,773 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:16 INFO - 2016-01-20 16:55:16,818 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 16:55:16 INFO - 2016-01-20 16:55:16,818 DEBUG : process_Request line: dromaeo_css 7405.39 graph.html#tests=[[72,52,43]] 16:55:16 INFO - 2016-01-20 16:55:16,818 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:16 INFO - 2016-01-20 16:55:16,852 DEBUG : process_Request line: kraken 1515.90 graph.html#tests=[[232,52,43]] 16:55:16 INFO - 2016-01-20 16:55:16,852 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:16 INFO - 2016-01-20 16:55:16,879 DEBUG : process_Request line: v8_7 23281.75 graph.html#tests=[[230,52,43]] 16:55:16 INFO - 2016-01-20 16:55:16,880 INFO : javascript benchmark 16:55:16 INFO - 2016-01-20 16:55:16,884 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3215.276562773376, 3219.905232221046, 3252.2682396460814, 3281.048495936178, 3285.1622836176784, 5437.53780928621, 5482.479164479378, 5494.7527361268785, 5523.6409633373805, 5587.05020146575, 5472.315960504937, 5537.723113844312, 5553.750081246343, 5564.749586268617, 5604.579656525756, 5045.117104506706, 5075.340205773245, 5082.16144336186, 5104.77028533715, 5125.231215317714, 5078.136716758141, 5079.669821461612, 5230.660007099526, 5278.788848446057, 5300.0, 5018.322526458936, 5091.694498330094, 5142.845714628567, 5159.019786240621, 5227.47725227478, 5218.086834803932, 5228.947710522903, 5240.502152295545, 5244.711540865251, 5277.577793776489, 4864.173090574611, 4866.3673722416215, 5015.247712843066, 5114.130597798383, 5135.563477104451, 5318.5213330800025, 5370.3287089113865, 5393.514583687448, 5407.297051383334, 5444.836654900319, 5914.260717410324, 5945.910811337833, 5948.345681974979, 5948.613340132878, 6032.42691944269, 5951.137085122677, 6028.668423236721, 6057.787977420813, 6076.301225359096, 6083.878322433571, 5558.722063896789, 5571.387147413781, 5574.693391863446, 5585.3297604287745, 5611.523020543259, 5943.286805583271, 5980.760769569256, 6018.398160183947, 6025.6685882276015, 6136.29432615255, 5826.300843898674, 5836.1245813127525, 5838.153467747238, 5847.093700476433, 5856.472917437451, 5809.535237181015, 5829.067349224104, 5897.5871688982215, 6030.487408570233, 6058.1518587397795, 5859.736311865891, 5892.970535147297, 5913.58604897653, 5926.703664816742, 5927.407259274124, 5874.295084589877, 5945.019071853182, 5958.553108516879, 5962.701864906738, 5974.133750606138, 4541.364209010741, 4570.65720070996, 4571.131485017836, 4626.722396656144, 4632.722036677743, 4114.177164567099, 4120.649744771728, 4123.175364927027, 4151.46031015966, 4153.709240353207, 5433.0763770159165, 5809.8547536311935, 5810.331811841608, 5813.680247586339, 5823.155642431909, 5984.850378740566, 6125.082842094287, 6229.563930524911, 6246.6876656167005, 6253.812385628438, 5814.563907706939, 5815.73829177688, 5826.547474465878, 5853.707314634251, 5900.64596124234, 5249.737513124329, 5288.0, 5313.734313284321, 5314.548263397577, 5338.679679219259, 6112.144299798032, 6149.0, 6167.321594624587, 6183.598066125687, 6240.219972503437, 6033.064874944391, 6191.628502289877, 6199.225096862892, 6201.0, 6295.118683384421, 6140.0, 6196.194494715838, 6246.437820596168, 6293.874122517433, 6326.2092238470195, 5934.554908381975, 5986.730597123227, 6038.275406951194, 6048.123022161674, 6054.061620448838, 6134.110553969738, 6152.507799376129, 6154.476869466145, 6165.260168779596, 6181.690915454119, 5854.121881717776, 5867.354590995073, 5938.851528711817, 5952.851178720567, 5969.4627483524955, 5926.940730592812, 6022.608530445507, 6037.516998640011, 6044.365341639241, 6052.092186172109, 5900.822975310747, 5919.763209471573, 5920.052791553331, 5921.082232254007, 5940.079287710412, 5816.796412125555, 5930.52555795544, 5937.406259374028, 6024.0, 6055.757769689163, 5906.557008224487, 5907.2911250650195, 5918.674472904032, 5922.644641321534, 5942.049272116441], "unit": "ms", "name": "dojo.html", "value": 5556.660967670196}, {"lowerIsBetter": false, "replicates": [598.488292509904, 630.9495240380769, 636.4621894499148, 669.2704951602755, 669.5079116849118, 40798.18403631929, 41073.7946310268, 41364.0, 41406.378904316385, 41455.17089658209, 44394.77802610982, 44887.0, 44956.3256551152, 45070.09859802802, 45164.548354516446, 9083.50040747757, 9211.0, 9234.907650923506, 9262.0, 9283.303752218577, 8944.463332200055, 8984.640614375417, 8998.28013758901, 9039.27685785139, 9045.864312035324, 8901.154390332907, 8909.376343655947, 8941.95529022354, 8972.0, 9070.954645226764, 8877.822443551126, 8967.192952634294, 9007.639694412248, 9039.774005649879, 9060.77348066297, 8849.115088491164, 8997.460152390811, 9024.684136055206, 9031.412958157698, 9056.275497960147, 41628.58371416277, 41996.58003419988, 42298.0, 42351.788241058595, 42367.788161059, 3528.6118526962014, 3533.5406397168204, 3545.85816567337, 3572.7856328620364, 3600.0459878132315, 31392.843035784903, 32022.199445013826, 32068.0, 32119.0, 32155.0, 3604.098975256186, 3652.4156135018534, 3657.9085522861874, 3714.4428335749585, 3764.623537646241, 281912.0, 283262.0, 283423.0, 283837.99999999796, 286972.0, 44268.0, 44467.0, 44692.3296150558, 44881.775591121834, 45011.324830127574, 42525.57474425278, 42609.78695106505, 42890.14219715651, 43066.56933430626, 43205.0, 14909.776353354708, 14964.251787410585, 15059.849401506064, 15096.924515377572, 15104.0, 12299.569515066929, 12308.630741077783, 12340.938295308466, 12472.0, 12705.809412858815, 14964.625884352761, 15049.699006019819, 15078.321475533627, 15109.39562417491, 15185.240737963057, 5929.792457264061, 6086.756529738761, 6098.54260930432, 6111.938880611226, 6164.349329788144, 1006.8036732837173, 1053.068034789217, 1113.969578140217, 1164.7554013657057, 1196.2463647901766, 33744.83127584346, 33821.66178338185, 34162.14594635154, 34234.82882585571, 34294.657053429146, 1094.1738987064716, 1094.87408947972, 1150.2753265442884, 1155.3299086529792, 1198.3888217009214, 15338.539843804481, 15743.68512629741, 17601.29594816193, 17605.383811566535, 17920.193591288422, 435881.0, 536901.0, 537387.0, 544388.0, 838446.0, 56827.14759278614, 57630.42369576335, 57734.422655772905, 57867.710661447265, 58048.0, 1488.2186851903055, 1490.4932323010228, 1491.6121808329913, 1501.4369611395728, 1589.6343840916654, 29965.70034299629, 30053.69946300509, 30947.226319342197, 31109.68890311068, 31237.375252494367, 47558.0, 48050.27924581064, 48177.75911120422, 48195.0, 48377.0, 331129.0, 333336.0, 334465.0, 334781.0, 334989.0, 32939.0, 33073.0, 33474.49364778542, 33587.49618755769, 33769.83115084409, 44321.33517997297, 44618.553814462735, 44762.10475790401, 45309.32036019397, 45796.77101614604, 37054.0, 37587.0, 38196.23607527778, 38514.614853851104, 38771.6122838768, 37970.721756694686, 38127.23745525129, 38152.61847381491, 38301.23397531978, 38883.222335552564, 37643.43534846925, 38282.61717382902, 38370.0, 38468.6153138465, 38475.0, 33169.0, 33841.15397115092, 33899.0, 33932.0, 34120.48819267663, 25891.352716182246, 26622.866885665448, 26676.333091672088, 26690.733092668826, 26721.732782671923], "unit": "ms", "name": "ext.html", "value": 19197.343763663855}, {"lowerIsBetter": false, "replicates": [386.65973942930236, 392.1822999046987, 392.397669577199, 393.26655786957315, 393.94484772131887, 16196.75704864428, 17027.0, 18499.722504162433, 20032.19871205152, 20267.290644827433, 12163.817542736844, 12169.817452738194, 12372.319522426264, 12384.752304953896, 12435.0, 5021.422536408305, 5179.2749015137915, 5184.688918664892, 5189.377274727038, 5265.736713164346, 5493.505584497394, 5587.692676902769, 5615.9157612635845, 5625.8593535161535, 5637.0, 5370.140777475604, 5499.092649712793, 5585.134304182858, 5590.804321848736, 5593.664380137185, 5432.076546987022, 5445.0, 5461.9453805462035, 5467.589930755189, 5477.780888764445, 5157.793688252503, 5308.124159513675, 5324.1215199492035, 5326.387465441447, 5330.840074797762, 13207.273599952, 13235.338233088307, 13238.205707657571, 13385.66535836612, 13537.52618658352, 2211.5024119572968, 2218.256883943881, 2223.155201023617, 2232.229880691159, 2277.35095497784, 10381.740456488647, 10483.633072842415, 10673.466326683712, 12405.25568465886, 12796.848283654423, 1908.0841196225751, 1939.94180174595, 1962.8724132931313, 1993.2126809910148, 2030.2691031228746, 65076.3492365075, 67325.0, 67835.0, 68663.31336686619, 68842.65578672074, 10943.233973621771, 11124.110071194285, 11295.887041129483, 11301.491432885376, 11402.087832973508, 14694.0, 14748.262586870613, 14801.555953321418, 14814.777778333333, 14860.851391486163, 8267.586620668942, 8331.583420828934, 8388.412811103164, 8426.452280601741, 8454.66181352739, 7897.960510197412, 7934.087579928267, 7964.2433968772875, 7965.362770978308, 7984.40116991228, 4758.405199350082, 4801.567858892717, 4806.831760888422, 4915.975420122948, 4945.9258111128365, 1990.7611086669692, 1995.4013795861183, 2014.6575082236054, 2035.877847329165, 2040.2858999350108, 954.236610711428, 1060.7666313411037, 1067.380919066955, 1070.7590792071878, 1133.4785998440645, 17294.394696185573, 17383.91308043477, 17610.64778704419, 17784.110794460226, 18825.152868120967, 1002.8746406699163, 1014.9035841595037, 1023.1558963854701, 1041.4063983529315, 1069.7111779819404, 10088.798224035625, 10381.9480902595, 10445.373277603368, 10455.94772026135, 10465.372077675363, 607555.0, 613631.0, 616031.0, 630544.0, 637126.0, 82245.0, 83268.58365708133, 85176.14823851806, 85408.57295713606, 86895.0, 1188.5958774016876, 1209.3469526455792, 1209.661294837447, 1213.805791073424, 1217.7077501399776, 16387.34450621962, 16424.83575164233, 16467.505974820775, 16474.012845795445, 16487.0, 37907.0, 38083.23833523369, 38568.80715596404, 38681.22637547177, 38904.416433754086, 50804.491955079975, 51972.0, 52060.73969630127, 52761.736191320335, 54932.45067549433, 10074.597016119273, 10383.117435018108, 10418.791624167627, 10550.630727924487, 10564.84152737725, 13617.727645446837, 14166.0, 17725.202365893823, 18000.729989049913, 18298.26806927708, 14724.0, 14819.33313000896, 15496.767548486556, 15709.45016924402, 15876.285567149736, 14868.851311486747, 14910.77633835515, 14980.625484362978, 15609.141497217763, 15748.0, 15657.295421706278, 15678.372865085268, 15817.0, 15981.280842362354, 15982.200889955688, 10149.898501014895, 10508.947455262674, 10572.41851698164, 10765.515551800345, 10935.45322733876, 12421.813672795097, 15967.920160399124, 16102.43641472543, 16310.532052115366, 16321.0], "unit": "ms", "name": "jquery.html", "value": 9341.802096751471}, {"lowerIsBetter": false, "replicates": [1592.004996876952, 1606.863416609588, 1643.3590899549174, 1850.4448665400378, 1911.789703132656, 8414.410991230616, 8531.95734021329, 8639.481631102139, 8716.477011379313, 8760.561971901412, 8700.129987001297, 8756.430831995916, 8761.649534018632, 8785.253253473462, 8803.911960880405, 2444.0, 2484.925452236436, 2485.2420011896365, 2493.127405408111, 2494.6756921600168, 2449.8775061246956, 2503.2615378463397, 2514.88683009265, 2515.5723527000455, 2520.243926821955, 2381.2141993142222, 2410.662507248978, 2421.128393778238, 2443.8778061096964, 2455.656208130863, 2396.424858034059, 2409.578323793338, 2415.070197973784, 2417.0, 2440.487497625492, 2388.737238903719, 2413.505231427553, 2436.6710494083427, 2441.206607852437, 2444.8777561121874, 8484.32125429964, 8525.957370213171, 8569.271611912995, 8572.0, 8612.655493780241, 4891.510848915115, 4955.4796746341835, 4993.0263598598285, 5016.824411145592, 5018.197088465828, 3168.3821654777325, 3195.680431956786, 3244.4160051190775, 3254.3653987472453, 3255.332656805373, 987.0721521769585, 998.1166667499243, 999.9950000250025, 1008.2841182760249, 1027.363034918348, 11915.344656043913, 11926.522939082426, 11983.400829958555, 12022.27866328023, 12075.033997280108, 4333.458317710286, 4368.126374725004, 4396.472423309224, 4408.316710909814, 4457.710248833815, 9587.616495340248, 9589.808203836024, 9671.90328096724, 9688.806223875483, 9730.805383892282, 4982.128127577659, 5010.699358038456, 5038.748062596856, 5061.34202553673, 5061.44324124346, 4563.520830312769, 4650.09323181983, 4651.186042442559, 4652.0, 4657.3246879202325, 3517.120719820045, 3587.1749497615697, 3597.1546686528645, 3613.403788374941, 3625.818709064536, 1136.4147464056018, 1143.279733767721, 1150.5397840863554, 1151.7638884028754, 1167.988320116805, 1111.5442668506034, 1127.656064900197, 1185.324365111878, 1350.473315406992, 1403.9578812635636, 7940.444168908121, 7948.324392426708, 8045.758627241192, 8135.267825895698, 8139.186081391814, 1182.3083496154845, 1190.8630507491575, 1199.9520019199308, 1212.1393810394543, 1226.7546490701895, 6311.936880631227, 6323.177986861679, 6360.14138091361, 6386.680665966776, 6424.486041116699, 9843.310968232156, 9884.901150988542, 9911.45486998222, 10036.197104231644, 10097.798044039226, 9585.712428627152, 9773.364731292444, 9800.411975281506, 9878.506074696237, 9880.110790028788, 7896.881546776803, 7968.681252749825, 7995.0, 8007.239312265326, 8043.235892590077, 7731.6520756567215, 7779.57212353326, 7814.531128132103, 7853.489523180975, 7880.093789214085, 8870.911290887267, 9120.771980700536, 9223.12380323895, 9309.394889332172, 9311.953440232755, 8959.686410975584, 9212.263018958602, 9346.20557252641, 9443.622255109993, 9516.19112375428, 7197.71209151628, 7252.927470725436, 7291.197968223385, 7300.598467084362, 7345.045144131229, 7842.725504607311, 7975.5613441261285, 8049.879251811345, 8147.063087744985, 8157.8368432632205, 7249.637518123967, 7334.4132469403385, 7392.704291828267, 7483.363914067365, 7818.257265559762, 7534.35957943581, 7540.0, 7607.391408687403, 7636.198199189227, 7678.692852285846, 7589.051368578927, 7640.885386719315, 7658.617069146632, 7674.0, 7694.499857509244, 6980.825479363057, 6998.020277161303, 7040.0, 7178.28217178278, 7207.783766487014, 6971.477139214478, 6977.441804655514, 7002.229754727078, 7004.509684322048, 7011.298870112948], "unit": "ms", "name": "mootools.html", "value": 4817.3455037894555}, {"lowerIsBetter": false, "replicates": [367.8252829905795, 368.8321813574824, 372.0327149411532, 372.07168115551696, 378.4229050697687, 6312.905306420402, 6335.714892829822, 6369.07648390983, 6445.226572811258, 6460.870782584358, 6284.214473190851, 6380.649064301461, 6397.712102955366, 6400.231972163347, 6403.743850245996, 4849.975750121244, 4863.294822250771, 4870.975645121769, 4873.293372460991, 4886.682365646239, 4891.14404979129, 4891.828785992491, 4894.608431325485, 4896.853094407174, 4903.926441103386, 4688.671792974493, 4713.905721885578, 4805.543473370024, 4814.759262036901, 4877.634177436688, 4783.784729687172, 4805.495422980589, 4811.711297322172, 4819.0602832447685, 4843.4187897452175, 4179.226843034048, 4215.409842622035, 4217.894552636178, 4220.261454245526, 4223.450951376332, 5990.1314309425325, 6006.249218847644, 6016.0, 6030.879382412327, 6036.0945858121195, 5522.972385138049, 5564.749586268587, 5567.081431563787, 5584.385717571064, 5620.690862002588, 6663.833404164886, 6666.866662666719, 6672.966635166842, 6675.766348177839, 6693.531452798306, 4594.379758732562, 4596.7931443085145, 4605.263157894721, 4608.493065762764, 4610.723356598614, 6898.620575868325, 6945.791626251221, 6948.096747422853, 6983.860322793566, 7009.509334346598, 4778.37881075458, 4785.641076919245, 4785.95214047862, 4795.712257264575, 4807.95192048075, 4842.903141937212, 4852.490488498727, 4853.708777473363, 4859.2954021667365, 4866.562009419169, 5596.664200148004, 5597.272354593877, 5603.0, 5625.971870140623, 5628.0713682242795, 6607.108040414482, 6774.153230846145, 6829.692663830139, 6831.829204269933, 6849.760258390932, 1693.0, 1731.3420900057897, 1732.8786984910935, 1733.081466822586, 1736.426979096895, 1152.6311580294225, 1157.9710507237219, 1162.2619636530694, 1175.494537348931, 1192.0880526397314, 6581.3747693969, 6586.5389422739945, 6595.97762346837, 6614.735410583619, 6650.600963942179, 7030.226675065739, 7070.186928503288, 7074.929250707427, 7087.858242835217, 7088.432925366062, 6505.349465053551, 6576.473882089422, 6601.900971485432, 6676.699548520328, 6685.79942601713, 3839.4816699745734, 3845.250176215611, 3860.1507668312925, 3860.3823388257742, 3877.1470276539117, 7296.8175795604475, 7297.3432391084, 7312.1591017033725, 7313.561186328838, 7327.523710958771, 7101.431885449255, 7257.637118144072, 7285.817854553678, 7291.598962057138, 7304.561726296333, 7318.707251709872, 7320.0, 7325.597092159983, 7328.303811137826, 7330.486865919334, 7140.178879428932, 7143.571385716874, 7148.142222933281, 7152.855543113077, 7153.141623005273, 6830.692618832065, 7010.404115650227, 7016.1580610325045, 7021.964890175516, 7036.683349249193, 7315.780526584211, 7328.523645963209, 7337.046183996046, 7340.265973402617, 7345.963270183829, 4851.223804191312, 4866.756662166807, 4888.486708895657, 4889.877753056202, 4909.3372394727685, 6955.513114081966, 7162.964185179041, 7170.605616691132, 7182.6408679564765, 7190.101237345332, 6927.238003819677, 6940.583564986117, 6959.478039146983, 6964.26875178099, 6965.930340696731, 6669.733210671713, 6894.931050689429, 6913.412359949461, 6941.271166527442, 6947.756828510978, 6784.118064651564, 6824.146981627297, 6834.589924604539, 6838.487113466609, 6845.623490708059, 6852.6916288768125, 6912.516123871281, 6935.687894044881, 6950.826229344307, 6985.406240469617, 6610.504212184202, 6741.2921643226755, 6769.323067693192, 6798.286179951034, 6834.760783372558], "unit": "ms", "name": "prototype.html", "value": 5143.062454663402}, {"lowerIsBetter": false, "replicates": [760.6957217113156, 796.5499492786576, 798.7284323330067, 817.8405210983857, 825.7605294464605, 14369.928150359247, 14628.853711462882, 14664.193469359181, 14700.852991470096, 14744.115353078809, 13919.0, 14137.57587272381, 14156.858431415683, 14168.574942751708, 14170.50403235887, 888.3515034025165, 928.9581968811386, 943.8395472769646, 946.2477330522252, 949.4066208619613, 907.841127802632, 919.9724008279762, 923.8752768376283, 923.8937522184967, 924.8289066522715, 965.7392504023909, 979.8481235408487, 986.7483791633124, 990.2127808392345, 990.7077412163393, 962.451402700461, 969.2682025071097, 971.1453920549942, 976.2824324121765, 979.0111986893218, 718.9029481020048, 724.0551080839502, 724.8840185570283, 725.876600977835, 728.4645785347765, 14420.278986050656, 14432.92783536086, 14568.198749068797, 14597.854021459756, 14637.853621463755, 12697.111202215849, 12895.484180632764, 12980.480780768758, 13039.0, 13327.00047496432, 10719.0, 10853.956881131584, 10896.61861834832, 10944.671659850137, 10979.560817567288, 3772.4152756322815, 3789.0, 3867.245887052026, 3881.9029524261837, 3896.337622604136, 49457.25814112791, 49873.25190122151, 50287.74856125732, 50323.49676503225, 50429.0, 10088.293819432569, 10264.743381415525, 10294.948525257325, 10296.536655850505, 10332.121769649513, 18970.0, 18983.62032759337, 18992.52518687044, 19002.1449034791, 19009.429717108233, 7370.520916140434, 7512.474126811071, 7535.73624923125, 7550.7541255693295, 7713.691452341844, 4355.769278634855, 4369.6722745794195, 4408.713433626804, 4428.977855110768, 4450.821967121344, 2977.8064425812254, 3004.6244219472565, 3028.6365636123805, 3030.0, 3040.969590304069, 573.9799107031234, 579.0677010013874, 579.6406228138582, 580.901246788047, 591.8964181268261, 528.8651393894609, 536.6699479819882, 544.104947361588, 588.0825911577953, 650.3334082565408, 8462.36532260083, 8559.358048146414, 8628.266597339296, 8630.611622477003, 8770.3422243332, 621.6798348850346, 670.1857243449233, 693.6046453521545, 696.9686364113627, 701.2776839854957, 4091.284025295561, 4127.876163715094, 4143.482064741907, 4180.623743863067, 4200.85297014603, 59448.10827837586, 59870.0, 60423.697881510314, 60587.69706151441, 60862.087068694, 54176.45823541793, 54645.0, 55803.0, 55822.720886395306, 56506.0, 50859.237111443355, 54144.72927635337, 54289.72855135699, 54588.0, 55158.72420637871, 9130.406523575946, 9330.113639204264, 9345.953270233606, 9493.430394176372, 9496.667616633385, 37591.87224383273, 37935.43096853605, 38893.611063889, 39292.21415571615, 39676.60323396729, 49316.2602560969, 49325.28710920934, 49710.0, 49736.0, 50113.498865010886, 10795.892041079489, 10876.293040952312, 10928.781424371628, 11389.487473063899, 11807.642121156177, 11620.0, 12094.697632558904, 12192.51229950792, 12445.875541244472, 12667.619971400873, 11828.763424731285, 12106.636800895987, 12172.208806427554, 12197.634070977885, 12221.816672750094, 11881.346525940811, 11882.762344752884, 11983.221090629082, 12031.338276394532, 12089.75820483603, 11403.973642371895, 11506.137039722222, 11951.462184201906, 11961.461734222155, 12042.21725587834, 10002.899971000488, 10304.896951030694, 10403.0, 10941.45292735376, 11072.612458563912, 9865.358751681119, 10037.247206459691, 10214.54034568461, 10431.791364172826, 10445.791084178425], "unit": "ms", "name": "yui.html", "value": 6679.395351076753}], "name": "dromaeo_css", "value": 7405.3895374765925}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 110.0, 112.0, 111.0, 121.0, 112.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [154.0, 133.0, 156.0, 155.0, 127.0, 155.0, 157.0, 131.0, 164.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 163.0, 164.0, 164.0, 165.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 73.0, 144.0, 71.0, 73.0, 74.0, 73.0, 152.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 134.0, 93.0, 93.0, 94.0, 138.0, 93.0, 94.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [152.0, 147.0, 148.0, 148.0, 148.0, 146.0, 148.0, 149.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 99.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 63.0, 63.0, 60.0, 60.0, 61.0, 65.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 61.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 63.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 82.0, 82.0, 82.0, 84.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 113.0, 117.0, 120.0, 127.0, 125.0, 124.0, 114.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 156.0, 152.0, 156.0, 135.0, 148.0, 149.0, 148.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 67.0, 66.0, 68.0, 68.0, 76.0, 66.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1515.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.55904481517828], "unit": "score", "name": "Richards", "value": 215.83642799999996}, {"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "DeltaBlue", "value": 394.32775200000015}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [917.4311926605504], "unit": "score", "name": "RayTrace", "value": 806.5880099999997}, {"lowerIsBetter": false, "replicates": [549.4505494505495], "unit": "score", "name": "Earley", "value": 1212.96266}, {"lowerIsBetter": false, "replicates": [11000.0], "unit": "score", "name": "Boyer", "value": 60.58754545454549}, {"lowerIsBetter": false, "replicates": [24000.0], "unit": "score", "name": "RegExp", "value": 37.95770833333335}, {"lowerIsBetter": false, "replicates": [522.7391531625718], "unit": "score", "name": "Splay", "value": 155.89228299999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23281.754231020146}]} 16:55:16 INFO - RETURN: dromaeo_css: 7405.39 16:55:16 INFO - RETURN: kraken: 1515.90 16:55:16 INFO - RETURN: v8_7: 23281.75 16:55:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23281.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1515.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7405.39"}}} 16:55:16 INFO - Return code: 0 16:55:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:55:17 INFO - # TBPL SUCCESS # 16:55:17 INFO - Running post-action listener: _resource_record_post_action 16:55:17 INFO - Running post-run listener: _resource_record_post_run 16:55:18 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 262144; Write bytes: 513306624; Read time: 12; Write time: 556916 16:55:18 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 237830144; Read time: 0; Write time: 365528 16:55:18 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 262144; Write bytes: 275251200; Read time: 12; Write time: 191360 16:55:18 INFO - Running post-run listener: _upload_blobber_files 16:55:18 INFO - Blob upload gear active. 16:55:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:55:18 INFO - Copying logs to upload dir... 16:55:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.256682 ========= master_lag: 301.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 5 secs) (at 2016-01-20 17:00:19.322590) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2016-01-20 17:00:19.326248) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009951 build_url: 'https://queue.taskcluster.net/v1/task/0_COgSGkRpqoUMIimGVM8Q/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 1.52 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2016-01-20 17:00:20.852622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 30 secs) (at 2016-01-20 17:00:20.853049) ========= 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=52faae308a556c440401f8e5000001e8-1453334567.187015-306003937 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 90.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 30 secs) (at 2016-01-20 17:01:51.010706) ========= ========= Started reboot skipped (results: 3, elapsed: 59 mins, 39 secs) (at 2016-01-20 17:01:51.011043) ========= ========= Finished reboot skipped (results: 3, elapsed: 59 mins, 39 secs) (at 2016-01-20 18:01:30.693699) ========= ========= Total master_lag: 393.38 =========