builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1453510389.13 results: success (0) buildid: 20160122143630 builduid: 1d52b401dee44679bd1c28b512ed59b0 revision: 23056818e2a5759d863da75aa6e7c9fd104d9350 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.129158) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.129846) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.130369) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.155293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.155560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.170398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.170670) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.219685) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.219947) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.220290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.220557) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 16:53:09-- 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% 35.6M=0s 2016-01-22 16:53:09 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152688 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.385197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.385500) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020982 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.435057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.435437) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 23056818e2a5759d863da75aa6e7c9fd104d9350 --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 23056818e2a5759d863da75aa6e7c9fd104d9350 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 16:53:09,558 truncating revision to first 12 chars 2016-01-22 16:53:09,558 Setting DEBUG logging. 2016-01-22 16:53:09,558 attempt 1/10 2016-01-22 16:53:09,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/23056818e2a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 16:53:09,800 unpacking tar archive at: mozilla-aurora-23056818e2a5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535606 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.984928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:09.985320) ========= echo 23056818e2a5759d863da75aa6e7c9fd104d9350 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'23056818e2a5759d863da75aa6e7c9fd104d9350'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23056818e2a5759d863da75aa6e7c9fd104d9350 program finished with exit code 0 elapsedTime=0.004622 script_repo_revision: '23056818e2a5759d863da75aa6e7c9fd104d9350' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:10.036259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:10.036608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 16:53:10.046923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 16:53:10.047287) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:10 INFO - MultiFileLogger online at 20160122 16:53:10 in /builds/slave/test-pgo 16:53:10 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:53:10 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:53:10 INFO - {'append_to_log': False, 16:53:10 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:53:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:53:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:53:10 INFO - 'branch': 'Mozilla-Aurora', 16:53:10 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:10 INFO - 'config_files': ('talos/linux_config.py',), 16:53:10 INFO - 'default_actions': ('clobber', 16:53:10 INFO - 'read-buildbot-config', 16:53:10 INFO - 'download-and-extract', 16:53:10 INFO - 'populate-webroot', 16:53:10 INFO - 'create-virtualenv', 16:53:10 INFO - 'install', 16:53:10 INFO - 'run-tests'), 16:53:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:10 INFO - 'download_minidump_stackwalk': True, 16:53:10 INFO - 'download_symbols': 'ondemand', 16:53:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:10 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:10 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:10 INFO - 'installer_path': 'installer.exe', 16:53:10 INFO - 'log_level': 'info', 16:53:10 INFO - 'log_name': 'talos', 16:53:10 INFO - 'log_to_console': True, 16:53:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:10 INFO - 'opt_config_files': (), 16:53:10 INFO - 'pip_index': False, 16:53:10 INFO - 'sps_profile': False, 16:53:10 INFO - 'sps_profile_interval': 0, 16:53:10 INFO - 'suite': 'dromaeojs-e10s', 16:53:10 INFO - 'system_bits': '32', 16:53:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:10 INFO - 'title': 'talos-linux64-ix-022', 16:53:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:10 INFO - 'use_talos_json': True, 16:53:10 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:53:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:10 INFO - 'work_dir': 'build'} 16:53:10 INFO - ##### 16:53:10 INFO - ##### Running clobber step. 16:53:10 INFO - ##### 16:53:10 INFO - Running pre-action listener: _resource_record_pre_action 16:53:10 INFO - Running main action method: clobber 16:53:10 INFO - rmtree: /builds/slave/test-pgo/build 16:53:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:53:11 INFO - Running post-action listener: _resource_record_post_action 16:53:11 INFO - ##### 16:53:11 INFO - ##### Running read-buildbot-config step. 16:53:11 INFO - ##### 16:53:11 INFO - Running pre-action listener: _resource_record_pre_action 16:53:11 INFO - Running main action method: read_buildbot_config 16:53:11 INFO - Using buildbot properties: 16:53:11 INFO - { 16:53:11 INFO - "properties": { 16:53:11 INFO - "buildnumber": 74, 16:53:11 INFO - "product": "firefox", 16:53:11 INFO - "script_repo_revision": "production", 16:53:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:53:11 INFO - "repository": "", 16:53:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:53:11 INFO - "buildid": "20160122143630", 16:53:11 INFO - "slavename": "talos-linux64-ix-022", 16:53:11 INFO - "pgo_build": "True", 16:53:11 INFO - "basedir": "/builds/slave/test-pgo", 16:53:11 INFO - "project": "", 16:53:11 INFO - "platform": "ubuntu64_hw", 16:53:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:53:11 INFO - "slavebuilddir": "test", 16:53:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:53:11 INFO - "branch": "mozilla-aurora", 16:53:11 INFO - "repo_path": "releases/mozilla-aurora", 16:53:11 INFO - "stage_platform": "linux64-pgo", 16:53:11 INFO - "builduid": "1d52b401dee44679bd1c28b512ed59b0", 16:53:11 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:11 INFO - }, 16:53:11 INFO - "sourcestamp": { 16:53:11 INFO - "repository": "", 16:53:11 INFO - "hasPatch": false, 16:53:11 INFO - "project": "", 16:53:11 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:53:11 INFO - "changes": [ 16:53:11 INFO - { 16:53:11 INFO - "category": null, 16:53:11 INFO - "files": [ 16:53:11 INFO - { 16:53:11 INFO - "url": null, 16:53:11 INFO - "name": "https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 16:53:11 INFO - } 16:53:11 INFO - ], 16:53:11 INFO - "repository": "", 16:53:11 INFO - "rev": "23056818e2a5759d863da75aa6e7c9fd104d9350", 16:53:11 INFO - "who": "kwierso@gmail.com", 16:53:11 INFO - "when": 1453510365, 16:53:11 INFO - "number": 7503817, 16:53:11 INFO - "comments": "Backout changeset 8bbed05c1661 r=bz a=lizzard", 16:53:11 INFO - "project": "", 16:53:11 INFO - "at": "Fri 22 Jan 2016 16:52:45", 16:53:11 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 16:53:11 INFO - "revlink": "", 16:53:11 INFO - "properties": [ 16:53:11 INFO - [ 16:53:11 INFO - "buildid", 16:53:11 INFO - "20160122143630", 16:53:11 INFO - "Change" 16:53:11 INFO - ], 16:53:11 INFO - [ 16:53:11 INFO - "builduid", 16:53:11 INFO - "1d52b401dee44679bd1c28b512ed59b0", 16:53:11 INFO - "Change" 16:53:11 INFO - ], 16:53:11 INFO - [ 16:53:11 INFO - "pgo_build", 16:53:11 INFO - "True", 16:53:11 INFO - "Change" 16:53:11 INFO - ] 16:53:11 INFO - ], 16:53:11 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:11 INFO - } 16:53:11 INFO - ], 16:53:11 INFO - "revision": "23056818e2a5759d863da75aa6e7c9fd104d9350" 16:53:11 INFO - } 16:53:11 INFO - } 16:53:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 16:53:11 INFO - Running post-action listener: _resource_record_post_action 16:53:11 INFO - ##### 16:53:11 INFO - ##### Running download-and-extract step. 16:53:11 INFO - ##### 16:53:11 INFO - Running pre-action listener: _resource_record_pre_action 16:53:11 INFO - Running main action method: download_and_extract 16:53:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:53:11 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:53:11 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json 16:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json 16:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:53:11 INFO - Downloaded 1302 bytes. 16:53:11 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:53:11 INFO - Using the following test package requirements: 16:53:11 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:11 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:53:11 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'jsshell-linux-x86_64.zip'], 16:53:11 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:53:11 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:11 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:53:11 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:53:11 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:53:11 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 16:53:11 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 16:53:11 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:53:11 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:53:11 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:53:11 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:14 INFO - Downloaded 23158855 bytes. 16:53:14 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:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:14 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:53:15 INFO - Return code: 0 16:53:15 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:53:15 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:53:15 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:19 INFO - Downloaded 23158855 bytes. 16:53:19 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:53:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 16:53:19 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:53:20 INFO - Return code: 0 16:53:20 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:53:20 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:22 INFO - Downloaded 11132038 bytes. 16:53:22 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:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 16:53:22 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:53:22 INFO - Return code: 0 16:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:22 INFO - https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d3frCFZqQnedfRj-qSZmPA/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:53:24 INFO - Downloaded 58014398 bytes. 16:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:24 INFO - mkdir: /builds/slave/test-pgo/properties 16:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:53:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:53:24 INFO - Contents: 16:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 16:53:24 INFO - Running post-action listener: _resource_record_post_action 16:53:24 INFO - Running post-action listener: set_extra_try_arguments 16:53:24 INFO - ##### 16:53:24 INFO - ##### Running populate-webroot step. 16:53:24 INFO - ##### 16:53:24 INFO - Running pre-action listener: _resource_record_pre_action 16:53:24 INFO - Running main action method: populate_webroot 16:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:24 INFO - '--tppagecycles', 16:53:24 INFO - '7'], 16:53:24 INFO - 'tests': ['tsvgm']}}, 16:53:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:53:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:53:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'tests': ['damp', 'tps']}, 16:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['damp', 'tps']}, 16:53:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:24 INFO - 'other': {'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'other_l64': {'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'other_nol64': {'tests': ['a11yr', 16:53:24 INFO - 'ts_paint', 16:53:24 INFO - 'tpaint', 16:53:24 INFO - 'sessionrestore', 16:53:24 INFO - 'sessionrestore_no_auto_restore']}, 16:53:24 INFO - 'svgr': {'tests': ['tsvgx', 16:53:24 INFO - 'tsvgr_opacity', 16:53:24 INFO - 'tart', 16:53:24 INFO - 'tscrollx', 16:53:24 INFO - 'cart']}, 16:53:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['tsvgx', 16:53:24 INFO - 'tsvgr_opacity', 16:53:24 INFO - 'tart', 16:53:24 INFO - 'tscrollx', 16:53:24 INFO - 'cart']}, 16:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'tests': ['tp5o']}, 16:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'talos_options': ['--e10s'], 16:53:24 INFO - 'tests': ['tp5o']}, 16:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'talos_options': ['--xperf_path', 16:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:24 INFO - 'tests': ['tp5n']}, 16:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:53:24 INFO - 'talos_options': ['--e10s', 16:53:24 INFO - '--xperf_path', 16:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:24 INFO - 'tests': ['tp5n']}}, 16:53:24 INFO - 'talos.zip': {'path': '', 16:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:24 INFO - Running post-action listener: _resource_record_post_action 16:53:24 INFO - ##### 16:53:24 INFO - ##### Running create-virtualenv step. 16:53:24 INFO - ##### 16:53:24 INFO - Running pre-action listener: _resource_record_pre_action 16:53:24 INFO - Running main action method: create_virtualenv 16:53:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:53:24 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:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:53:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:24 INFO - Using real prefix '/usr' 16:53:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:53:25 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:26 INFO - Installing pip.................done. 16:53:27 INFO - Return code: 0 16:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:53: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:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:27 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:27 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:53:27 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:53:27 INFO - Using env: {'DISPLAY': ':0', 16:53:27 INFO - 'HOME': '/home/cltbld', 16:53:27 INFO - 'LANG': 'en_US.UTF-8', 16:53:27 INFO - 'LANGUAGE': 'en_US:en', 16:53:27 INFO - 'LOGNAME': 'cltbld', 16:53:27 INFO - 'MAIL': '/var/mail/cltbld', 16:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:27 INFO - 'MOZ_NO_REMOTE': '1', 16:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:27 INFO - 'NO_EM_RESTART': '1', 16:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:27 INFO - 'SHELL': '/bin/bash', 16:53:27 INFO - 'SHLVL': '1', 16:53:27 INFO - 'TERM': 'linux', 16:53:27 INFO - 'TMOUT': '86400', 16:53:27 INFO - 'USER': 'cltbld', 16:53:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:27 INFO - '_': '/tools/buildbot/bin/python'} 16:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:27 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:53:27 INFO - Cleaning up... 16:53:27 INFO - Return code: 0 16:53:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:53: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:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:27 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:27 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:53:27 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:53:27 INFO - Using env: {'DISPLAY': ':0', 16:53:27 INFO - 'HOME': '/home/cltbld', 16:53:27 INFO - 'LANG': 'en_US.UTF-8', 16:53:27 INFO - 'LANGUAGE': 'en_US:en', 16:53:27 INFO - 'LOGNAME': 'cltbld', 16:53:27 INFO - 'MAIL': '/var/mail/cltbld', 16:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:27 INFO - 'MOZ_NO_REMOTE': '1', 16:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:27 INFO - 'NO_EM_RESTART': '1', 16:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:27 INFO - 'SHELL': '/bin/bash', 16:53:27 INFO - 'SHLVL': '1', 16:53:27 INFO - 'TERM': 'linux', 16:53:27 INFO - 'TMOUT': '86400', 16:53:27 INFO - 'USER': 'cltbld', 16:53:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:27 INFO - '_': '/tools/buildbot/bin/python'} 16:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:27 INFO - Downloading/unpacking psutil>=0.7.1 16:53:27 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:53:27 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:53:27 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:53:27 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:53:27 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:53:27 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:53:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:29 INFO - Installing collected packages: psutil 16:53:29 INFO - Running setup.py install for psutil 16:53:29 INFO - building 'psutil._psutil_linux' extension 16:53:29 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:53:29 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:53:29 INFO - building 'psutil._psutil_posix' extension 16:53:29 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:53:29 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:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:29 INFO - Successfully installed psutil 16:53:29 INFO - Cleaning up... 16:53:29 INFO - Return code: 0 16:53:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:53:29 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:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:29 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:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:29 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:29 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:53:29 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:53:29 INFO - Using env: {'DISPLAY': ':0', 16:53:29 INFO - 'HOME': '/home/cltbld', 16:53:29 INFO - 'LANG': 'en_US.UTF-8', 16:53:29 INFO - 'LANGUAGE': 'en_US:en', 16:53:29 INFO - 'LOGNAME': 'cltbld', 16:53:29 INFO - 'MAIL': '/var/mail/cltbld', 16:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:29 INFO - 'MOZ_NO_REMOTE': '1', 16:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:29 INFO - 'NO_EM_RESTART': '1', 16:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:29 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:29 INFO - 'SHELL': '/bin/bash', 16:53:29 INFO - 'SHLVL': '1', 16:53:29 INFO - 'TERM': 'linux', 16:53:29 INFO - 'TMOUT': '86400', 16:53:29 INFO - 'USER': 'cltbld', 16:53:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:29 INFO - '_': '/tools/buildbot/bin/python'} 16:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:53:30 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:53:30 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:53:30 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:53:30 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:53:30 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:53:30 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:53:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:53:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:32 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:53:32 INFO - Installing collected packages: mozsystemmonitor 16:53:32 INFO - Running setup.py install for mozsystemmonitor 16:53:32 INFO - Successfully installed mozsystemmonitor 16:53:32 INFO - Cleaning up... 16:53:32 INFO - Return code: 0 16:53:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:53: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:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53: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', '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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:53: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 blobuploader==1.2.4 16:53:32 INFO - Using env: {'DISPLAY': ':0', 16:53:32 INFO - 'HOME': '/home/cltbld', 16:53:32 INFO - 'LANG': 'en_US.UTF-8', 16:53:32 INFO - 'LANGUAGE': 'en_US:en', 16:53:32 INFO - 'LOGNAME': 'cltbld', 16:53:32 INFO - 'MAIL': '/var/mail/cltbld', 16:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:32 INFO - 'MOZ_NO_REMOTE': '1', 16:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:32 INFO - 'NO_EM_RESTART': '1', 16:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:32 INFO - 'SHELL': '/bin/bash', 16:53:32 INFO - 'SHLVL': '1', 16:53:32 INFO - 'TERM': 'linux', 16:53:32 INFO - 'TMOUT': '86400', 16:53:32 INFO - 'USER': 'cltbld', 16:53:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:32 INFO - '_': '/tools/buildbot/bin/python'} 16:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:32 INFO - Downloading/unpacking blobuploader==1.2.4 16:53: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:53: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:53: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:53: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:53: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:53: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:53:34 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:34 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:53:34 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:53:34 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:53:34 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:53:34 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:53:34 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:53:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:53:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:34 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:53:34 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:53:34 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:53:34 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:53:34 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:53:34 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:53:35 INFO - Downloading docopt-0.6.1.tar.gz 16:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:35 INFO - Running setup.py install for blobuploader 16:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:53:35 INFO - Running setup.py install for requests 16:53:35 INFO - Running setup.py install for docopt 16:53:35 INFO - Successfully installed blobuploader requests docopt 16:53:35 INFO - Cleaning up... 16:53:35 INFO - Return code: 0 16:53:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:35 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:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:35 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:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:35 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:35 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:53:35 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:53:35 INFO - Using env: {'DISPLAY': ':0', 16:53:35 INFO - 'HOME': '/home/cltbld', 16:53:35 INFO - 'LANG': 'en_US.UTF-8', 16:53:35 INFO - 'LANGUAGE': 'en_US:en', 16:53:35 INFO - 'LOGNAME': 'cltbld', 16:53:35 INFO - 'MAIL': '/var/mail/cltbld', 16:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:35 INFO - 'MOZ_NO_REMOTE': '1', 16:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:35 INFO - 'NO_EM_RESTART': '1', 16:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:35 INFO - 'SHELL': '/bin/bash', 16:53:35 INFO - 'SHLVL': '1', 16:53:35 INFO - 'TERM': 'linux', 16:53:35 INFO - 'TMOUT': '86400', 16:53:35 INFO - 'USER': 'cltbld', 16:53:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:35 INFO - '_': '/tools/buildbot/bin/python'} 16:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:36 INFO - Running setup.py (path:/tmp/pip-q1NLwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:36 INFO - Running setup.py (path:/tmp/pip-UVS4NC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:36 INFO - Running setup.py (path:/tmp/pip-XmNeFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:36 INFO - Running setup.py (path:/tmp/pip-0UDxFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:36 INFO - Running setup.py (path:/tmp/pip-H444rI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:36 INFO - Running setup.py (path:/tmp/pip-nJBHBF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:36 INFO - Running setup.py (path:/tmp/pip-242Kqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:36 INFO - Running setup.py (path:/tmp/pip-GGoNwJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:36 INFO - Running setup.py (path:/tmp/pip-zGnTKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:36 INFO - Running setup.py (path:/tmp/pip-PbLBQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:36 INFO - Running setup.py (path:/tmp/pip-_GSBgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:36 INFO - Running setup.py (path:/tmp/pip-t6sE26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:36 INFO - Running setup.py (path:/tmp/pip-La0wU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:36 INFO - Running setup.py (path:/tmp/pip-pBJYOx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:36 INFO - Running setup.py (path:/tmp/pip-31Gm5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:37 INFO - Running setup.py (path:/tmp/pip-p3TvoQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:37 INFO - Running setup.py (path:/tmp/pip-RnWVAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:37 INFO - Running setup.py install for manifestparser 16:53:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:53:37 INFO - Running setup.py install for mozcrash 16:53:37 INFO - Running setup.py install for mozdebug 16:53:37 INFO - Running setup.py install for mozdevice 16:53:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:53:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:53:37 INFO - Running setup.py install for mozfile 16:53:37 INFO - Running setup.py install for mozhttpd 16:53:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:53:37 INFO - Running setup.py install for mozinfo 16:53:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:53:37 INFO - Running setup.py install for mozInstall 16:53:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozleak 16:53:38 INFO - Running setup.py install for mozlog 16:53:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for moznetwork 16:53:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozprocess 16:53:38 INFO - Running setup.py install for mozprofile 16:53:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozrunner 16:53:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Running setup.py install for mozscreenshot 16:53:38 INFO - Running setup.py install for moztest 16:53:38 INFO - Running setup.py install for mozversion 16:53:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:53:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:38 INFO - Cleaning up... 16:53:38 INFO - Return code: 0 16:53:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:38 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:38 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:53:38 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:53:39 INFO - Using env: {'DISPLAY': ':0', 16:53:39 INFO - 'HOME': '/home/cltbld', 16:53:39 INFO - 'LANG': 'en_US.UTF-8', 16:53:39 INFO - 'LANGUAGE': 'en_US:en', 16:53:39 INFO - 'LOGNAME': 'cltbld', 16:53:39 INFO - 'MAIL': '/var/mail/cltbld', 16:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:39 INFO - 'MOZ_NO_REMOTE': '1', 16:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:39 INFO - 'NO_EM_RESTART': '1', 16:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:39 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:39 INFO - 'SHELL': '/bin/bash', 16:53:39 INFO - 'SHLVL': '1', 16:53:39 INFO - 'TERM': 'linux', 16:53:39 INFO - 'TMOUT': '86400', 16:53:39 INFO - 'USER': 'cltbld', 16:53:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:39 INFO - '_': '/tools/buildbot/bin/python'} 16:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:39 INFO - Running setup.py (path:/tmp/pip-9BsIBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:39 INFO - Running setup.py (path:/tmp/pip-YRFAuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:39 INFO - Running setup.py (path:/tmp/pip-9I_LOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:39 INFO - Running setup.py (path:/tmp/pip-lGg3nh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:39 INFO - Running setup.py (path:/tmp/pip-DyZay4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:39 INFO - Running setup.py (path:/tmp/pip-W95k6T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:39 INFO - Running setup.py (path:/tmp/pip-hRrBBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:39 INFO - Running setup.py (path:/tmp/pip-6tvXQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:39 INFO - Running setup.py (path:/tmp/pip-vom6FB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:39 INFO - Running setup.py (path:/tmp/pip-8dOSIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:53:39 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:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:39 INFO - Running setup.py (path:/tmp/pip-fGPkxQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:40 INFO - Running setup.py (path:/tmp/pip-xaOiHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:40 INFO - Running setup.py (path:/tmp/pip-M6YbYC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:40 INFO - Running setup.py (path:/tmp/pip-vwYSGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:40 INFO - Running setup.py (path:/tmp/pip-Qm1chm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:40 INFO - Running setup.py (path:/tmp/pip-MNJGX_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:53:40 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:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:40 INFO - Running setup.py (path:/tmp/pip-PMBDyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:53:40 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:53:40 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:53:40 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:53:40 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:53:40 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:53:40 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:53:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:40 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:53:40 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:53:40 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:53:40 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:53:40 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:53:40 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:53:42 INFO - Downloading blessings-1.6.tar.gz 16:53:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:42 INFO - Installing collected packages: blessings 16:53:42 INFO - Running setup.py install for blessings 16:53:42 INFO - Successfully installed blessings 16:53:42 INFO - Cleaning up... 16:53:42 INFO - Return code: 0 16:53:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:53:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:42 INFO - Reading from file tmpfile_stdout 16:53:42 INFO - Current package versions: 16:53:42 INFO - argparse == 1.2.1 16:53:42 INFO - blessings == 1.6 16:53:42 INFO - blobuploader == 1.2.4 16:53:42 INFO - docopt == 0.6.1 16:53:42 INFO - manifestparser == 1.1 16:53:42 INFO - mozInstall == 1.12 16:53:42 INFO - mozcrash == 0.16 16:53:42 INFO - mozdebug == 0.1 16:53:42 INFO - mozdevice == 0.47 16:53:42 INFO - mozfile == 1.2 16:53:42 INFO - mozhttpd == 0.7 16:53:42 INFO - mozinfo == 0.9 16:53:42 INFO - mozleak == 0.1 16:53:42 INFO - mozlog == 3.1 16:53:42 INFO - moznetwork == 0.27 16:53:42 INFO - mozprocess == 0.22 16:53:42 INFO - mozprofile == 0.27 16:53:42 INFO - mozrunner == 6.11 16:53:42 INFO - mozscreenshot == 0.1 16:53:42 INFO - mozsystemmonitor == 0.0 16:53:42 INFO - moztest == 0.7 16:53:42 INFO - mozversion == 1.4 16:53:42 INFO - psutil == 3.1.1 16:53:42 INFO - requests == 1.2.3 16:53:42 INFO - wsgiref == 0.1.2 16:53:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:53:42 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:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:42 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:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:42 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:42 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:53:42 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:53:42 INFO - Using env: {'DISPLAY': ':0', 16:53:42 INFO - 'HOME': '/home/cltbld', 16:53:42 INFO - 'LANG': 'en_US.UTF-8', 16:53:42 INFO - 'LANGUAGE': 'en_US:en', 16:53:42 INFO - 'LOGNAME': 'cltbld', 16:53:42 INFO - 'MAIL': '/var/mail/cltbld', 16:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:42 INFO - 'MOZ_NO_REMOTE': '1', 16:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:42 INFO - 'NO_EM_RESTART': '1', 16:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:42 INFO - 'SHELL': '/bin/bash', 16:53:42 INFO - 'SHLVL': '1', 16:53:42 INFO - 'TERM': 'linux', 16:53:42 INFO - 'TMOUT': '86400', 16:53:42 INFO - 'USER': 'cltbld', 16:53:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:42 INFO - '_': '/tools/buildbot/bin/python'} 16:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 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:53:42 INFO - Cleaning up... 16:53:42 INFO - Return code: 0 16:53:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:53:42 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:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:42 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:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:42 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:42 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:53:42 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:53:42 INFO - Using env: {'DISPLAY': ':0', 16:53:42 INFO - 'HOME': '/home/cltbld', 16:53:42 INFO - 'LANG': 'en_US.UTF-8', 16:53:42 INFO - 'LANGUAGE': 'en_US:en', 16:53:42 INFO - 'LOGNAME': 'cltbld', 16:53:42 INFO - 'MAIL': '/var/mail/cltbld', 16:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:42 INFO - 'MOZ_NO_REMOTE': '1', 16:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:42 INFO - 'NO_EM_RESTART': '1', 16:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:42 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:42 INFO - 'SHELL': '/bin/bash', 16:53:42 INFO - 'SHLVL': '1', 16:53:42 INFO - 'TERM': 'linux', 16:53:42 INFO - 'TMOUT': '86400', 16:53:42 INFO - 'USER': 'cltbld', 16:53:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:42 INFO - '_': '/tools/buildbot/bin/python'} 16:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:43 INFO - Downloading/unpacking jsonschema 16:53:43 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:53:43 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:53:43 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:53:43 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:53:43 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:53:43 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:53:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:44 INFO - Downloading/unpacking functools32 (from jsonschema) 16:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:45 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:45 INFO - warning: no files found matching '*.txt' 16:53:45 INFO - no previously-included directories found matching 'build' 16:53:45 INFO - no previously-included directories found matching 'dist' 16:53:45 INFO - no previously-included directories found matching '.git*' 16:53:45 INFO - Installing collected packages: jsonschema, functools32 16:53:45 INFO - Running setup.py install for functools32 16:53:45 INFO - warning: no files found matching '*.txt' 16:53:45 INFO - no previously-included directories found matching 'build' 16:53:45 INFO - no previously-included directories found matching 'dist' 16:53:45 INFO - no previously-included directories found matching '.git*' 16:53:45 INFO - Successfully installed jsonschema functools32 16:53:45 INFO - Cleaning up... 16:53:45 INFO - Return code: 0 16:53:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:53:45 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 0x7f04f2e46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ec450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', '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:53:45 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:53:45 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:53:45 INFO - Using env: {'DISPLAY': ':0', 16:53:45 INFO - 'HOME': '/home/cltbld', 16:53:45 INFO - 'LANG': 'en_US.UTF-8', 16:53:45 INFO - 'LANGUAGE': 'en_US:en', 16:53:45 INFO - 'LOGNAME': 'cltbld', 16:53:45 INFO - 'MAIL': '/var/mail/cltbld', 16:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:45 INFO - 'MOZ_NO_REMOTE': '1', 16:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:45 INFO - 'NO_EM_RESTART': '1', 16:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:53:45 INFO - 'SHELL': '/bin/bash', 16:53:45 INFO - 'SHLVL': '1', 16:53:45 INFO - 'TERM': 'linux', 16:53:45 INFO - 'TMOUT': '86400', 16:53:45 INFO - 'USER': 'cltbld', 16:53:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:45 INFO - '_': '/tools/buildbot/bin/python'} 16:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:45 INFO - Downloading/unpacking flake8 16:53: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:53: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:53: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:53: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:53: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:53: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:53:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:53:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:53:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:53: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:53: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:53: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:53: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:53: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:53: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:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:47 INFO - no previously-included directories found matching 'docs/_build' 16:53:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:53:48 INFO - Running setup.py install for pep8 16:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:53:48 INFO - no previously-included directories found matching 'docs/_build' 16:53:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:53:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:53:48 INFO - Cleaning up... 16:53:48 INFO - Return code: 0 16:53:48 INFO - Running post-action listener: _resource_record_post_action 16:53:48 INFO - Running post-action listener: _start_resource_monitoring 16:53:48 INFO - Starting resource monitoring. 16:53:48 INFO - ##### 16:53:48 INFO - ##### Running install step. 16:53:48 INFO - ##### 16:53:48 INFO - Running pre-action listener: _resource_record_pre_action 16:53:48 INFO - Running main action method: install 16:53:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:53:48 INFO - Reading from file tmpfile_stdout 16:53:48 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:53:48 INFO - Reading from file tmpfile_stdout 16:53:48 INFO - Output received: 16:53:48 INFO - Usage: mozinstall [options] installer 16:53:48 INFO - Options: 16:53:48 INFO - -h, --help show this help message and exit 16:53:48 INFO - -d DEST, --destination=DEST 16:53:48 INFO - Directory to install application into. [default: 16:53:48 INFO - "/builds/slave/test-pgo"] 16:53:48 INFO - --app=APP Application being installed. [default: firefox] 16:53:48 INFO - mkdir: /builds/slave/test-pgo/build/application 16:53:48 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:53:48 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:54:03 INFO - Reading from file tmpfile_stdout 16:54:03 INFO - Output received: 16:54:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:54:03 INFO - Running post-action listener: _resource_record_post_action 16:54:03 INFO - ##### 16:54:03 INFO - ##### Running run-tests step. 16:54:03 INFO - ##### 16:54:03 INFO - Running pre-action listener: _resource_record_pre_action 16:54:03 INFO - Running main action method: run_tests 16:54:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:54:03 INFO - Python 2.7.3 16:54:03 INFO - Return code: 0 16:54:03 INFO - grabbing minidump binary from tooltool 16:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:03 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 0x197ea50>, '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 0x18ea550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:54:03 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:54:03 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:54:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:03 INFO - Return code: 0 16:54:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:54:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:54:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:54:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:54:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:54:04 INFO - Return code: 0 16:54:04 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/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 16:54:04 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/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 16:54:04 INFO - Using env: {'DISPLAY': ':0', 16:54:04 INFO - 'HOME': '/home/cltbld', 16:54:04 INFO - 'LANG': 'en_US.UTF-8', 16:54:04 INFO - 'LANGUAGE': 'en_US:en', 16:54:04 INFO - 'LOGNAME': 'cltbld', 16:54:04 INFO - 'MAIL': '/var/mail/cltbld', 16:54:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:04 INFO - 'MOZ_NO_REMOTE': '1', 16:54:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:04 INFO - 'NO_EM_RESTART': '1', 16:54:04 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:54:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:54:04 INFO - 'SHELL': '/bin/bash', 16:54:04 INFO - 'SHLVL': '1', 16:54:04 INFO - 'TERM': 'linux', 16:54:04 INFO - 'TMOUT': '86400', 16:54:04 INFO - 'USER': 'cltbld', 16:54:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584', 16:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:04 INFO - '_': '/tools/buildbot/bin/python'} 16:54:04 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/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 16:54:04 INFO - mozversion INFO | application_buildid: 20160122143630 16:54:04 INFO - mozversion INFO | application_changeset: 23056818e2a5759d863da75aa6e7c9fd104d9350 16:54:04 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 16:54:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:04 INFO - mozversion INFO | application_name: Firefox 16:54:04 INFO - mozversion INFO | application_remotingname: firefox-dev 16:54:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:54:04 INFO - mozversion INFO | application_vendor: Mozilla 16:54:04 INFO - mozversion INFO | application_version: 45.0a2 16:54:04 INFO - mozversion INFO | platform_buildid: 20160122143630 16:54:04 INFO - mozversion INFO | platform_changeset: 23056818e2a5759d863da75aa6e7c9fd104d9350 16:54:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:54:04 INFO - mozversion INFO | platform_version: 45.0a2 16:54:04 INFO - 2016-01-22 16:54:04,394 DEBUG : using testdate: 1453510444 16:54:04 INFO - 2016-01-22 16:54:04,394 DEBUG : actual date: 1453510444 16:54:04 INFO - 2016-01-22 16:54:04,403 INFO : starting webserver on 'localhost:56565' 16:54:04 INFO - 2016-01-22 16:54:04,404 INFO : Starting test suite talos-linux64-ix-022.e 16:54:04 INFO - 2016-01-22 16:54:04,405 INFO : Starting test dromaeo_css 16:54:04 INFO - 2016-01-22 16:54:04,405 DEBUG : operating with platform_type : linux_ 16:54:04 INFO - 2016-01-22 16:54:04,405 INFO : Initialising browser for dromaeo_css test... 16:54:04 INFO - 2016-01-22 16:54:04,419 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVdeV41/profile http://localhost:56565/getInfo.html 16:54:08 INFO - 2016-01-22 16:54:08,200 DEBUG : BROWSER_OUTPUT: 16:54:08 INFO - 2016-01-22 16:54:08,201 DEBUG : BROWSER_OUTPUT: (process:10723): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:09 INFO - 2016-01-22 16:54:09,104 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:54:09 INFO - 2016-01-22 16:54:09,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:54:09 INFO - 2016-01-22 16:54:09,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:54:09 INFO - 2016-01-22 16:54:09,105 DEBUG : BROWSER_OUTPUT: __metrics 16:54:10 INFO - 2016-01-22 16:54:10,105 INFO : Browser initialized. 16:54:10 INFO - 2016-01-22 16:54:10,106 INFO : Running cycle 1/1 for dromaeo_css test... 16:54:10 INFO - 2016-01-22 16:54:10,106 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVdeV41/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:54:11 INFO - 2016-01-22 16:54:11,402 DEBUG : BROWSER_OUTPUT: 16:54:11 INFO - 2016-01-22 16:54:11,403 DEBUG : BROWSER_OUTPUT: (process:10836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:54:21 INFO - 2016-01-22 16:54:21,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 138080256 16:54:21 INFO - 2016-01-22 16:54:21,914 DEBUG : BROWSER_OUTPUT: 16:55:11 INFO - 2016-01-22 16:55:11,516 DEBUG : BROWSER_OUTPUT: 1453510511515 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:57:19 INFO - 2016-01-22 16:57:19,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56565/tests/dromaeo/cssquery-ext.html) 16:57:20 INFO - 2016-01-22 16:57:20,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 142475264 16:57:20 INFO - 2016-01-22 16:57:20,146 DEBUG : BROWSER_OUTPUT: 17:00:21 INFO - 2016-01-22 17:00:21,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-ext.html (next: http://localhost:56565/tests/dromaeo/cssquery-jquery.html) 17:00:22 INFO - 2016-01-22 17:00:22,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 140206080 17:00:22 INFO - 2016-01-22 17:00:22,499 DEBUG : BROWSER_OUTPUT: 17:03:24 INFO - 2016-01-22 17:03:24,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56565/tests/dromaeo/cssquery-mootools.html) 17:03:24 INFO - 2016-01-22 17:03:24,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 17:03:24 INFO - 2016-01-22 17:03:24,662 DEBUG : BROWSER_OUTPUT: 17:06:26 INFO - 2016-01-22 17:06:26,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56565/tests/dromaeo/cssquery-prototype.html) 17:06:26 INFO - 2016-01-22 17:06:26,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 139427840 17:06:26 INFO - 2016-01-22 17:06:26,839 DEBUG : BROWSER_OUTPUT: 17:09:29 INFO - 2016-01-22 17:09:29,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56565/tests/dromaeo/cssquery-yui.html) 17:09:29 INFO - 2016-01-22 17:09:29,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 140161024 17:09:29 INFO - 2016-01-22 17:09:29,668 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/dromaeo/cssquery-yui.html (next: http://localhost:56565/tests/dromaeo/cssquery-dojo.html) 17:12:31 INFO - 2016-01-22 17:12:31,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 142520320 17:12:31 INFO - 2016-01-22 17:12:31,922 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,922 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:12:31 INFO - 2016-01-22 17:12:31,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:12:31 INFO - 2016-01-22 17:12:31,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:12:31 INFO - 2016-01-22 17:12:31,922 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:12:31 INFO - 2016-01-22 17:12:31,923 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3196.53650220718;3261.543383926251;3278.5082237664333;3294.9505757413644;3302.5871766029245;5461.15352120421;5481.12302031675;5524.06090964536;5527.778888844451;5531.557475401968;5482.890342193154;5545.556355491561;5554.444555544444;5560.610757246995;5608.747606357713;5005.224190250517;5038.2190760432195;5102.897942041157;5132.127538318477;5134.845954621367;4830.227163653816;4975.999999999982;4976.776045077981;4995.975020124913;5106.514881086291;4950.579200767939;4978.6763860348965;4995.875103122433;5008.173651347523;5072.847814565569;5024.799008039674;5054.469280725508;5071.54356107952;5080.949190508085;5088.338515992934;4749.928751068736;4831.130396528659;4873.658843880929;4978.925316120261;5008.298838162624;5335.733213339357;5343.198520221959;5353.437889021675;5377.1665391863935;5415.702136382497;5862.325832529271;5900.616459930134;5922.674252916131;5940.079287710412;5948.583599148062;5687.146927960797;5771.913421298684;5803.21656576361;5922.052471604566;5925.851853703649;5506.752196151183;5521.66869987798;5522.22688823565;5541.639793413416;5546.611737178399;5977.940220597825;5985.790497332572;5986;5986.551008674367;6010.398960103955;5600.719964001783;5708.029634962067;5785.88428231433;5894.4400281974;5924.348321684612;5883.823485295448;5919.644821310735;5929.525637948954;5930.584859059824;5939.4951429129005;5663.518600918886;5875.676837773964;5899.056151015817;5908.704564771744;5910.763569457259;5744.195812586241;5819.79630712923;5831.883362332815;5854.121881717691;5860.882782344329;4528.841490547815;4531.796069176895;4589.54104589545;4592.2422800238255;4614.28478585813;3974.721769476109;4090.9386359204636;4097.774622395737;4114.444549985714;4122.835086596562;5626.099824028136;5677.403872593401;5678.4605462480995;5723.570732195102;5747.051736463521;5950.464458198783;5958.106284057426;5992.700364981733;6002.879942401215;6014.398560143951;5538.889222215533;5542.307211598551;5636.60543761941;5692.829215123553;5707.71461426927;5120.641555091108;5158.896822063538;5171.095058364846;5177.249298851721;5236.947630523646;5962.85092872673;6014.1580178775;6017.849553761191;6017.879642407215;6018.458338749533;5714.685692286964;5822.184894114743;5824.330202026821;5824.796132135355;5954.225950626477;5986.191864098291;6080.300765412034;6088;6088.208532890696;6133.3866613338305;5779.162021506774;5788.450097240755;5796.652200867961;5859.121131830259;5876.764929402947;5751.079827227623;5828.388019258086;5855.619384739978;5973.432523910222;5987.491063259672;5823.18475413451;5875.970620146872;5883.35283118848;5884.499817515388;5889.49939255151;5863.149843272617;5866.6480011199465;5869.589128760946;5871.647701137946;5888.528917686489;5570.860728481658;5640.4077571856005;5673.716314184357;5760.855978600569;5788.565857560616;5808.15781711641;5814.970925145347;5852.239208902815;5854.590178687451;5870.589058766016;5704.714764261853;5748.45389687979;5751.281089863767;5770.682612456355;5781.4507621775865 17:12:31 INFO - 2016-01-22 17:12:31,924 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.0630247486697;596.916431699562;604.888095702295;629.918110645616;691.1395312835521;32459.67540324599;39868.2026359473;40604.59395406045;40817.387739183934;40878.795606022;45074.774626126906;45555.31667024989;45580.544194558046;45584.31623525642;45703;9042.954785226064;9088.681896133636;9142.222911052568;9208.539573021322;9212;8981.730548083568;9101.681441149562;9110.498922559256;9123.996360400351;9126.361154719172;9061.275097992146;9109.3168012399;9136.223421009223;9141.63433462664;9155.67955121571;9051.728448146534;9133.360664753436;9148.63405463784;9157.908420915772;9198.908010919871;8961.596728147184;9099.135582119688;9117.5441227939;9135.497547634877;9151.496667683276;41462.37806432876;41506.792466037776;41628;41688.374674379906;41824;3574.7140228781896;3578;3596.226811235597;3725.497057897176;4048.397384787113;31810.363792724016;32845.34309313824;32915.177120571934;33186.17034574131;33503;3977.4033894915706;4094.488188976378;4107.63031327179;4133.875983720493;4177.791110444466;272003;272389.19027024286;274991.6250418755;275026;275065;44822;44827.775861120484;45080.77459612746;45107;45309;42704.35943460851;43050;43081;43162.56837431585;43195;16060.518184454486;16201.59496012609;16226.918865405598;16230.350785968665;16240;12579.119461637598;12659.430325635369;12687.682807929876;12774.425150868048;13038.478460861648;15130.848691513163;15140.318685659171;15179.620509487131;15236.542903712907;15243.771343429857;5999.400059993965;6122.6938653068055;6160.661163636043;6162.630242185483;6171.290301615282;980.578351308944;1024.1857723110145;1155.641751057175;1162.8255761635821;1170.2919733561243;29510;29663.85168074189;29671;29802.10593682193;29920.40159196804;1153.5385845661635;1174.6652204121783;1204.765070811201;1238.238483332762;1244.2472304255975;15707.528774136794;15710.293036813371;15748.606284842741;15845.603859903595;15986.040837549785;340788;564823;569892;572730;582842;58517.41482585205;58680;58744.41255587475;58751.41248587545;58764;1408.6900881805987;1517.4613012380446;1518.5140754958306;1522.5889009967248;1523.5581681312294;31581.8420907894;31901;32282.192945176557;33074.33851322912;34009.65990340065;54394.912101758535;54715.72642136764;54832.72583637056;54997.45002549923;55296;311245;312838;313253;315594;316316;44349;44448.55551444573;44592.10815783601;44635.33047004363;45128.77435612801;48104.51895481;48223.75888120537;48345.5165448341;48978;49287.75356123196;41029.794851026745;42023;42048;42143.36784948167;42548.78725606352;41361.58638413698;44957;46137;46679.53320466888;47277.29084063673;39598.2080358397;39837.60162398339;44174.779126104164;44746.55253447424;44919.55080449284;34136.658633413346;35029.1169117612;35303.646963531064;35443;35560;26537.60193597059;26976;27408.725912741415;28039.157225204224;29970 17:12:31 INFO - 2016-01-22 17:12:31,925 DEBUG : BROWSER_OUTPUT: |2;jquery.html;382.68428546449184;385.3506840972961;386.6269050366397;386.84719535783364;388.1906225519791;16047.598810029755;17062;18157.455276341716;18183.272669093254;18184.99999999998;11443.027342675861;11886.465109070092;12007.3395963222;16718.916405417986;17992.55018624535;5073.7463126843695;5160.122779127557;5168.276441298202;5179.482051794828;5218.843434696946;5320.813771517997;5351.491608297206;5434.049041417756;5478.096114141162;5483.835484935458;5416.052190866602;5443.646162999412;5450.264214331074;5460.31746031746;5578.2748242728385;5564.248826408423;5615.719214039302;5631.60578759487;5634.690092044936;5644.7459864306;5335.1997200419855;5408.540274076709;5423.972880135613;5442.265294185274;5506.311711036121;13021;13151.934240328832;13166.210027398387;13272.535461258809;13500.257485838274;2288.416453804286;2329.114936324203;2393.7366889642126;2397.6523404106306;2401.807855371566;9849.16282116021;10009.89990100097;10038.196944244442;13806.723865522634;14003.579892603238;1949.756280464942;1983.464464594566;1987.76146862376;1992.0537744571357;2016.2640636167694;60321.6983915082;64139;64322.67838660823;64371;64535.354646453874;10436.63471778484;10552.683419497427;10623.787524249627;10687.46562671879;10708.30396024256;13667.658308542366;13704.24626645524;13725.45098196081;13775.448982040807;13831.170129792245;7847.332976697045;7883;8302;8350.457220280663;8356.791080222922;8175.100738918714;8195.098539160688;8201.056878458934;8231.588420578948;8244.093149753522;4446.955530444654;4484.932726009112;4520.728756274569;4526.117407105583;4676.041411510632;1909.5130741660787;1954.8436125109956;1967.655660259449;1970.6748386516351;1989.5523507210762;903.701778413122;1035.0322448510667;1047.2459828923163;1081.967540973772;1126.0822429719751;17063.914680426766;17244.396446124327;17505.649887002444;17642.558936026446;17989.910050449926;991.1723710701501;1012.5190534496055;1037.1288117980932;1037.2790910317408;1066.418801753031;10010.949945250228;10086.798264034678;10163.695089147337;10276.588936442458;10284.711524560098;628023;631026;642486;645977;658268;78964.21035789684;79319.20680793234;83676.58161709152;83878.16121838703;84697.57651211704;1222.3277197541317;1224.5958833584896;1237.10928131745;1240.2868350698384;1241.5902752091968;15002.624934376729;15556.844431555992;15934.4422945201;16440.424585139463;16560.585985350463;33868.49197261994;33969.32061358808;34034.14914627154;34088.29558522014;34176.82911585426;41387.586124138375;42026.369604456566;42656;43976;45805;10036.397816130764;10373.170146388422;10427.270091093551;10481.056704896597;10528.631497897537;18185.81814181894;19161.712574311117;19250;19414.320498782476;19840.305589304306;15852.048877067413;16068.517944461684;16234.67530649404;16464.01215927048;16500.504984850475;15513.689726205639;15838.7624185635;15852.365905364117;15913.124778137313;16325.346986120898;15686.372545098067;16016.759748603547;16081.195940203177;16257.349706011628;16641;9923.454210018519;10185.84721229197;10206.23453240995;10490.895091049297;10493.685189444328;15421.151836649093;15556.144412057445;15838.60403489922;16082.115483648044;16191.271392787117 17:12:31 INFO - 2016-01-22 17:12:31,926 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1585.8176309724379;1590.4512943034656;1814.1654838774164;1819.3632228719948;1864.6084322292313;7756.573388463632;7859.410544209193;8108.391870609698;8116.3101136403475;8118.309943654789;8102.311303539192;8113.391495637836;8134.593270336489;8170.714025009126;8190.180981901822;2351.8824058797036;2386.940326491834;2391.701037370329;2393.150431596784;2395.161693407311;2354.364321633158;2386.85678859269;2387.6657267982496;2393.904243830245;2397.4845408237225;2257.661350797377;2289.164454973931;2299.2067736630834;2318.1654604342507;2320.4082958845556;2341.7424083350816;2363.468219650582;2367.0650093213085;2369.1707902234252;2370.1349007612184;2313.7570555091643;2331.825113116506;2350.647402889563;2351.1535847095033;2358.25714899806;8051.235132662447;8134.715284964997;8135.837283254361;8136.389770767216;8138.918610813876;4702.3416721659;4792.041591681677;4799.328094066834;4828.637852161102;4828.855134345975;3138.419392412411;3199.2001999500126;3203.6315823680343;3208.1658768720067;3231.5475833383343;984.8276551603512;985.5023213277249;1023.4933707814679;1026.958921643141;1056.5351245451977;10534.683959481228;10593.25847190697;10621;10645.361278323326;10661.786764264749;4097.795110244476;4170.124273902454;4191.476065491814;4206.032612499082;4231.090315582103;8761.518116503526;8815.647374104963;8821.60302786376;8841.513716745641;8844.73465796027;4697.224957881911;4720.221163508051;4726.338312636233;4732.148213321635;4734.881627959328;4356.390105385249;4399.6920215584605;4411.073674528321;4417.094495628388;4425.424694789656;3502.176988407722;3520.9119772005906;3531.2760884018717;3534.929301414009;3541.8406171722336;1039.3867618105355;1063.000779267486;1070.1385384765338;1073.75303680154;1074;1120.4061847220823;1126.3298337489182;1184.1237484261756;1400.6218321053461;1454.185656032604;7258.782236532912;7267.4549408794555;7346.816329591803;7412.962935185397;7427.405807535384;1182.9526818927318;1183.8756930522343;1187.2579637726421;1205.1262834444958;1210.352461433129;6103.115048317969;6103.877922441527;6110.7555697771595;6129.693515324216;6133.3866613339205;8993.235574976201;9207.90792092084;9296.488693121808;9303.441793492411;9356.111169438893;9235.584398702074;9267.72196834096;9278.396904201205;9336.4864932428;9371.109744574254;7394.889076663854;7504;7520.736774212876;7534.962325188339;7553.01810764608;7556.433267504849;7577.204393538599;7609.961950190213;7612.276833700789;7648.464607477423;7968.561729104955;8567.143285671384;8630.39587228888;8668.133186681534;8767.780805479659;8397.160283971554;8404.87392689098;8466.322694184328;8544.273736732448;8686.261667758312;7093.397061249645;7134.857302854018;7145.1425828900865;7169.139703235645;7188.245234250328;7254.0098167082915;7373.078365204349;7415.480916335805;7419.777406677808;7644.235576442311;6701.66491675424;7270.236625154283;7288.416926645961;7301.342879140902;7365.7790266292095;6422.710978006095;6958.617276049663;7054.047703559953;7195.784126476214;7304.086989126359;7357.558546487228;7384.040074790243;7387.593682347522;7392.815179620553;7440.255974402517;6818.761343352959;6827.965860170667;6833.658317084027;6869.690863911236;6884.5180837342905;6510.121133646897;6608.669566521751;6632.900506492503;6752.527323087336;6783.05037294789 17:12:31 INFO - 2016-01-22 17:12:31,928 DEBUG : BROWSER_OUTPUT: |4;prototype.html;360.96209897960716;371.7082090558912;372.51014915386264;375.78016860136825;376.26628075253245;6300;6385.616862988219;6394.808155755329;6398.968005159979;6449.161608990837;6111.7249723762425;6248.531360147985;6267.905981410271;6274.152989346437;6278.9372106278925;4791.808327666889;4797.832075877345;4810.446798618169;4819.831305904286;4839.5644392004715;4831.299461578086;4844;4848.321235027099;4851.66038377312;4862.708237505743;4738.47876733559;4831.516848315158;4832.106060378824;4835.734034628094;4842.370491836056;4803.78382972767;4825.227963525819;4835.347228124193;4837.226043833005;4838.540338667821;4182.979085104555;4249.915001699979;4255.000074982377;4262.019735460831;4270.9109177159935;5991.820245392645;5995.610285331483;6006.789762358297;6017.939820601781;6023.909641355383;5508.256385387961;5590.832275031756;5604.187392828017;5614.29821272341;5640.153976903456;6680.331966803281;6711.060451536789;6711.56374835639;6729.5625784323865;6731.93268067318;4632.837850675211;4634.536546345372;4641.141388843075;4642.396488456513;4645.744484053375;6878.55289406187;6910.827229319257;6932.757353492654;6964.129483814523;6996.930030699729;4681.9297710534365;4734.337192793012;4740.7437029187295;4741.099191153669;4745.098431298043;4809.591184749265;4810.037992401533;4811.27830825372;4815.856943660107;4818.253170758538;5555.527780138734;5578.54957710998;5587.189857470726;5596.048671725816;5598.636088654224;6532.542722009509;6805.115335006418;6813.148356455443;6828.770821252222;6829.658517074126;1664.4923298394106;1689.1047744695331;1702.1914590569381;1704.0797969096798;1706.6416052629088;1127.808272593661;1135.517405102828;1139.0716565998684;1149.83327417524;1150.6605551362368;6480.2547707013355;6553.049807777846;6580.407763301326;6591.307912669101;6597.736090556324;6905.551139175937;6976.232614412411;6989.580625162506;7000.124984376953;7009.404200643003;6484.448821850101;6490.4807615390655;6514.804555863332;6575.901361479581;6578.934210657928;3778.981105094457;3780.3006443807985;3782.924341513154;3784.262068896594;3790.336691079105;7140.464465165133;7147.571145731273;7177.7487787927175;7178.569285842762;7188;7009.824754381079;7126.251743566954;7156.749513766993;7181.174164971095;7193.676284567207;7168.856622867514;7169.175544812413;7191.316824901626;7195.388391986635;7195.992561041458;6962.094927659372;7002.4398048157045;7002.684879180347;7004.264552222147;7013.368796808311;6745.5952642841585;6900.2409734928115;6919.204291506541;6923.376896079377;6924.826879328057;7102.4673149512955;7178.533395329287;7185.964070179615;7193;7194.388476979515;4750.5961993229585;4765.666403351871;4775.71345719258;4782.37829082231;4784.330193772944;6812.591244525344;6891.827704307432;6916.3429474199875;6939.097917270722;6944.201416836926;6750.72997080131;6768.898466523105;6791;6804.557703749439;6807.421369183477;6748;6756.155480564929;6762.222344430454;6782.25395206517;6796.830079248059;6516.152900122954;6645.933540664531;6659.334066593302;6662.200535935719;6703.966480167568;6774.661266936535;6806.863862722619;6834.8633027340165;6835.179778426621;6838.452923766186;6620.073189753534;6626.370494802986;6636.767713130017;6640.07039014548;6657.667116644246 17:12:31 INFO - 2016-01-22 17:12:31,931 DEBUG : BROWSER_OUTPUT: |5;yui.html;852.6418904060298;903.9909600903989;922.1976880114302;923.2798417234555;946.2950102173882;15821.762673559891;16186.433474828384;16191.838081619195;16206.108664023473;16334.918325408371;15461.458848940289;15502.5349239523;15538.067715937052;15619.843801561981;15645.687086258267;915.057490784493;928.1414691410453;936.7049379445486;937.728058862929;943.7451887990238;935.242453612576;935.9766005849874;939.5349302095439;939.6194541210821;939.8872135343769;958.702802131338;962.4369743699943;966.7534778631474;967.719361385201;970.3110791338123;955.7276176289724;959.6545243712258;960.2414092866592;963.3978763272954;963.9807203855919;713.105053158283;714.921358650548;716.7491378017704;717.0033653222025;718.737660753821;14631.561053168421;14739.189344586044;14744.631384215374;14745.70508589833;14761.483348082873;12761.808572871414;12772.48910043597;13030.087893847434;13293.268870212134;13581.456741730417;10185.643502477378;10626;10635.361878287327;10823.783524329468;10974;3766.3408903441787;3814.332491813949;3844.3464611016193;3876.3991581304945;3878.3600705883496;48252.03495930097;48259.276110858365;48340.27489587659;48463;48696.51303486955;10483.213758968108;10779.784404312026;11336.659900203007;11412.885871141183;11429.199956003165;19243.230270789292;19658.41024769259;19665.606687866162;19722.802771972383;19952.20191192336;8261.8347633047;8272.462289951134;8282.296004839536;8349.95825020871;8523.40336176474;4505.414296141546;4557.772111394417;4566.908661826811;4573.885652858705;4673.883152921204;3423.4864770284157;3441.1913200398385;3444.121748954001;3493.3537295600395;3540.380433424192;613.7176898626682;614.5421660862686;623.2271982741458;623.9001759718424;626.6866566716642;722.8409749855024;723.1791916175074;734.5262305812721;744.0253268218651;761.767660863442;9274.953625231965;9940.10539051489;9989.802283100513;9994.851587097244;10087.596496140219;598.1267349669445;635.7488791927162;706.3501578547748;732.7435397610793;733.3399940053888;4362.800229936793;4415.448068991376;4580.312953057001;4631.675782695246;4666.626669866402;54297.45702543003;54321.185182222296;55023;59391.406085938586;59848.70075649594;52760.73619631877;53343.46656533385;55121.44878551243;55509.16736248959;55617;47848.52151478441;49137.508624913295;49560.256596151085;51226.48773512217;51375.48624513707;9091.586852686534;9180.219681327162;9504.287178461505;9633.566489507848;9794.951025244829;37430.251394971405;37982.43026354552;38072.61927380691;38122;38189.2362152761;48153.75923120502;48759.75620121877;49279.50720492749;49331.75334123307;49587;11250.887491125311;11285.887141128484;11636.301821890713;12182.086343524448;12411.131220814455;13183;13191;13223.272720000492;13606.591802245948;13988.650283742987;11355.545778169111;11566.884331156582;11662.825057623973;12213.267203967791;12371.443285052374;12402;12418.316992565495;12635.494580216688;12682.429290681757;12700.174488658207;11871.287722736663;11935.104867134825;12044.879551204376;12136;12210.633680989584;10166.542505587118;10423.426711530636;10432.58269669235;10525.263231573716;10984.615538456115;10187.541560629641;10292.794144116926;10350.896491034993;10381.740456488647;10424.947875260576 17:12:31 INFO - 2016-01-22 17:12:31,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:12:31 INFO - 2016-01-22 17:12:31,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:12:31 INFO - 2016-01-22 17:12:31,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 17:12:31 INFO - 2016-01-22 17:12:31,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511551920__endTimestamp 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5487.41 Median:5723.57 stddev:606.52 (10.6%) stddev-sans-first:581.15 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: Values: 3196.5 3261.5 3278.5 3295.0 3302.6 5461.2 5481.1 5524.1 5527.8 5531.6 5482.9 5545.6 5554.4 5560.6 5608.7 5005.2 5038.2 5102.9 5132.1 5134.8 4830.2 4976.0 4976.8 4996.0 5106.5 4950.6 4978.7 4995.9 5008.2 5072.8 5024.8 5054.5 5071.5 5080.9 5088.3 4749.9 4831.1 4873.7 4978.9 5008.3 5335.7 5343.2 5353.4 5377.2 5415.7 5862.3 5900.6 5922.7 5940.1 5948.6 5687.1 5771.9 5803.2 5922.1 5925.9 5506.8 5521.7 5522.2 5541.6 5546.6 5977.9 5985.8 5986.0 5986.6 6010.4 5600.7 5708.0 5785.9 5894.4 5924.3 5883.8 5919.6 5929.5 5930.6 5939.5 5663.5 5875.7 5899.1 5908.7 5910.8 5744.2 5819.8 5831.9 5854.1 5860.9 4528.8 4531.8 4589.5 4592.2 4614.3 3974.7 4090.9 4097.8 4114.4 4122.8 5626.1 5677.4 5678.5 5723.6 5747.1 5950.5 5958.1 5992.7 6002.9 6014.4 5538.9 5542.3 5636.6 5692.8 5707.7 5120.6 5158.9 5171.1 5177.2 5236.9 5962.9 6014.2 6017.8 6017.9 6018.5 5714.7 5822.2 5824.3 5824.8 5954.2 5986.2 6080.3 6088.0 6088.2 6133.4 5779.2 5788.5 5796.7 5859.1 5876.8 5751.1 5828.4 5855.6 5973.4 5987.5 5823.2 5876.0 5883.4 5884.5 5889.5 5863.1 5866.6 5869.6 5871.6 5888.5 5570.9 5640.4 5673.7 5760.9 5788.6 5808.2 5815.0 5852.2 5854.6 5870.6 5704.7 5748.5 5751.3 5770.7 5781.5 17:12:31 INFO - 2016-01-22 17:12:31,932 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54072.01 Median:41658.19 stddev:103820.90 (249.2%) stddev-sans-first:104034.41 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: Values: 561.1 596.9 604.9 629.9 691.1 32459.7 39868.2 40604.6 40817.4 40878.8 45074.8 45555.3 45580.5 45584.3 45703.0 9043.0 9088.7 9142.2 9208.5 9212.0 8981.7 9101.7 9110.5 9124.0 9126.4 9061.3 9109.3 9136.2 9141.6 9155.7 9051.7 9133.4 9148.6 9157.9 9198.9 8961.6 9099.1 9117.5 9135.5 9151.5 41462.4 41506.8 41628.0 41688.4 41824.0 3574.7 3578.0 3596.2 3725.5 4048.4 31810.4 32845.3 32915.2 33186.2 33503.0 3977.4 4094.5 4107.6 4133.9 4177.8 272003.0 272389.2 274991.6 275026.0 275065.0 44822.0 44827.8 45080.8 45107.0 45309.0 42704.4 43050.0 43081.0 43162.6 43195.0 16060.5 16201.6 16226.9 16230.4 16240.0 12579.1 12659.4 12687.7 12774.4 13038.5 15130.8 15140.3 15179.6 15236.5 15243.8 5999.4 6122.7 6160.7 6162.6 6171.3 980.6 1024.2 1155.6 1162.8 1170.3 29510.0 29663.9 29671.0 29802.1 29920.4 1153.5 1174.7 1204.8 1238.2 1244.2 15707.5 15710.3 15748.6 15845.6 15986.0 340788.0 564823.0 569892.0 572730.0 582842.0 58517.4 58680.0 58744.4 58751.4 58764.0 1408.7 1517.5 1518.5 1522.6 1523.6 31581.8 31901.0 32282.2 33074.3 34009.7 54394.9 54715.7 54832.7 54997.5 55296.0 311245.0 312838.0 313253.0 315594.0 316316.0 44349.0 44448.6 44592.1 44635.3 45128.8 48104.5 48223.8 48345.5 48978.0 49287.8 41029.8 42023.0 42048.0 42143.4 42548.8 41361.6 44957.0 46137.0 46679.5 47277.3 39598.2 39837.6 44174.8 44746.6 44919.6 34136.7 35029.1 35303.6 35443.0 35560.0 26537.6 26976.0 27408.7 28039.2 29970.0 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31945.22 Median:10682.04 stddev:104639.03 (979.6%) stddev-sans-first:104905.73 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: Values: 382.7 385.4 386.6 386.8 388.2 16047.6 17062.0 18157.5 18183.3 18185.0 11443.0 11886.5 12007.3 16718.9 17992.6 5073.7 5160.1 5168.3 5179.5 5218.8 5320.8 5351.5 5434.0 5478.1 5483.8 5416.1 5443.6 5450.3 5460.3 5578.3 5564.2 5615.7 5631.6 5634.7 5644.7 5335.2 5408.5 5424.0 5442.3 5506.3 13021.0 13151.9 13166.2 13272.5 13500.3 2288.4 2329.1 2393.7 2397.7 2401.8 9849.2 10009.9 10038.2 13806.7 14003.6 1949.8 1983.5 1987.8 1992.1 2016.3 60321.7 64139.0 64322.7 64371.0 64535.4 10436.6 10552.7 10623.8 10687.5 10708.3 13667.7 13704.2 13725.5 13775.4 13831.2 7847.3 7883.0 8302.0 8350.5 8356.8 8175.1 8195.1 8201.1 8231.6 8244.1 4447.0 4484.9 4520.7 4526.1 4676.0 1909.5 1954.8 1967.7 1970.7 1989.6 903.7 1035.0 1047.2 1082.0 1126.1 17063.9 17244.4 17505.6 17642.6 17989.9 991.2 1012.5 1037.1 1037.3 1066.4 10010.9 10086.8 10163.7 10276.6 10284.7 628023.0 631026.0 642486.0 645977.0 658268.0 78964.2 79319.2 83676.6 83878.2 84697.6 1222.3 1224.6 1237.1 1240.3 1241.6 15002.6 15556.8 15934.4 16440.4 16560.6 33868.5 33969.3 34034.1 34088.3 34176.8 41387.6 42026.4 42656.0 43976.0 45805.0 10036.4 10373.2 10427.3 10481.1 10528.6 18185.8 19161.7 19250.0 19414.3 19840.3 15852.0 16068.5 16234.7 16464.0 16500.5 15513.7 15838.8 15852.4 15913.1 16325.3 15686.4 16016.8 16081.2 16257.3 16641.0 9923.5 10185.8 10206.2 10490.9 10493.7 15421.2 15556.1 15838.6 16082.1 16191.3 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,933 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5563.30 Median:6620.79 stddev:2834.03 (42.8%) stddev-sans-first:2826.21 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: Values: 1585.8 1590.5 1814.2 1819.4 1864.6 7756.6 7859.4 8108.4 8116.3 8118.3 8102.3 8113.4 8134.6 8170.7 8190.2 2351.9 2386.9 2391.7 2393.2 2395.2 2354.4 2386.9 2387.7 2393.9 2397.5 2257.7 2289.2 2299.2 2318.2 2320.4 2341.7 2363.5 2367.1 2369.2 2370.1 2313.8 2331.8 2350.6 2351.2 2358.3 8051.2 8134.7 8135.8 8136.4 8138.9 4702.3 4792.0 4799.3 4828.6 4828.9 3138.4 3199.2 3203.6 3208.2 3231.5 984.8 985.5 1023.5 1027.0 1056.5 10534.7 10593.3 10621.0 10645.4 10661.8 4097.8 4170.1 4191.5 4206.0 4231.1 8761.5 8815.6 8821.6 8841.5 8844.7 4697.2 4720.2 4726.3 4732.1 4734.9 4356.4 4399.7 4411.1 4417.1 4425.4 3502.2 3520.9 3531.3 3534.9 3541.8 1039.4 1063.0 1070.1 1073.8 1074.0 1120.4 1126.3 1184.1 1400.6 1454.2 7258.8 7267.5 7346.8 7413.0 7427.4 1183.0 1183.9 1187.3 1205.1 1210.4 6103.1 6103.9 6110.8 6129.7 6133.4 8993.2 9207.9 9296.5 9303.4 9356.1 9235.6 9267.7 9278.4 9336.5 9371.1 7394.9 7504.0 7520.7 7535.0 7553.0 7556.4 7577.2 7610.0 7612.3 7648.5 7968.6 8567.1 8630.4 8668.1 8767.8 8397.2 8404.9 8466.3 8544.3 8686.3 7093.4 7134.9 7145.1 7169.1 7188.2 7254.0 7373.1 7415.5 7419.8 7644.2 6701.7 7270.2 7288.4 7301.3 7365.8 6422.7 6958.6 7054.0 7195.8 7304.1 7357.6 7384.0 7387.6 7392.8 7440.3 6818.8 6828.0 6833.7 6869.7 6884.5 6510.1 6608.7 6632.9 6752.5 6783.1 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5634.75 Median:6482.35 stddev:1702.26 (26.3%) stddev-sans-first:1660.37 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: Values: 361.0 371.7 372.5 375.8 376.3 6300.0 6385.6 6394.8 6399.0 6449.2 6111.7 6248.5 6267.9 6274.2 6278.9 4791.8 4797.8 4810.4 4819.8 4839.6 4831.3 4844.0 4848.3 4851.7 4862.7 4738.5 4831.5 4832.1 4835.7 4842.4 4803.8 4825.2 4835.3 4837.2 4838.5 4183.0 4249.9 4255.0 4262.0 4270.9 5991.8 5995.6 6006.8 6017.9 6023.9 5508.3 5590.8 5604.2 5614.3 5640.2 6680.3 6711.1 6711.6 6729.6 6731.9 4632.8 4634.5 4641.1 4642.4 4645.7 6878.6 6910.8 6932.8 6964.1 6996.9 4681.9 4734.3 4740.7 4741.1 4745.1 4809.6 4810.0 4811.3 4815.9 4818.3 5555.5 5578.5 5587.2 5596.0 5598.6 6532.5 6805.1 6813.1 6828.8 6829.7 1664.5 1689.1 1702.2 1704.1 1706.6 1127.8 1135.5 1139.1 1149.8 1150.7 6480.3 6553.0 6580.4 6591.3 6597.7 6905.6 6976.2 6989.6 7000.1 7009.4 6484.4 6490.5 6514.8 6575.9 6578.9 3779.0 3780.3 3782.9 3784.3 3790.3 7140.5 7147.6 7177.7 7178.6 7188.0 7009.8 7126.3 7156.7 7181.2 7193.7 7168.9 7169.2 7191.3 7195.4 7196.0 6962.1 7002.4 7002.7 7004.3 7013.4 6745.6 6900.2 6919.2 6923.4 6924.8 7102.5 7178.5 7186.0 7193.0 7194.4 4750.6 4765.7 4775.7 4782.4 4784.3 6812.6 6891.8 6916.3 6939.1 6944.2 6750.7 6768.9 6791.0 6804.6 6807.4 6748.0 6756.2 6762.2 6782.3 6796.8 6516.2 6645.9 6659.3 6662.2 6704.0 6774.7 6806.9 6834.9 6835.2 6838.5 6620.1 6626.4 6636.8 6640.1 6657.7 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: 17:12:31 INFO - 2016-01-22 17:12:31,934 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14753.77 Median:4570.40 stddev:16574.51 (362.6%) stddev-sans-first:16588.13 17:12:31 INFO - 2016-01-22 17:12:31,935 DEBUG : BROWSER_OUTPUT: Values: 852.6 904.0 922.2 923.3 946.3 15821.8 16186.4 16191.8 16206.1 16334.9 15461.5 15502.5 15538.1 15619.8 15645.7 915.1 928.1 936.7 937.7 943.7 935.2 936.0 939.5 939.6 939.9 958.7 962.4 966.8 967.7 970.3 955.7 959.7 960.2 963.4 964.0 713.1 714.9 716.7 717.0 718.7 14631.6 14739.2 14744.6 14745.7 14761.5 12761.8 12772.5 13030.1 13293.3 13581.5 10185.6 10626.0 10635.4 10823.8 10974.0 3766.3 3814.3 3844.3 3876.4 3878.4 48252.0 48259.3 48340.3 48463.0 48696.5 10483.2 10779.8 11336.7 11412.9 11429.2 19243.2 19658.4 19665.6 19722.8 19952.2 8261.8 8272.5 8282.3 8350.0 8523.4 4505.4 4557.8 4566.9 4573.9 4673.9 3423.5 3441.2 3444.1 3493.4 3540.4 613.7 614.5 623.2 623.9 626.7 722.8 723.2 734.5 744.0 761.8 9275.0 9940.1 9989.8 9994.9 10087.6 598.1 635.7 706.4 732.7 733.3 4362.8 4415.4 4580.3 4631.7 4666.6 54297.5 54321.2 55023.0 59391.4 59848.7 52760.7 53343.5 55121.4 55509.2 55617.0 47848.5 49137.5 49560.3 51226.5 51375.5 9091.6 9180.2 9504.3 9633.6 9795.0 37430.3 37982.4 38072.6 38122.0 38189.2 48153.8 48759.8 49279.5 49331.8 49587.0 11250.9 11285.9 11636.3 12182.1 12411.1 13183.0 13191.0 13223.3 13606.6 13988.7 11355.5 11566.9 11662.8 12213.3 12371.4 12402.0 12418.3 12635.5 12682.4 12700.2 11871.3 11935.1 12044.9 12136.0 12210.6 10166.5 10423.4 10432.6 10525.3 10984.6 10187.5 10292.8 10350.9 10381.7 10424.9 17:12:31 INFO - 2016-01-22 17:12:31,936 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:12:31 INFO - 2016-01-22 17:12:31,936 DEBUG : BROWSER_OUTPUT: 17:12:32 INFO - 2016-01-22 17:12:32,649 INFO : Browser exited with error code: 0 17:12:32 INFO - 2016-01-22 17:12:32,668 INFO : Completed test dromaeo_css (00:18:28) 17:12:32 INFO - 2016-01-22 17:12:32,668 INFO : Starting test kraken 17:12:32 INFO - 2016-01-22 17:12:32,668 DEBUG : operating with platform_type : linux_ 17:12:32 INFO - 2016-01-22 17:12:32,668 INFO : Initialising browser for kraken test... 17:12:32 INFO - 2016-01-22 17:12:32,674 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzf6PaP/profile http://localhost:56565/getInfo.html 17:12:36 INFO - 2016-01-22 17:12:36,521 DEBUG : BROWSER_OUTPUT: 17:12:36 INFO - 2016-01-22 17:12:36,521 DEBUG : BROWSER_OUTPUT: (process:11105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:37 INFO - 2016-01-22 17:12:37,384 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:12:37 INFO - 2016-01-22 17:12:37,384 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:12:37 INFO - 2016-01-22 17:12:37,384 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:12:37 INFO - 2016-01-22 17:12:37,384 DEBUG : BROWSER_OUTPUT: __metrics 17:12:38 INFO - 2016-01-22 17:12:38,417 INFO : Browser initialized. 17:12:38 INFO - 2016-01-22 17:12:38,418 INFO : Running cycle 1/1 for kraken test... 17:12:38 INFO - 2016-01-22 17:12:38,418 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzf6PaP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:12:39 INFO - 2016-01-22 17:12:39,729 DEBUG : BROWSER_OUTPUT: 17:12:39 INFO - 2016-01-22 17:12:39,729 DEBUG : BROWSER_OUTPUT: (process:11218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:12:50 INFO - 2016-01-22 17:12:50,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 136380416 17:12:50 INFO - 2016-01-22 17:12:50,237 DEBUG : BROWSER_OUTPUT: 17:12:52 INFO - 2016-01-22 17:12:52,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56565/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:53 INFO - 2016-01-22 17:12:53,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 139247616 17:12:53 INFO - 2016-01-22 17:12:53,307 DEBUG : BROWSER_OUTPUT: 17:12:55 INFO - 2016-01-22 17:12:55,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56565/tests/kraken/driver.html?testName=audio-dft) 17:12:56 INFO - 2016-01-22 17:12:56,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 17:12:56 INFO - 2016-01-22 17:12:56,526 DEBUG : BROWSER_OUTPUT: 17:12:59 INFO - 2016-01-22 17:12:59,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56565/tests/kraken/driver.html?testName=audio-fft) 17:12:59 INFO - 2016-01-22 17:12:59,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 17:12:59 INFO - 2016-01-22 17:12:59,921 DEBUG : BROWSER_OUTPUT: 17:13:01 INFO - 2016-01-22 17:13:01,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56565/tests/kraken/driver.html?testName=audio-oscillator) 17:13:02 INFO - 2016-01-22 17:13:02,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 139231232 17:13:02 INFO - 2016-01-22 17:13:02,535 DEBUG : BROWSER_OUTPUT: 17:13:04 INFO - 2016-01-22 17:13:04,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:05 INFO - 2016-01-22 17:13:05,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 137879552 17:13:05 INFO - 2016-01-22 17:13:05,302 DEBUG : BROWSER_OUTPUT: 17:13:08 INFO - 2016-01-22 17:13:08,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56565/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:08 INFO - 2016-01-22 17:13:08,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 17:13:08 INFO - 2016-01-22 17:13:08,786 DEBUG : BROWSER_OUTPUT: 17:13:12 INFO - 2016-01-22 17:13:12,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56565/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:12 INFO - 2016-01-22 17:13:12,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 137396224 17:13:12 INFO - 2016-01-22 17:13:12,742 DEBUG : BROWSER_OUTPUT: 17:13:15 INFO - 2016-01-22 17:13:15,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56565/tests/kraken/driver.html?testName=json-parse-financial) 17:13:16 INFO - 2016-01-22 17:13:16,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 137551872 17:13:16 INFO - 2016-01-22 17:13:16,119 DEBUG : BROWSER_OUTPUT: 17:13:17 INFO - 2016-01-22 17:13:17,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:18 INFO - 2016-01-22 17:13:18,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 17:13:18 INFO - 2016-01-22 17:13:18,286 DEBUG : BROWSER_OUTPUT: 17:13:20 INFO - 2016-01-22 17:13:20,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:20 INFO - 2016-01-22 17:13:20,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 138678272 17:13:20 INFO - 2016-01-22 17:13:20,661 DEBUG : BROWSER_OUTPUT: 17:13:22 INFO - 2016-01-22 17:13:22,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:23 INFO - 2016-01-22 17:13:23,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 138686464 17:13:23 INFO - 2016-01-22 17:13:23,326 DEBUG : BROWSER_OUTPUT: 17:13:25 INFO - 2016-01-22 17:13:25,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:26 INFO - 2016-01-22 17:13:26,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 17:13:26 INFO - 2016-01-22 17:13:26,322 DEBUG : BROWSER_OUTPUT: 17:13:28 INFO - 2016-01-22 17:13:28,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:29 INFO - 2016-01-22 17:13:29,444 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 17:13:29 INFO - 2016-01-22 17:13:29,444 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56565/tests/kraken/driver.html?testName=ai-astar) 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 140324864 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:13:31 INFO - 2016-01-22 17:13:31,389 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;104;109;109;110;119;112;110;109;111 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;130;144;161;124;150;153;122;173;125 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;162;162;161;162;162;161 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;73;160;73;71;72;73;162;72 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;139;92;93;92;140;92;93;137 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;111;110;109;110;110;110;110;109 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;148;147;146;146;147;147;148;147 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;98;96;96;96 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;62;61;63;64;65;63;69;58 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;65;64;65;67;66;65;65 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;89;81;82;83;90;84;90;81;92 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;119;114;118;114;119;116;115;117;112 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;152;148;149;144;144;148;146;143;134 17:13:31 INFO - 2016-01-22 17:13:31,390 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;72;67;68;66;68;67;66;68;73 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,697 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511611388__endTimestamp 17:13:31 INFO - 2016-01-22 17:13:31,391 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:13:31 INFO - 2016-01-22 17:13:31,392 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:13:31 INFO - 2016-01-22 17:13:31,392 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,392 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:3.75 (3.4%) stddev-sans-first:3.94 17:13:31 INFO - 2016-01-22 17:13:31,393 DEBUG : BROWSER_OUTPUT: Values: 112.0 104.0 109.0 109.0 110.0 119.0 112.0 110.0 109.0 111.0 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.50 stddev:18.08 (11.9%) stddev-sans-first:18.26 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: Values: 160.0 130.0 144.0 161.0 124.0 150.0 153.0 122.0 173.0 125.0 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 162.0 162.0 161.0 162.0 162.0 161.0 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.70 Median:73.00 stddev:37.10 (50.8%) stddev-sans-first:39.07 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 73.0 160.0 73.0 71.0 72.0 73.0 162.0 72.0 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.50 stddev:22.28 (24.1%) stddev-sans-first:23.10 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 139.0 92.0 93.0 92.0 140.0 92.0 93.0 137.0 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,394 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 111.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 148.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,395 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 98.0 96.0 96.0 96.0 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.50 Median:63.00 stddev:3.14 (5.0%) stddev-sans-first:3.06 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 62.0 61.0 63.0 64.0 65.0 63.0 69.0 58.0 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 65.0 64.0 65.0 67.0 66.0 65.0 65.0 17:13:31 INFO - 2016-01-22 17:13:31,396 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.50 stddev:4.42 (5.1%) stddev-sans-first:4.41 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: Values: 81.0 89.0 81.0 82.0 83.0 90.0 84.0 90.0 81.0 92.0 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:117.50 stddev:4.72 (4.0%) stddev-sans-first:2.45 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: Values: 129.0 119.0 114.0 118.0 114.0 119.0 116.0 115.0 117.0 112.0 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,397 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:147.00 stddev:4.89 (3.3%) stddev-sans-first:5.12 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: Values: 143.0 152.0 148.0 149.0 144.0 144.0 148.0 146.0 143.0 134.0 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.39 (3.5%) stddev-sans-first:2.50 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 67.0 68.0 66.0 68.0 67.0 66.0 68.0 73.0 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:13:31 INFO - 2016-01-22 17:13:31,398 DEBUG : BROWSER_OUTPUT: 17:13:32 INFO - 2016-01-22 17:13:32,237 INFO : Browser exited with error code: 0 17:13:32 INFO - 2016-01-22 17:13:32,290 INFO : Completed test kraken (00:00:59) 17:13:32 INFO - 2016-01-22 17:13:32,290 INFO : Starting test v8_7 17:13:32 INFO - 2016-01-22 17:13:32,291 DEBUG : operating with platform_type : linux_ 17:13:32 INFO - 2016-01-22 17:13:32,291 INFO : Initialising browser for v8_7 test... 17:13:32 INFO - 2016-01-22 17:13:32,297 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCSIjmR/profile http://localhost:56565/getInfo.html 17:13:35 INFO - 2016-01-22 17:13:35,993 DEBUG : BROWSER_OUTPUT: 17:13:35 INFO - 2016-01-22 17:13:35,994 DEBUG : BROWSER_OUTPUT: (process:11532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:13:36 INFO - 2016-01-22 17:13:36,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:13:36 INFO - 2016-01-22 17:13:36,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:13:36 INFO - 2016-01-22 17:13:36,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:13:36 INFO - 2016-01-22 17:13:36,756 DEBUG : BROWSER_OUTPUT: __metrics 17:13:37 INFO - 2016-01-22 17:13:37,693 INFO : Browser initialized. 17:13:37 INFO - 2016-01-22 17:13:37,694 INFO : Running cycle 1/1 for v8_7 test... 17:13:37 INFO - 2016-01-22 17:13:37,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCSIjmR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:13:38 INFO - 2016-01-22 17:13:38,950 DEBUG : BROWSER_OUTPUT: 17:13:38 INFO - 2016-01-22 17:13:38,950 DEBUG : BROWSER_OUTPUT: (process:11645): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:13:49 INFO - 2016-01-22 17:13:49,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 138051584 17:13:49 INFO - 2016-01-22 17:13:49,451 DEBUG : BROWSER_OUTPUT: 17:14:10 INFO - 2016-01-22 17:14:10,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56565/tests/v8_7/run.html (next: http://localhost:56565/tests/v8_7/run.html) 17:14:11 INFO - 2016-01-22 17:14:11,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 136257536 17:14:11 INFO - 2016-01-22 17:14:11,074 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: |0;Richards;164.66326362588507 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;168.29350387075058 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 17:14:11 INFO - 2016-01-22 17:14:11,075 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5223.958333333333 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |4;RayTrace;884.1732979664014 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |5;Earley;548.847420417124 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |6;Boyer;10978.260869565218 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |7;RegExp;24512.19512195122 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |8;Splay;512.2950819672132 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4873.78640776699 17:14:11 INFO - 2016-01-22 17:14:11,076 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: __startTimestamp1453511651071__endTimestamp 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.66 Median:164.66 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,077 DEBUG : BROWSER_OUTPUT: Values: 164.7 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:168.29 Median:168.29 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: Values: 168.3 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: Values: 278.7 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,078 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,079 DEBUG : BROWSER_OUTPUT: Values: 5224.0 17:14:11 INFO - 2016-01-22 17:14:11,079 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,079 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:884.17 Median:884.17 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,079 DEBUG : BROWSER_OUTPUT: Values: 884.2 17:14:11 INFO - 2016-01-22 17:14:11,079 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:548.85 Median:548.85 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: Values: 548.8 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10978.26 Median:10978.26 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: Values: 10978.3 17:14:11 INFO - 2016-01-22 17:14:11,080 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24512.20 Median:24512.20 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: Values: 24512.2 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:512.30 Median:512.30 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: Values: 512.3 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,081 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 17:14:11 INFO - 2016-01-22 17:14:11,082 DEBUG : BROWSER_OUTPUT: Values: 4873.8 17:14:11 INFO - 2016-01-22 17:14:11,082 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:14:11 INFO - 2016-01-22 17:14:11,082 DEBUG : BROWSER_OUTPUT: 17:14:11 INFO - 2016-01-22 17:14:11,877 INFO : Browser exited with error code: 0 17:14:11 INFO - 2016-01-22 17:14:11,894 INFO : Completed test v8_7 (00:00:39) 17:14:12 INFO - 2016-01-22 17:14:12,140 INFO : Completed test suite (00:20:07) 17:14:12 INFO - 2016-01-22 17:14:12,140 DEBUG : Working with test: dromaeo_css 17:14:12 INFO - 2016-01-22 17:14:12,140 DEBUG : Generating results file: dromaeo_css 17:14:12 INFO - 2016-01-22 17:14:12,141 DEBUG : Working with test: kraken 17:14:12 INFO - 2016-01-22 17:14:12,141 DEBUG : Generating results file: kraken 17:14:12 INFO - 2016-01-22 17:14:12,141 INFO : javascript benchmark 17:14:12 INFO - 2016-01-22 17:14:12,142 DEBUG : Working with test: v8_7 17:14:12 INFO - 2016-01-22 17:14:12,142 DEBUG : Generating results file: v8_7 17:14:12 INFO - 2016-01-22 17:14:12,142 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:12 INFO - 2016-01-22 17:14:12,191 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 17:14:12 INFO - 2016-01-22 17:14:12,191 DEBUG : process_Request line: dromaeo_css 7374.09 graph.html#tests=[[72,52,43]] 17:14:12 INFO - 2016-01-22 17:14:12,191 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:12 INFO - 2016-01-22 17:14:12,219 DEBUG : process_Request line: kraken 1509.60 graph.html#tests=[[232,52,43]] 17:14:12 INFO - 2016-01-22 17:14:12,219 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:14:12 INFO - 2016-01-22 17:14:12,248 DEBUG : process_Request line: v8_7 23309.23 graph.html#tests=[[230,52,43]] 17:14:12 INFO - 2016-01-22 17:14:12,250 INFO : javascript benchmark 17:14:12 INFO - 2016-01-22 17:14:12,253 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3196.53650220718, 3261.543383926251, 3278.5082237664333, 3294.9505757413644, 3302.5871766029245, 5461.15352120421, 5481.12302031675, 5524.06090964536, 5527.778888844451, 5531.557475401968, 5482.890342193154, 5545.556355491561, 5554.444555544444, 5560.610757246995, 5608.747606357713, 5005.224190250517, 5038.2190760432195, 5102.897942041157, 5132.127538318477, 5134.845954621367, 4830.227163653816, 4975.999999999982, 4976.776045077981, 4995.975020124913, 5106.514881086291, 4950.579200767939, 4978.6763860348965, 4995.875103122433, 5008.173651347523, 5072.847814565569, 5024.799008039674, 5054.469280725508, 5071.54356107952, 5080.949190508085, 5088.338515992934, 4749.928751068736, 4831.130396528659, 4873.658843880929, 4978.925316120261, 5008.298838162624, 5335.733213339357, 5343.198520221959, 5353.437889021675, 5377.1665391863935, 5415.702136382497, 5862.325832529271, 5900.616459930134, 5922.674252916131, 5940.079287710412, 5948.583599148062, 5687.146927960797, 5771.913421298684, 5803.21656576361, 5922.052471604566, 5925.851853703649, 5506.752196151183, 5521.66869987798, 5522.22688823565, 5541.639793413416, 5546.611737178399, 5977.940220597825, 5985.790497332572, 5986.0, 5986.551008674367, 6010.398960103955, 5600.719964001783, 5708.029634962067, 5785.88428231433, 5894.4400281974, 5924.348321684612, 5883.823485295448, 5919.644821310735, 5929.525637948954, 5930.584859059824, 5939.4951429129005, 5663.518600918886, 5875.676837773964, 5899.056151015817, 5908.704564771744, 5910.763569457259, 5744.195812586241, 5819.79630712923, 5831.883362332815, 5854.121881717691, 5860.882782344329, 4528.841490547815, 4531.796069176895, 4589.54104589545, 4592.2422800238255, 4614.28478585813, 3974.721769476109, 4090.9386359204636, 4097.774622395737, 4114.444549985714, 4122.835086596562, 5626.099824028136, 5677.403872593401, 5678.4605462480995, 5723.570732195102, 5747.051736463521, 5950.464458198783, 5958.106284057426, 5992.700364981733, 6002.879942401215, 6014.398560143951, 5538.889222215533, 5542.307211598551, 5636.60543761941, 5692.829215123553, 5707.71461426927, 5120.641555091108, 5158.896822063538, 5171.095058364846, 5177.249298851721, 5236.947630523646, 5962.85092872673, 6014.1580178775, 6017.849553761191, 6017.879642407215, 6018.458338749533, 5714.685692286964, 5822.184894114743, 5824.330202026821, 5824.796132135355, 5954.225950626477, 5986.191864098291, 6080.300765412034, 6088.0, 6088.208532890696, 6133.3866613338305, 5779.162021506774, 5788.450097240755, 5796.652200867961, 5859.121131830259, 5876.764929402947, 5751.079827227623, 5828.388019258086, 5855.619384739978, 5973.432523910222, 5987.491063259672, 5823.18475413451, 5875.970620146872, 5883.35283118848, 5884.499817515388, 5889.49939255151, 5863.149843272617, 5866.6480011199465, 5869.589128760946, 5871.647701137946, 5888.528917686489, 5570.860728481658, 5640.4077571856005, 5673.716314184357, 5760.855978600569, 5788.565857560616, 5808.15781711641, 5814.970925145347, 5852.239208902815, 5854.590178687451, 5870.589058766016, 5704.714764261853, 5748.45389687979, 5751.281089863767, 5770.682612456355, 5781.4507621775865], "unit": "ms", "name": "dojo.html", "value": 5447.889329758045}, {"lowerIsBetter": false, "replicates": [561.0630247486697, 596.916431699562, 604.888095702295, 629.918110645616, 691.1395312835521, 32459.67540324599, 39868.2026359473, 40604.59395406045, 40817.387739183934, 40878.795606022, 45074.774626126906, 45555.31667024989, 45580.544194558046, 45584.31623525642, 45703.0, 9042.954785226064, 9088.681896133636, 9142.222911052568, 9208.539573021322, 9212.0, 8981.730548083568, 9101.681441149562, 9110.498922559256, 9123.996360400351, 9126.361154719172, 9061.275097992146, 9109.3168012399, 9136.223421009223, 9141.63433462664, 9155.67955121571, 9051.728448146534, 9133.360664753436, 9148.63405463784, 9157.908420915772, 9198.908010919871, 8961.596728147184, 9099.135582119688, 9117.5441227939, 9135.497547634877, 9151.496667683276, 41462.37806432876, 41506.792466037776, 41628.0, 41688.374674379906, 41824.0, 3574.7140228781896, 3578.0, 3596.226811235597, 3725.497057897176, 4048.397384787113, 31810.363792724016, 32845.34309313824, 32915.177120571934, 33186.17034574131, 33503.0, 3977.4033894915706, 4094.488188976378, 4107.63031327179, 4133.875983720493, 4177.791110444466, 272003.0, 272389.19027024286, 274991.6250418755, 275026.0, 275065.0, 44822.0, 44827.775861120484, 45080.77459612746, 45107.0, 45309.0, 42704.35943460851, 43050.0, 43081.0, 43162.56837431585, 43195.0, 16060.518184454486, 16201.59496012609, 16226.918865405598, 16230.350785968665, 16240.0, 12579.119461637598, 12659.430325635369, 12687.682807929876, 12774.425150868048, 13038.478460861648, 15130.848691513163, 15140.318685659171, 15179.620509487131, 15236.542903712907, 15243.771343429857, 5999.400059993965, 6122.6938653068055, 6160.661163636043, 6162.630242185483, 6171.290301615282, 980.578351308944, 1024.1857723110145, 1155.641751057175, 1162.8255761635821, 1170.2919733561243, 29510.0, 29663.85168074189, 29671.0, 29802.10593682193, 29920.40159196804, 1153.5385845661635, 1174.6652204121783, 1204.765070811201, 1238.238483332762, 1244.2472304255975, 15707.528774136794, 15710.293036813371, 15748.606284842741, 15845.603859903595, 15986.040837549785, 340788.0, 564823.0, 569892.0, 572730.0, 582842.0, 58517.41482585205, 58680.0, 58744.41255587475, 58751.41248587545, 58764.0, 1408.6900881805987, 1517.4613012380446, 1518.5140754958306, 1522.5889009967248, 1523.5581681312294, 31581.8420907894, 31901.0, 32282.192945176557, 33074.33851322912, 34009.65990340065, 54394.912101758535, 54715.72642136764, 54832.72583637056, 54997.45002549923, 55296.0, 311245.0, 312838.0, 313253.0, 315594.0, 316316.0, 44349.0, 44448.55551444573, 44592.10815783601, 44635.33047004363, 45128.77435612801, 48104.51895481, 48223.75888120537, 48345.5165448341, 48978.0, 49287.75356123196, 41029.794851026745, 42023.0, 42048.0, 42143.36784948167, 42548.78725606352, 41361.58638413698, 44957.0, 46137.0, 46679.53320466888, 47277.29084063673, 39598.2080358397, 39837.60162398339, 44174.779126104164, 44746.55253447424, 44919.55080449284, 34136.658633413346, 35029.1169117612, 35303.646963531064, 35443.0, 35560.0, 26537.60193597059, 26976.0, 27408.725912741415, 28039.157225204224, 29970.0], "unit": "ms", "name": "ext.html", "value": 19705.596633895835}, {"lowerIsBetter": false, "replicates": [382.68428546449184, 385.3506840972961, 386.6269050366397, 386.84719535783364, 388.1906225519791, 16047.598810029755, 17062.0, 18157.455276341716, 18183.272669093254, 18184.99999999998, 11443.027342675861, 11886.465109070092, 12007.3395963222, 16718.916405417986, 17992.55018624535, 5073.7463126843695, 5160.122779127557, 5168.276441298202, 5179.482051794828, 5218.843434696946, 5320.813771517997, 5351.491608297206, 5434.049041417756, 5478.096114141162, 5483.835484935458, 5416.052190866602, 5443.646162999412, 5450.264214331074, 5460.31746031746, 5578.2748242728385, 5564.248826408423, 5615.719214039302, 5631.60578759487, 5634.690092044936, 5644.7459864306, 5335.1997200419855, 5408.540274076709, 5423.972880135613, 5442.265294185274, 5506.311711036121, 13021.0, 13151.934240328832, 13166.210027398387, 13272.535461258809, 13500.257485838274, 2288.416453804286, 2329.114936324203, 2393.7366889642126, 2397.6523404106306, 2401.807855371566, 9849.16282116021, 10009.89990100097, 10038.196944244442, 13806.723865522634, 14003.579892603238, 1949.756280464942, 1983.464464594566, 1987.76146862376, 1992.0537744571357, 2016.2640636167694, 60321.6983915082, 64139.0, 64322.67838660823, 64371.0, 64535.354646453874, 10436.63471778484, 10552.683419497427, 10623.787524249627, 10687.46562671879, 10708.30396024256, 13667.658308542366, 13704.24626645524, 13725.45098196081, 13775.448982040807, 13831.170129792245, 7847.332976697045, 7883.0, 8302.0, 8350.457220280663, 8356.791080222922, 8175.100738918714, 8195.098539160688, 8201.056878458934, 8231.588420578948, 8244.093149753522, 4446.955530444654, 4484.932726009112, 4520.728756274569, 4526.117407105583, 4676.041411510632, 1909.5130741660787, 1954.8436125109956, 1967.655660259449, 1970.6748386516351, 1989.5523507210762, 903.701778413122, 1035.0322448510667, 1047.2459828923163, 1081.967540973772, 1126.0822429719751, 17063.914680426766, 17244.396446124327, 17505.649887002444, 17642.558936026446, 17989.910050449926, 991.1723710701501, 1012.5190534496055, 1037.1288117980932, 1037.2790910317408, 1066.418801753031, 10010.949945250228, 10086.798264034678, 10163.695089147337, 10276.588936442458, 10284.711524560098, 628023.0, 631026.0, 642486.0, 645977.0, 658268.0, 78964.21035789684, 79319.20680793234, 83676.58161709152, 83878.16121838703, 84697.57651211704, 1222.3277197541317, 1224.5958833584896, 1237.10928131745, 1240.2868350698384, 1241.5902752091968, 15002.624934376729, 15556.844431555992, 15934.4422945201, 16440.424585139463, 16560.585985350463, 33868.49197261994, 33969.32061358808, 34034.14914627154, 34088.29558522014, 34176.82911585426, 41387.586124138375, 42026.369604456566, 42656.0, 43976.0, 45805.0, 10036.397816130764, 10373.170146388422, 10427.270091093551, 10481.056704896597, 10528.631497897537, 18185.81814181894, 19161.712574311117, 19250.0, 19414.320498782476, 19840.305589304306, 15852.048877067413, 16068.517944461684, 16234.67530649404, 16464.01215927048, 16500.504984850475, 15513.689726205639, 15838.7624185635, 15852.365905364117, 15913.124778137313, 16325.346986120898, 15686.372545098067, 16016.759748603547, 16081.195940203177, 16257.349706011628, 16641.0, 9923.454210018519, 10185.84721229197, 10206.23453240995, 10490.895091049297, 10493.685189444328, 15421.151836649093, 15556.144412057445, 15838.60403489922, 16082.115483648044, 16191.271392787117], "unit": "ms", "name": "jquery.html", "value": 9278.378678653473}, {"lowerIsBetter": false, "replicates": [1585.8176309724379, 1590.4512943034656, 1814.1654838774164, 1819.3632228719948, 1864.6084322292313, 7756.573388463632, 7859.410544209193, 8108.391870609698, 8116.3101136403475, 8118.309943654789, 8102.311303539192, 8113.391495637836, 8134.593270336489, 8170.714025009126, 8190.180981901822, 2351.8824058797036, 2386.940326491834, 2391.701037370329, 2393.150431596784, 2395.161693407311, 2354.364321633158, 2386.85678859269, 2387.6657267982496, 2393.904243830245, 2397.4845408237225, 2257.661350797377, 2289.164454973931, 2299.2067736630834, 2318.1654604342507, 2320.4082958845556, 2341.7424083350816, 2363.468219650582, 2367.0650093213085, 2369.1707902234252, 2370.1349007612184, 2313.7570555091643, 2331.825113116506, 2350.647402889563, 2351.1535847095033, 2358.25714899806, 8051.235132662447, 8134.715284964997, 8135.837283254361, 8136.389770767216, 8138.918610813876, 4702.3416721659, 4792.041591681677, 4799.328094066834, 4828.637852161102, 4828.855134345975, 3138.419392412411, 3199.2001999500126, 3203.6315823680343, 3208.1658768720067, 3231.5475833383343, 984.8276551603512, 985.5023213277249, 1023.4933707814679, 1026.958921643141, 1056.5351245451977, 10534.683959481228, 10593.25847190697, 10621.0, 10645.361278323326, 10661.786764264749, 4097.795110244476, 4170.124273902454, 4191.476065491814, 4206.032612499082, 4231.090315582103, 8761.518116503526, 8815.647374104963, 8821.60302786376, 8841.513716745641, 8844.73465796027, 4697.224957881911, 4720.221163508051, 4726.338312636233, 4732.148213321635, 4734.881627959328, 4356.390105385249, 4399.6920215584605, 4411.073674528321, 4417.094495628388, 4425.424694789656, 3502.176988407722, 3520.9119772005906, 3531.2760884018717, 3534.929301414009, 3541.8406171722336, 1039.3867618105355, 1063.000779267486, 1070.1385384765338, 1073.75303680154, 1074.0, 1120.4061847220823, 1126.3298337489182, 1184.1237484261756, 1400.6218321053461, 1454.185656032604, 7258.782236532912, 7267.4549408794555, 7346.816329591803, 7412.962935185397, 7427.405807535384, 1182.9526818927318, 1183.8756930522343, 1187.2579637726421, 1205.1262834444958, 1210.352461433129, 6103.115048317969, 6103.877922441527, 6110.7555697771595, 6129.693515324216, 6133.3866613339205, 8993.235574976201, 9207.90792092084, 9296.488693121808, 9303.441793492411, 9356.111169438893, 9235.584398702074, 9267.72196834096, 9278.396904201205, 9336.4864932428, 9371.109744574254, 7394.889076663854, 7504.0, 7520.736774212876, 7534.962325188339, 7553.01810764608, 7556.433267504849, 7577.204393538599, 7609.961950190213, 7612.276833700789, 7648.464607477423, 7968.561729104955, 8567.143285671384, 8630.39587228888, 8668.133186681534, 8767.780805479659, 8397.160283971554, 8404.87392689098, 8466.322694184328, 8544.273736732448, 8686.261667758312, 7093.397061249645, 7134.857302854018, 7145.1425828900865, 7169.139703235645, 7188.245234250328, 7254.0098167082915, 7373.078365204349, 7415.480916335805, 7419.777406677808, 7644.235576442311, 6701.66491675424, 7270.236625154283, 7288.416926645961, 7301.342879140902, 7365.7790266292095, 6422.710978006095, 6958.617276049663, 7054.047703559953, 7195.784126476214, 7304.086989126359, 7357.558546487228, 7384.040074790243, 7387.593682347522, 7392.815179620553, 7440.255974402517, 6818.761343352959, 6827.965860170667, 6833.658317084027, 6869.690863911236, 6884.5180837342905, 6510.121133646897, 6608.669566521751, 6632.900506492503, 6752.527323087336, 6783.05037294789], "unit": "ms", "name": "mootools.html", "value": 4591.031761594318}, {"lowerIsBetter": false, "replicates": [360.96209897960716, 371.7082090558912, 372.51014915386264, 375.78016860136825, 376.26628075253245, 6300.0, 6385.616862988219, 6394.808155755329, 6398.968005159979, 6449.161608990837, 6111.7249723762425, 6248.531360147985, 6267.905981410271, 6274.152989346437, 6278.9372106278925, 4791.808327666889, 4797.832075877345, 4810.446798618169, 4819.831305904286, 4839.5644392004715, 4831.299461578086, 4844.0, 4848.321235027099, 4851.66038377312, 4862.708237505743, 4738.47876733559, 4831.516848315158, 4832.106060378824, 4835.734034628094, 4842.370491836056, 4803.78382972767, 4825.227963525819, 4835.347228124193, 4837.226043833005, 4838.540338667821, 4182.979085104555, 4249.915001699979, 4255.000074982377, 4262.019735460831, 4270.9109177159935, 5991.820245392645, 5995.610285331483, 6006.789762358297, 6017.939820601781, 6023.909641355383, 5508.256385387961, 5590.832275031756, 5604.187392828017, 5614.29821272341, 5640.153976903456, 6680.331966803281, 6711.060451536789, 6711.56374835639, 6729.5625784323865, 6731.93268067318, 4632.837850675211, 4634.536546345372, 4641.141388843075, 4642.396488456513, 4645.744484053375, 6878.55289406187, 6910.827229319257, 6932.757353492654, 6964.129483814523, 6996.930030699729, 4681.9297710534365, 4734.337192793012, 4740.7437029187295, 4741.099191153669, 4745.098431298043, 4809.591184749265, 4810.037992401533, 4811.27830825372, 4815.856943660107, 4818.253170758538, 5555.527780138734, 5578.54957710998, 5587.189857470726, 5596.048671725816, 5598.636088654224, 6532.542722009509, 6805.115335006418, 6813.148356455443, 6828.770821252222, 6829.658517074126, 1664.4923298394106, 1689.1047744695331, 1702.1914590569381, 1704.0797969096798, 1706.6416052629088, 1127.808272593661, 1135.517405102828, 1139.0716565998684, 1149.83327417524, 1150.6605551362368, 6480.2547707013355, 6553.049807777846, 6580.407763301326, 6591.307912669101, 6597.736090556324, 6905.551139175937, 6976.232614412411, 6989.580625162506, 7000.124984376953, 7009.404200643003, 6484.448821850101, 6490.4807615390655, 6514.804555863332, 6575.901361479581, 6578.934210657928, 3778.981105094457, 3780.3006443807985, 3782.924341513154, 3784.262068896594, 3790.336691079105, 7140.464465165133, 7147.571145731273, 7177.7487787927175, 7178.569285842762, 7188.0, 7009.824754381079, 7126.251743566954, 7156.749513766993, 7181.174164971095, 7193.676284567207, 7168.856622867514, 7169.175544812413, 7191.316824901626, 7195.388391986635, 7195.992561041458, 6962.094927659372, 7002.4398048157045, 7002.684879180347, 7004.264552222147, 7013.368796808311, 6745.5952642841585, 6900.2409734928115, 6919.204291506541, 6923.376896079377, 6924.826879328057, 7102.4673149512955, 7178.533395329287, 7185.964070179615, 7193.0, 7194.388476979515, 4750.5961993229585, 4765.666403351871, 4775.71345719258, 4782.37829082231, 4784.330193772944, 6812.591244525344, 6891.827704307432, 6916.3429474199875, 6939.097917270722, 6944.201416836926, 6750.72997080131, 6768.898466523105, 6791.0, 6804.557703749439, 6807.421369183477, 6748.0, 6756.155480564929, 6762.222344430454, 6782.25395206517, 6796.830079248059, 6516.152900122954, 6645.933540664531, 6659.334066593302, 6662.200535935719, 6703.966480167568, 6774.661266936535, 6806.863862722619, 6834.8633027340165, 6835.179778426621, 6838.452923766186, 6620.073189753534, 6626.370494802986, 6636.767713130017, 6640.07039014548, 6657.667116644246], "unit": "ms", "name": "prototype.html", "value": 5085.394859417494}, {"lowerIsBetter": false, "replicates": [852.6418904060298, 903.9909600903989, 922.1976880114302, 923.2798417234555, 946.2950102173882, 15821.762673559891, 16186.433474828384, 16191.838081619195, 16206.108664023473, 16334.918325408371, 15461.458848940289, 15502.5349239523, 15538.067715937052, 15619.843801561981, 15645.687086258267, 915.057490784493, 928.1414691410453, 936.7049379445486, 937.728058862929, 943.7451887990238, 935.242453612576, 935.9766005849874, 939.5349302095439, 939.6194541210821, 939.8872135343769, 958.702802131338, 962.4369743699943, 966.7534778631474, 967.719361385201, 970.3110791338123, 955.7276176289724, 959.6545243712258, 960.2414092866592, 963.3978763272954, 963.9807203855919, 713.105053158283, 714.921358650548, 716.7491378017704, 717.0033653222025, 718.737660753821, 14631.561053168421, 14739.189344586044, 14744.631384215374, 14745.70508589833, 14761.483348082873, 12761.808572871414, 12772.48910043597, 13030.087893847434, 13293.268870212134, 13581.456741730417, 10185.643502477378, 10626.0, 10635.361878287327, 10823.783524329468, 10974.0, 3766.3408903441787, 3814.332491813949, 3844.3464611016193, 3876.3991581304945, 3878.3600705883496, 48252.03495930097, 48259.276110858365, 48340.27489587659, 48463.0, 48696.51303486955, 10483.213758968108, 10779.784404312026, 11336.659900203007, 11412.885871141183, 11429.199956003165, 19243.230270789292, 19658.41024769259, 19665.606687866162, 19722.802771972383, 19952.20191192336, 8261.8347633047, 8272.462289951134, 8282.296004839536, 8349.95825020871, 8523.40336176474, 4505.414296141546, 4557.772111394417, 4566.908661826811, 4573.885652858705, 4673.883152921204, 3423.4864770284157, 3441.1913200398385, 3444.121748954001, 3493.3537295600395, 3540.380433424192, 613.7176898626682, 614.5421660862686, 623.2271982741458, 623.9001759718424, 626.6866566716642, 722.8409749855024, 723.1791916175074, 734.5262305812721, 744.0253268218651, 761.767660863442, 9274.953625231965, 9940.10539051489, 9989.802283100513, 9994.851587097244, 10087.596496140219, 598.1267349669445, 635.7488791927162, 706.3501578547748, 732.7435397610793, 733.3399940053888, 4362.800229936793, 4415.448068991376, 4580.312953057001, 4631.675782695246, 4666.626669866402, 54297.45702543003, 54321.185182222296, 55023.0, 59391.406085938586, 59848.70075649594, 52760.73619631877, 53343.46656533385, 55121.44878551243, 55509.16736248959, 55617.0, 47848.52151478441, 49137.508624913295, 49560.256596151085, 51226.48773512217, 51375.48624513707, 9091.586852686534, 9180.219681327162, 9504.287178461505, 9633.566489507848, 9794.951025244829, 37430.251394971405, 37982.43026354552, 38072.61927380691, 38122.0, 38189.2362152761, 48153.75923120502, 48759.75620121877, 49279.50720492749, 49331.75334123307, 49587.0, 11250.887491125311, 11285.887141128484, 11636.301821890713, 12182.086343524448, 12411.131220814455, 13183.0, 13191.0, 13223.272720000492, 13606.591802245948, 13988.650283742987, 11355.545778169111, 11566.884331156582, 11662.825057623973, 12213.267203967791, 12371.443285052374, 12402.0, 12418.316992565495, 12635.494580216688, 12682.429290681757, 12700.174488658207, 11871.287722736663, 11935.104867134825, 12044.879551204376, 12136.0, 12210.633680989584, 10166.542505587118, 10423.426711530636, 10432.58269669235, 10525.263231573716, 10984.615538456115, 10187.541560629641, 10292.794144116926, 10350.896491034993, 10381.740456488647, 10424.947875260576], "unit": "ms", "name": "yui.html", "value": 6913.36093453813}], "name": "dromaeo_css", "value": 7374.094434634584}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 109.0, 109.0, 110.0, 119.0, 112.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 144.0, 161.0, 124.0, 150.0, 153.0, 122.0, 173.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 73.0, 160.0, 73.0, 71.0, 72.0, 73.0, 162.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 90.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 93.0, 92.0, 140.0, 92.0, 93.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 62.0, 61.0, 63.0, 64.0, 65.0, 63.0, 69.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 62.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 67.0, 66.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.1}, {"lowerIsBetter": true, "replicates": [81.0, 89.0, 81.0, 82.0, 83.0, 90.0, 84.0, 90.0, 81.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 114.0, 118.0, 114.0, 119.0, 116.0, 115.0, 117.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [143.0, 152.0, 148.0, 149.0, 144.0, 144.0, 148.0, 146.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 67.0, 68.0, 66.0, 68.0, 67.0, 66.0, 68.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1509.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.66326362588507], "unit": "score", "name": "Richards", "value": 214.38904599999995}, {"lowerIsBetter": false, "replicates": [168.29350387075058], "unit": "score", "name": "DeltaBlue", "value": 392.8731559999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [884.1732979664014], "unit": "score", "name": "RayTrace", "value": 836.9275589999997}, {"lowerIsBetter": false, "replicates": [548.847420417124], "unit": "score", "name": "Earley", "value": 1214.2955859999995}, {"lowerIsBetter": false, "replicates": [10978.260869565218], "unit": "score", "name": "Boyer", "value": 60.70752079207921}, {"lowerIsBetter": false, "replicates": [24512.19512195122], "unit": "score", "name": "RegExp", "value": 37.1645621890547}, {"lowerIsBetter": false, "replicates": [512.2950819672132], "unit": "score", "name": "Splay", "value": 159.07043199999998}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 23309.230259752472}]} 17:14:12 INFO - RETURN: dromaeo_css: 7374.09 17:14:12 INFO - RETURN: kraken: 1509.60 17:14:12 INFO - RETURN: v8_7: 23309.23 17:14:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23309.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1509.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7374.09"}}} 17:14:12 INFO - Return code: 0 17:14:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:14:12 INFO - # TBPL SUCCESS # 17:14:12 INFO - Running post-action listener: _resource_record_post_action 17:14:12 INFO - Running post-run listener: _resource_record_post_run 17:14:13 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513323008; Read time: 20; Write time: 571572 17:14:13 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 238039040; Read time: 0; Write time: 360272 17:14:13 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275283968; Read time: 20; Write time: 211300 17:14:13 INFO - Running post-run listener: _upload_blobber_files 17:14:13 INFO - Blob upload gear active. 17:14:13 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:14:13 INFO - Copying logs to upload dir... 17:14:13 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.397796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-22 17:14:13.465577) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:13.468721) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010015 build_url: 'https://queue.taskcluster.net/v1/task/d3frCFZqQnedfRj-qSZmPA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:13.520971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:13.521356) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1453510356.990771-1050464584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 17:14:13.574389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 17:14:13.575010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 17:14:13.575695) ========= ========= Total master_lag: 0.28 =========