builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1453290366.53 results: success (0) buildid: 20160120011619 builduid: 3febfa71171f40f19f6a9839e4b966bd revision: 0d26450b5fab028cf96540799954808177f84340 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.527173) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.527689) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.528090) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006244 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.553762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.554360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.568520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.569091) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.620722) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.621232) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.621759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.622091) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 03:46:07-- 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.4M=0s 2016-01-20 03:46:07 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.794968) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.795737) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022043 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.848148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:06.848667) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d26450b5fab028cf96540799954808177f84340 --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 0d26450b5fab028cf96540799954808177f84340 --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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 03:46:07,519 truncating revision to first 12 chars 2016-01-20 03:46:07,519 Setting DEBUG logging. 2016-01-20 03:46:07,519 attempt 1/10 2016-01-20 03:46:07,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d26450b5fab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 03:46:08,053 unpacking tar archive at: mozilla-aurora-0d26450b5fab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857395 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.722413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.722835) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004785 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.779547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.779966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.790222) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.790543) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 03:46:07.790994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-20 03:46:07.791338) ========= /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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:08 INFO - MultiFileLogger online at 20160120 03:46:08 in /builds/slave/test-pgo 03:46:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:46:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:08 INFO - {'append_to_log': False, 03:46:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:46:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:08 INFO - 'branch': 'Mozilla-Aurora', 03:46:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:08 INFO - 'config_files': ('talos/linux_config.py',), 03:46:08 INFO - 'default_actions': ('clobber', 03:46:08 INFO - 'read-buildbot-config', 03:46:08 INFO - 'download-and-extract', 03:46:08 INFO - 'populate-webroot', 03:46:08 INFO - 'create-virtualenv', 03:46:08 INFO - 'install', 03:46:08 INFO - 'run-tests'), 03:46:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:08 INFO - 'download_minidump_stackwalk': True, 03:46:08 INFO - 'download_symbols': 'ondemand', 03:46:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:08 INFO - 'installer_path': 'installer.exe', 03:46:08 INFO - 'log_level': 'info', 03:46:08 INFO - 'log_name': 'talos', 03:46:08 INFO - 'log_to_console': True, 03:46:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:08 INFO - 'opt_config_files': (), 03:46:08 INFO - 'pip_index': False, 03:46:08 INFO - 'sps_profile': False, 03:46:08 INFO - 'sps_profile_interval': 0, 03:46:08 INFO - 'suite': 'dromaeojs-e10s', 03:46:08 INFO - 'system_bits': '32', 03:46:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:08 INFO - 'title': 'talos-linux64-ix-010', 03:46:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:08 INFO - 'use_talos_json': True, 03:46:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:08 INFO - 'work_dir': 'build'} 03:46:08 INFO - ##### 03:46:08 INFO - ##### Running clobber step. 03:46:08 INFO - ##### 03:46:08 INFO - Running pre-action listener: _resource_record_pre_action 03:46:08 INFO - Running main action method: clobber 03:46:08 INFO - rmtree: /builds/slave/test-pgo/build 03:46:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:09 INFO - Running post-action listener: _resource_record_post_action 03:46:09 INFO - ##### 03:46:09 INFO - ##### Running read-buildbot-config step. 03:46:09 INFO - ##### 03:46:09 INFO - Running pre-action listener: _resource_record_pre_action 03:46:09 INFO - Running main action method: read_buildbot_config 03:46:09 INFO - Using buildbot properties: 03:46:09 INFO - { 03:46:09 INFO - "properties": { 03:46:09 INFO - "buildnumber": 95, 03:46:09 INFO - "product": "firefox", 03:46:09 INFO - "script_repo_revision": "production", 03:46:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:46:09 INFO - "repository": "", 03:46:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:46:09 INFO - "buildid": "20160120011619", 03:46:09 INFO - "slavename": "talos-linux64-ix-010", 03:46:09 INFO - "pgo_build": "True", 03:46:09 INFO - "basedir": "/builds/slave/test-pgo", 03:46:09 INFO - "project": "", 03:46:09 INFO - "platform": "ubuntu64_hw", 03:46:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:46:09 INFO - "slavebuilddir": "test", 03:46:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:46:09 INFO - "branch": "mozilla-aurora", 03:46:09 INFO - "repo_path": "releases/mozilla-aurora", 03:46:09 INFO - "stage_platform": "linux64-pgo", 03:46:09 INFO - "builduid": "3febfa71171f40f19f6a9839e4b966bd", 03:46:09 INFO - "revision": "0d26450b5fab028cf96540799954808177f84340" 03:46:09 INFO - }, 03:46:09 INFO - "sourcestamp": { 03:46:09 INFO - "repository": "", 03:46:09 INFO - "hasPatch": false, 03:46:09 INFO - "project": "", 03:46:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:09 INFO - "changes": [ 03:46:09 INFO - { 03:46:09 INFO - "category": null, 03:46:09 INFO - "files": [ 03:46:09 INFO - { 03:46:09 INFO - "url": null, 03:46:09 INFO - "name": "https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:46:09 INFO - } 03:46:09 INFO - ], 03:46:09 INFO - "repository": "", 03:46:09 INFO - "rev": "0d26450b5fab028cf96540799954808177f84340", 03:46:09 INFO - "who": "cbook@mozilla.com", 03:46:09 INFO - "when": 1453290198, 03:46:09 INFO - "number": 7484363, 03:46:09 INFO - "comments": "Bug 1240993 - Remove deprecated --download-cache flag from pip invocation, r=bustage, a=bustage\n\nCLOSED TREE", 03:46:09 INFO - "project": "", 03:46:09 INFO - "at": "Wed 20 Jan 2016 03:43:18", 03:46:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:09 INFO - "revlink": "", 03:46:09 INFO - "properties": [ 03:46:09 INFO - [ 03:46:09 INFO - "buildid", 03:46:09 INFO - "20160120011619", 03:46:09 INFO - "Change" 03:46:09 INFO - ], 03:46:09 INFO - [ 03:46:09 INFO - "builduid", 03:46:09 INFO - "3febfa71171f40f19f6a9839e4b966bd", 03:46:09 INFO - "Change" 03:46:09 INFO - ], 03:46:09 INFO - [ 03:46:09 INFO - "pgo_build", 03:46:09 INFO - "True", 03:46:09 INFO - "Change" 03:46:09 INFO - ] 03:46:09 INFO - ], 03:46:09 INFO - "revision": "0d26450b5fab028cf96540799954808177f84340" 03:46:09 INFO - } 03:46:09 INFO - ], 03:46:09 INFO - "revision": "0d26450b5fab028cf96540799954808177f84340" 03:46:09 INFO - } 03:46:09 INFO - } 03:46:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:46:09 INFO - Running post-action listener: _resource_record_post_action 03:46:09 INFO - ##### 03:46:09 INFO - ##### Running download-and-extract step. 03:46:09 INFO - ##### 03:46:09 INFO - Running pre-action listener: _resource_record_pre_action 03:46:09 INFO - Running main action method: download_and_extract 03:46:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:09 INFO - https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/test_packages.json 03:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/test_packages.json 03:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:10 INFO - Downloaded 1302 bytes. 03:46:10 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:10 INFO - Using the following test package requirements: 03:46:10 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:10 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:10 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'jsshell-linux-x86_64.zip'], 03:46:10 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:10 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:10 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:10 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:10 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:10 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:10 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:10 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:10 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:10 INFO - https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:11 INFO - Downloaded 23025183 bytes. 03:46:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:12 INFO - Return code: 0 03:46:12 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:12 INFO - https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:14 INFO - Downloaded 23025183 bytes. 03:46: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 03:46:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46: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 03:46:15 INFO - Return code: 0 03:46: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')]} 03:46:15 INFO - https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:16 INFO - Downloaded 11132038 bytes. 03:46:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:46:16 INFO - Return code: 0 03:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 INFO - https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:46:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:17 INFO - Downloaded 58156229 bytes. 03:46:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:17 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:17 INFO - Contents: 03:46:17 INFO - build_url:https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:17 INFO - Running post-action listener: _resource_record_post_action 03:46:17 INFO - Running post-action listener: set_extra_try_arguments 03:46:17 INFO - ##### 03:46:17 INFO - ##### Running populate-webroot step. 03:46:17 INFO - ##### 03:46:17 INFO - Running pre-action listener: _resource_record_pre_action 03:46:17 INFO - Running main action method: populate_webroot 03:46:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:17 INFO - '--tppagecycles', 03:46:17 INFO - '7'], 03:46:17 INFO - 'tests': ['tsvgm']}}, 03:46:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'tests': ['damp', 'tps']}, 03:46:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['damp', 'tps']}, 03:46:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:17 INFO - 'other': {'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'other_l64': {'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:17 INFO - 'ts_paint', 03:46:17 INFO - 'tpaint', 03:46:17 INFO - 'sessionrestore', 03:46:17 INFO - 'sessionrestore_no_auto_restore']}, 03:46:17 INFO - 'svgr': {'tests': ['tsvgx', 03:46:17 INFO - 'tsvgr_opacity', 03:46:17 INFO - 'tart', 03:46:17 INFO - 'tscrollx', 03:46:17 INFO - 'cart']}, 03:46:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['tsvgx', 03:46:17 INFO - 'tsvgr_opacity', 03:46:17 INFO - 'tart', 03:46:17 INFO - 'tscrollx', 03:46:17 INFO - 'cart']}, 03:46:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'tests': ['tp5o']}, 03:46:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'talos_options': ['--e10s'], 03:46:17 INFO - 'tests': ['tp5o']}, 03:46:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'talos_options': ['--xperf_path', 03:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:17 INFO - 'tests': ['tp5n']}, 03:46:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:17 INFO - 'talos_options': ['--e10s', 03:46:17 INFO - '--xperf_path', 03:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:17 INFO - 'tests': ['tp5n']}}, 03:46:17 INFO - 'talos.zip': {'path': '', 03:46:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:17 INFO - Running post-action listener: _resource_record_post_action 03:46:17 INFO - ##### 03:46:17 INFO - ##### Running create-virtualenv step. 03:46:17 INFO - ##### 03:46:17 INFO - Running pre-action listener: _resource_record_pre_action 03:46:17 INFO - Running main action method: create_virtualenv 03:46:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:46:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:17 INFO - Using real prefix '/usr' 03:46:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:46:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:20 INFO - Installing pip.................done. 03:46:20 INFO - Return code: 0 03:46:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:46:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:46:20 INFO - Using env: {'DISPLAY': ':0', 03:46:20 INFO - 'HOME': '/home/cltbld', 03:46:20 INFO - 'LANG': 'en_US.UTF-8', 03:46:20 INFO - 'LANGUAGE': 'en_US:en', 03:46:20 INFO - 'LOGNAME': 'cltbld', 03:46:20 INFO - 'MAIL': '/var/mail/cltbld', 03:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:20 INFO - 'MOZ_NO_REMOTE': '1', 03:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:20 INFO - 'NO_EM_RESTART': '1', 03:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:20 INFO - 'SHELL': '/bin/bash', 03:46:20 INFO - 'SHLVL': '1', 03:46:20 INFO - 'TERM': 'linux', 03:46:20 INFO - 'TMOUT': '86400', 03:46:20 INFO - 'USER': 'cltbld', 03:46:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:20 INFO - '_': '/tools/buildbot/bin/python'} 03:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:46:20 INFO - Cleaning up... 03:46:20 INFO - Return code: 0 03:46:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:20 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:46:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:46:20 INFO - Using env: {'DISPLAY': ':0', 03:46:20 INFO - 'HOME': '/home/cltbld', 03:46:20 INFO - 'LANG': 'en_US.UTF-8', 03:46:20 INFO - 'LANGUAGE': 'en_US:en', 03:46:20 INFO - 'LOGNAME': 'cltbld', 03:46:20 INFO - 'MAIL': '/var/mail/cltbld', 03:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:20 INFO - 'MOZ_NO_REMOTE': '1', 03:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:20 INFO - 'NO_EM_RESTART': '1', 03:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:20 INFO - 'SHELL': '/bin/bash', 03:46:20 INFO - 'SHLVL': '1', 03:46:20 INFO - 'TERM': 'linux', 03:46:20 INFO - 'TMOUT': '86400', 03:46:20 INFO - 'USER': 'cltbld', 03:46:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:20 INFO - '_': '/tools/buildbot/bin/python'} 03:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:21 INFO - Downloading/unpacking psutil>=0.7.1 03:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:22 INFO - Installing collected packages: psutil 03:46:22 INFO - Running setup.py install for psutil 03:46:22 INFO - building 'psutil._psutil_linux' extension 03:46:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:46:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:46:23 INFO - building 'psutil._psutil_posix' extension 03:46:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:46:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:46:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:23 INFO - Successfully installed psutil 03:46:23 INFO - Cleaning up... 03:46:23 INFO - Return code: 0 03:46:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:23 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:46:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:46:23 INFO - Using env: {'DISPLAY': ':0', 03:46:23 INFO - 'HOME': '/home/cltbld', 03:46:23 INFO - 'LANG': 'en_US.UTF-8', 03:46:23 INFO - 'LANGUAGE': 'en_US:en', 03:46:23 INFO - 'LOGNAME': 'cltbld', 03:46:23 INFO - 'MAIL': '/var/mail/cltbld', 03:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:23 INFO - 'MOZ_NO_REMOTE': '1', 03:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:23 INFO - 'NO_EM_RESTART': '1', 03:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:23 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:23 INFO - 'SHELL': '/bin/bash', 03:46:23 INFO - 'SHLVL': '1', 03:46:23 INFO - 'TERM': 'linux', 03:46:23 INFO - 'TMOUT': '86400', 03:46:23 INFO - 'USER': 'cltbld', 03:46:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:23 INFO - '_': '/tools/buildbot/bin/python'} 03:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:25 INFO - Installing collected packages: mozsystemmonitor 03:46:25 INFO - Running setup.py install for mozsystemmonitor 03:46:25 INFO - Successfully installed mozsystemmonitor 03:46:25 INFO - Cleaning up... 03:46:25 INFO - Return code: 0 03:46:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:25 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:46:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:46:25 INFO - Using env: {'DISPLAY': ':0', 03:46:25 INFO - 'HOME': '/home/cltbld', 03:46:25 INFO - 'LANG': 'en_US.UTF-8', 03:46:25 INFO - 'LANGUAGE': 'en_US:en', 03:46:25 INFO - 'LOGNAME': 'cltbld', 03:46:25 INFO - 'MAIL': '/var/mail/cltbld', 03:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:25 INFO - 'MOZ_NO_REMOTE': '1', 03:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:25 INFO - 'NO_EM_RESTART': '1', 03:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:25 INFO - 'SHELL': '/bin/bash', 03:46:25 INFO - 'SHLVL': '1', 03:46:25 INFO - 'TERM': 'linux', 03:46:25 INFO - 'TMOUT': '86400', 03:46:25 INFO - 'USER': 'cltbld', 03:46:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:25 INFO - '_': '/tools/buildbot/bin/python'} 03:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:25 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:27 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:46:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:28 INFO - Downloading docopt-0.6.1.tar.gz 03:46:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:28 INFO - Running setup.py install for blobuploader 03:46:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:46:28 INFO - Running setup.py install for requests 03:46:28 INFO - Running setup.py install for docopt 03:46:28 INFO - Successfully installed blobuploader requests docopt 03:46:28 INFO - Cleaning up... 03:46:28 INFO - Return code: 0 03:46:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:28 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:46:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:28 INFO - Using env: {'DISPLAY': ':0', 03:46:28 INFO - 'HOME': '/home/cltbld', 03:46:28 INFO - 'LANG': 'en_US.UTF-8', 03:46:28 INFO - 'LANGUAGE': 'en_US:en', 03:46:28 INFO - 'LOGNAME': 'cltbld', 03:46:28 INFO - 'MAIL': '/var/mail/cltbld', 03:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:28 INFO - 'MOZ_NO_REMOTE': '1', 03:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:28 INFO - 'NO_EM_RESTART': '1', 03:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:28 INFO - 'SHELL': '/bin/bash', 03:46:28 INFO - 'SHLVL': '1', 03:46:28 INFO - 'TERM': 'linux', 03:46:28 INFO - 'TMOUT': '86400', 03:46:28 INFO - 'USER': 'cltbld', 03:46:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:28 INFO - '_': '/tools/buildbot/bin/python'} 03:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:28 INFO - Running setup.py (path:/tmp/pip-EwRzMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:29 INFO - Running setup.py (path:/tmp/pip-rAHeeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:29 INFO - Running setup.py (path:/tmp/pip-5QMerk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:29 INFO - Running setup.py (path:/tmp/pip-NYbdxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:29 INFO - Running setup.py (path:/tmp/pip-iYy00u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:29 INFO - Running setup.py (path:/tmp/pip-sA7HyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:29 INFO - Running setup.py (path:/tmp/pip-qYW7_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:29 INFO - Running setup.py (path:/tmp/pip-SK599g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:29 INFO - Running setup.py (path:/tmp/pip-PB_ghT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:29 INFO - Running setup.py (path:/tmp/pip-0ggwxR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:29 INFO - Running setup.py (path:/tmp/pip-um5crm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:29 INFO - Running setup.py (path:/tmp/pip-JHaKke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:29 INFO - Running setup.py (path:/tmp/pip-vBmHuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:29 INFO - Running setup.py (path:/tmp/pip-5ghkxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:29 INFO - Running setup.py (path:/tmp/pip-2OJjMg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:30 INFO - Running setup.py (path:/tmp/pip-lWgy8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:30 INFO - Running setup.py (path:/tmp/pip-Eq2BtC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:30 INFO - Running setup.py install for manifestparser 03:46:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Running setup.py install for mozcrash 03:46:30 INFO - Running setup.py install for mozdebug 03:46:30 INFO - Running setup.py install for mozdevice 03:46:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Running setup.py install for mozfile 03:46:30 INFO - Running setup.py install for mozhttpd 03:46:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Running setup.py install for mozinfo 03:46:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Running setup.py install for mozInstall 03:46:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:46:30 INFO - Running setup.py install for mozleak 03:46:31 INFO - Running setup.py install for mozlog 03:46:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Running setup.py install for moznetwork 03:46:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Running setup.py install for mozprocess 03:46:31 INFO - Running setup.py install for mozprofile 03:46:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Running setup.py install for mozrunner 03:46:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Running setup.py install for mozscreenshot 03:46:31 INFO - Running setup.py install for moztest 03:46:31 INFO - Running setup.py install for mozversion 03:46:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:46:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:31 INFO - Cleaning up... 03:46:31 INFO - Return code: 0 03:46:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:46:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:31 INFO - Using env: {'DISPLAY': ':0', 03:46:31 INFO - 'HOME': '/home/cltbld', 03:46:31 INFO - 'LANG': 'en_US.UTF-8', 03:46:31 INFO - 'LANGUAGE': 'en_US:en', 03:46:31 INFO - 'LOGNAME': 'cltbld', 03:46:31 INFO - 'MAIL': '/var/mail/cltbld', 03:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:31 INFO - 'MOZ_NO_REMOTE': '1', 03:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:31 INFO - 'NO_EM_RESTART': '1', 03:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:31 INFO - 'SHELL': '/bin/bash', 03:46:31 INFO - 'SHLVL': '1', 03:46:31 INFO - 'TERM': 'linux', 03:46:31 INFO - 'TMOUT': '86400', 03:46:31 INFO - 'USER': 'cltbld', 03:46:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:31 INFO - '_': '/tools/buildbot/bin/python'} 03:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:32 INFO - Running setup.py (path:/tmp/pip-Erpm1C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:32 INFO - Running setup.py (path:/tmp/pip-oW3Ftl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:32 INFO - Running setup.py (path:/tmp/pip-RpthAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:32 INFO - Running setup.py (path:/tmp/pip-MR6xdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:32 INFO - Running setup.py (path:/tmp/pip-FgOwcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:32 INFO - Running setup.py (path:/tmp/pip-rIs8d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:32 INFO - Running setup.py (path:/tmp/pip-Eqazyl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:32 INFO - Running setup.py (path:/tmp/pip-d30F5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:32 INFO - Running setup.py (path:/tmp/pip-ktiqWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:32 INFO - Running setup.py (path:/tmp/pip-xU4imc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:32 INFO - Running setup.py (path:/tmp/pip-k8hdXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:32 INFO - Running setup.py (path:/tmp/pip-gskpvv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:46:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:32 INFO - Running setup.py (path:/tmp/pip-p7SCVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:46:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:33 INFO - Running setup.py (path:/tmp/pip-oNYLeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:46:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:33 INFO - Running setup.py (path:/tmp/pip-n711IK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:46:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:33 INFO - Running setup.py (path:/tmp/pip-2frc4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:46:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:33 INFO - Running setup.py (path:/tmp/pip-odyd_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:46:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:35 INFO - Downloading blessings-1.5.1.tar.gz 03:46:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:35 INFO - Installing collected packages: blessings 03:46:35 INFO - Running setup.py install for blessings 03:46:35 INFO - Successfully installed blessings 03:46:35 INFO - Cleaning up... 03:46:35 INFO - Return code: 0 03:46:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:46:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:35 INFO - Reading from file tmpfile_stdout 03:46:35 INFO - Current package versions: 03:46:35 INFO - argparse == 1.2.1 03:46:35 INFO - blessings == 1.5.1 03:46:35 INFO - blobuploader == 1.2.4 03:46:35 INFO - docopt == 0.6.1 03:46:35 INFO - manifestparser == 1.1 03:46:35 INFO - mozInstall == 1.12 03:46:35 INFO - mozcrash == 0.16 03:46:35 INFO - mozdebug == 0.1 03:46:35 INFO - mozdevice == 0.47 03:46:35 INFO - mozfile == 1.2 03:46:35 INFO - mozhttpd == 0.7 03:46:35 INFO - mozinfo == 0.9 03:46:35 INFO - mozleak == 0.1 03:46:35 INFO - mozlog == 3.1 03:46:35 INFO - moznetwork == 0.27 03:46:35 INFO - mozprocess == 0.22 03:46:35 INFO - mozprofile == 0.27 03:46:35 INFO - mozrunner == 6.11 03:46:35 INFO - mozscreenshot == 0.1 03:46:35 INFO - mozsystemmonitor == 0.0 03:46:35 INFO - moztest == 0.7 03:46:35 INFO - mozversion == 1.4 03:46:35 INFO - psutil == 3.1.1 03:46:35 INFO - requests == 1.2.3 03:46:35 INFO - wsgiref == 0.1.2 03:46:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:35 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:46:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:35 INFO - Using env: {'DISPLAY': ':0', 03:46:35 INFO - 'HOME': '/home/cltbld', 03:46:35 INFO - 'LANG': 'en_US.UTF-8', 03:46:35 INFO - 'LANGUAGE': 'en_US:en', 03:46:35 INFO - 'LOGNAME': 'cltbld', 03:46:35 INFO - 'MAIL': '/var/mail/cltbld', 03:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:35 INFO - 'MOZ_NO_REMOTE': '1', 03:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:35 INFO - 'NO_EM_RESTART': '1', 03:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:35 INFO - 'SHELL': '/bin/bash', 03:46:35 INFO - 'SHLVL': '1', 03:46:35 INFO - 'TERM': 'linux', 03:46:35 INFO - 'TMOUT': '86400', 03:46:35 INFO - 'USER': 'cltbld', 03:46:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:35 INFO - '_': '/tools/buildbot/bin/python'} 03:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:46:35 INFO - Cleaning up... 03:46:35 INFO - Return code: 0 03:46:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:35 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:46:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:46:35 INFO - Using env: {'DISPLAY': ':0', 03:46:35 INFO - 'HOME': '/home/cltbld', 03:46:35 INFO - 'LANG': 'en_US.UTF-8', 03:46:35 INFO - 'LANGUAGE': 'en_US:en', 03:46:35 INFO - 'LOGNAME': 'cltbld', 03:46:35 INFO - 'MAIL': '/var/mail/cltbld', 03:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:35 INFO - 'MOZ_NO_REMOTE': '1', 03:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:35 INFO - 'NO_EM_RESTART': '1', 03:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:35 INFO - 'SHELL': '/bin/bash', 03:46:35 INFO - 'SHLVL': '1', 03:46:35 INFO - 'TERM': 'linux', 03:46:35 INFO - 'TMOUT': '86400', 03:46:35 INFO - 'USER': 'cltbld', 03:46:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:35 INFO - '_': '/tools/buildbot/bin/python'} 03:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:35 INFO - Downloading/unpacking jsonschema 03:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:37 INFO - Downloading/unpacking functools32 (from jsonschema) 03:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:37 INFO - warning: no files found matching '*.txt' 03:46:37 INFO - no previously-included directories found matching 'build' 03:46:37 INFO - no previously-included directories found matching 'dist' 03:46:37 INFO - no previously-included directories found matching '.git*' 03:46:37 INFO - Installing collected packages: jsonschema, functools32 03:46:37 INFO - Running setup.py install for functools32 03:46:38 INFO - warning: no files found matching '*.txt' 03:46:38 INFO - no previously-included directories found matching 'build' 03:46:38 INFO - no previously-included directories found matching 'dist' 03:46:38 INFO - no previously-included directories found matching '.git*' 03:46:38 INFO - Successfully installed jsonschema functools32 03:46:38 INFO - Cleaning up... 03:46:38 INFO - Return code: 0 03:46:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:46: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')]} 03:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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')]} 03:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:38 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 0x7f9ddd5f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1484450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, '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': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:46:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:46:38 INFO - Using env: {'DISPLAY': ':0', 03:46:38 INFO - 'HOME': '/home/cltbld', 03:46:38 INFO - 'LANG': 'en_US.UTF-8', 03:46:38 INFO - 'LANGUAGE': 'en_US:en', 03:46:38 INFO - 'LOGNAME': 'cltbld', 03:46:38 INFO - 'MAIL': '/var/mail/cltbld', 03:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:38 INFO - 'MOZ_NO_REMOTE': '1', 03:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:38 INFO - 'NO_EM_RESTART': '1', 03:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:38 INFO - 'SHELL': '/bin/bash', 03:46:38 INFO - 'SHLVL': '1', 03:46:38 INFO - 'TERM': 'linux', 03:46:38 INFO - 'TMOUT': '86400', 03:46:38 INFO - 'USER': 'cltbld', 03:46:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:38 INFO - '_': '/tools/buildbot/bin/python'} 03:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:38 INFO - Downloading/unpacking flake8 03:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:46:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:46:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:40 INFO - no previously-included directories found matching 'docs/_build' 03:46:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:40 INFO - Running setup.py install for pep8 03:46:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:40 INFO - no previously-included directories found matching 'docs/_build' 03:46:40 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:46:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:40 INFO - Cleaning up... 03:46:40 INFO - Return code: 0 03:46:40 INFO - Running post-action listener: _resource_record_post_action 03:46:40 INFO - Running post-action listener: _start_resource_monitoring 03:46:40 INFO - Starting resource monitoring. 03:46:40 INFO - ##### 03:46:40 INFO - ##### Running install step. 03:46:40 INFO - ##### 03:46:40 INFO - Running pre-action listener: _resource_record_pre_action 03:46:40 INFO - Running main action method: install 03:46:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:41 INFO - Reading from file tmpfile_stdout 03:46:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:46:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:46:41 INFO - Reading from file tmpfile_stdout 03:46:41 INFO - Output received: 03:46:41 INFO - Usage: mozinstall [options] installer 03:46:41 INFO - Options: 03:46:41 INFO - -h, --help show this help message and exit 03:46:41 INFO - -d DEST, --destination=DEST 03:46:41 INFO - Directory to install application into. [default: 03:46:41 INFO - "/builds/slave/test-pgo"] 03:46:41 INFO - --app=APP Application being installed. [default: firefox] 03:46:41 INFO - mkdir: /builds/slave/test-pgo/build/application 03:46:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:46:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:46:56 INFO - Reading from file tmpfile_stdout 03:46:56 INFO - Output received: 03:46:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:46:56 INFO - Running post-action listener: _resource_record_post_action 03:46:56 INFO - ##### 03:46:56 INFO - ##### Running run-tests step. 03:46:56 INFO - ##### 03:46:56 INFO - Running pre-action listener: _resource_record_pre_action 03:46:56 INFO - Running main action method: run_tests 03:46:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:46:56 INFO - Python 2.7.3 03:46:56 INFO - Return code: 0 03:46:56 INFO - grabbing minidump binary from tooltool 03:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:56 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 0x1516a50>, '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 0x1482550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14829e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:46:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:46:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:46:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:56 INFO - Return code: 0 03:46:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:46:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:46:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:46:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:46:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:46:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:46:57 INFO - Return code: 0 03:46:57 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/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:46:57 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/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 03:46:57 INFO - Using env: {'DISPLAY': ':0', 03:46:57 INFO - 'HOME': '/home/cltbld', 03:46:57 INFO - 'LANG': 'en_US.UTF-8', 03:46:57 INFO - 'LANGUAGE': 'en_US:en', 03:46:57 INFO - 'LOGNAME': 'cltbld', 03:46:57 INFO - 'MAIL': '/var/mail/cltbld', 03:46:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:46:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:57 INFO - 'MOZ_NO_REMOTE': '1', 03:46:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:57 INFO - 'NO_EM_RESTART': '1', 03:46:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:46:57 INFO - 'SHELL': '/bin/bash', 03:46:57 INFO - 'SHLVL': '1', 03:46:57 INFO - 'TERM': 'linux', 03:46:57 INFO - 'TMOUT': '86400', 03:46:57 INFO - 'USER': 'cltbld', 03:46:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373', 03:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:57 INFO - '_': '/tools/buildbot/bin/python'} 03:46:57 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/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 03:46:57 INFO - mozversion INFO | application_buildid: 20160120011619 03:46:57 INFO - mozversion INFO | application_changeset: 0d26450b5fab028cf96540799954808177f84340 03:46:57 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:46:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:57 INFO - mozversion INFO | application_name: Firefox 03:46:57 INFO - mozversion INFO | application_remotingname: firefox-dev 03:46:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:57 INFO - mozversion INFO | application_vendor: Mozilla 03:46:57 INFO - mozversion INFO | application_version: 45.0a2 03:46:57 INFO - mozversion INFO | platform_buildid: 20160120011619 03:46:57 INFO - mozversion INFO | platform_changeset: 0d26450b5fab028cf96540799954808177f84340 03:46:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:57 INFO - mozversion INFO | platform_version: 45.0a2 03:46:57 INFO - 2016-01-20 03:46:57,498 DEBUG : using testdate: 1453290417 03:46:57 INFO - 2016-01-20 03:46:57,498 DEBUG : actual date: 1453290417 03:46:57 INFO - 2016-01-20 03:46:57,507 INFO : starting webserver on 'localhost:56361' 03:46:57 INFO - 2016-01-20 03:46:57,508 INFO : Starting test suite talos-linux64-ix-010.e 03:46:57 INFO - 2016-01-20 03:46:57,508 INFO : Starting test dromaeo_css 03:46:57 INFO - 2016-01-20 03:46:57,508 DEBUG : operating with platform_type : linux_ 03:46:57 INFO - 2016-01-20 03:46:57,509 INFO : Initialising browser for dromaeo_css test... 03:46:57 INFO - 2016-01-20 03:46:57,522 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeUX0EO/profile http://localhost:56361/getInfo.html 03:47:01 INFO - 2016-01-20 03:47:01,242 DEBUG : BROWSER_OUTPUT: 03:47:01 INFO - 2016-01-20 03:47:01,242 DEBUG : BROWSER_OUTPUT: (process:29088): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:02 INFO - 2016-01-20 03:47:02,158 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:02 INFO - 2016-01-20 03:47:02,158 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:02 INFO - 2016-01-20 03:47:02,158 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:02 INFO - 2016-01-20 03:47:02,158 DEBUG : BROWSER_OUTPUT: __metrics 03:47:03 INFO - 2016-01-20 03:47:03,185 INFO : Browser initialized. 03:47:03 INFO - 2016-01-20 03:47:03,185 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:03 INFO - 2016-01-20 03:47:03,186 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeUX0EO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:04 INFO - 2016-01-20 03:47:04,437 DEBUG : BROWSER_OUTPUT: 03:47:04 INFO - 2016-01-20 03:47:04,438 DEBUG : BROWSER_OUTPUT: (process:29199): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:14 INFO - 2016-01-20 03:47:14,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 136441856 03:47:14 INFO - 2016-01-20 03:47:14,941 DEBUG : BROWSER_OUTPUT: 03:48:04 INFO - 2016-01-20 03:48:04,570 DEBUG : BROWSER_OUTPUT: 1453290484568 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:50:12 INFO - 2016-01-20 03:50:12,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56361/tests/dromaeo/cssquery-ext.html) 03:50:13 INFO - 2016-01-20 03:50:13,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 141897728 03:50:13 INFO - 2016-01-20 03:50:13,604 DEBUG : BROWSER_OUTPUT: 03:53:15 INFO - 2016-01-20 03:53:15,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-ext.html (next: http://localhost:56361/tests/dromaeo/cssquery-jquery.html) 03:53:16 INFO - 2016-01-20 03:53:16,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 03:53:16 INFO - 2016-01-20 03:53:16,045 DEBUG : BROWSER_OUTPUT: 03:56:17 INFO - 2016-01-20 03:56:17,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56361/tests/dromaeo/cssquery-mootools.html) 03:56:18 INFO - 2016-01-20 03:56:18,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 138059776 03:56:18 INFO - 2016-01-20 03:56:18,249 DEBUG : BROWSER_OUTPUT: 03:59:19 INFO - 2016-01-20 03:59:19,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56361/tests/dromaeo/cssquery-prototype.html) 03:59:20 INFO - 2016-01-20 03:59:20,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 137879552 03:59:20 INFO - 2016-01-20 03:59:20,403 DEBUG : BROWSER_OUTPUT: 04:02:22 INFO - 2016-01-20 04:02:22,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56361/tests/dromaeo/cssquery-yui.html) 04:02:23 INFO - 2016-01-20 04:02:23,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 04:02:23 INFO - 2016-01-20 04:02:23,250 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/dromaeo/cssquery-yui.html (next: http://localhost:56361/tests/dromaeo/cssquery-dojo.html) 04:05:25 INFO - 2016-01-20 04:05:25,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 141406208 04:05:25 INFO - 2016-01-20 04:05:25,632 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,632 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:25 INFO - 2016-01-20 04:05:25,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:25 INFO - 2016-01-20 04:05:25,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:25 INFO - 2016-01-20 04:05:25,633 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:25 INFO - 2016-01-20 04:05:25,633 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3391.084407210053;3445.7071148952323;3455;3482.860685572578;3483.7909725416475;5587.161925711145;5644.181593668925;5649.8305050848485;5685.715714214293;5691.857703557408;5643.238162848014;5677.48902598766;5682.062459694145;5713;5744.33940096889;5165.612579056567;5226.05930932432;5263.131583288753;5282.947170528284;5285.7885684572575;5093.898122037575;5146.5625421839;5220.556252718524;5233.031889100528;5257.7108259045735;5138.871528211787;5221.6083793715625;5222.791088356461;5234.7644356004075;5235.319408476893;5176.896462070775;5218.295530103444;5236.502532259429;5242.266082748418;5265.631405801595;4988.276699878534;5045.747712614355;5089.618278629081;5106.540411362958;5107.20838270065;5429.56563474921;5433.728313584305;5470.8085217017615;5476.151196564539;5491.588130890199;6021.909671354933;6047.274327080734;6066.059760737093;6079.817605471843;6108.450239478469;5789.334226563957;5886.293644762613;5905.320888097838;5972.970135149297;5982.162497250389;5741.081426971665;5760.9711951440395;5784.13238014297;5792.160136780143;5795.159701843251;5992.34084250732;6256.468200202943;6268.592541484789;6273.843153921097;6289.402506761941;5849.561282903799;5869.295684517885;5907.1434641976675;5912.526997840248;5967.701614919237;6000.8799824004145;6119.938800612026;6133.693315334304;6138.202033735586;6140.232470941132;5873.706314684248;5927.792527261525;6082.239720034996;6098.14625952367;6102;5942.435468630473;5975.282966044016;6017.368176341509;6038.969805150946;6063.151158837766;4556.908861822812;4592.471865735483;4597.816087356468;4603.631709463235;4637.513061128533;3961.3067713150085;4084.244414783275;4099;4171.6036976487185;4173.707840451139;5701.2018317435595;5743.770249189985;5761.971190144022;5787.276590426197;5792.420757924174;6109.541784366191;6126.08108783686;6126.23422072241;6133.723982420802;6142.385761423822;5552.444755524415;5624.465675760796;5666.320041595035;5733.684647344353;5770.769169233267;5268.92096618551;5316.043112239757;5336.119540275811;5358.517733404013;5358.544523715528;6230.127782110508;6235.376462353819;6239.032949892774;6243.0635404688755;6246.375362463808;5949.940500594938;6033.18551995475;6135.018317212141;6139;6143.020634991936;6192.3807619239515;6216.595921265103;6225.470834979077;6249.812505624838;6250.499960003098;5863.765449381977;6007.008843540942;6036.758529658764;6052.656515732597;6063.484603808725;5986.431289027535;6081.27024757032;6085.391460853879;6099.847503812262;6126.1423400724825;5828.271466066742;5844.590878638454;5858.9121163181735;5899.203607512931;5900.586958912835;5793.855153621024;5846.590738648254;5886.941130588811;5889.823305300848;5902.026165682614;5735.426457354231;5798.942010580009;5804.21643078179;5806.303243610625;5839.883202336015;5960.374160713062;6025.638461692312;6059.33347331802;6091.025435930407;6100.511959043355;5594.188842617717;5690.203371528072;5772.9711351442975;5945.554083443672;5945.732442040205 04:05:25 INFO - 2016-01-20 04:05:25,633 DEBUG : BROWSER_OUTPUT: |1;ext.html;598.2820615261685;640.9166808314919;640.9487241020715;644.4876323322958;651.7783953455826;38646.22707545851;39074;39302.41046384303;39312.21375572487;39609;44926.550734492645;45211.09577808442;45485.31772023422;45589.31616025754;45606;8885.111488851127;9069.138431848964;9082.228010619072;9114.179723824855;9140.360174787767;8954.910450895506;9055.773605659879;9061.954690226572;9063.95468022659;9102.681406150787;8966.103389661046;8971.95514022429;8981.101889811;9055.864162037575;9075.54622268884;9022.774430639254;9106.225970792491;9108.134727200939;9109.635614575442;9116.270698344117;8928.910710892873;9037.954810225907;9042.095790420972;9042.140996605312;9049.2308153807;41169.382459263135;41880.1623967519;41998.79000605008;42030.36954445686;42053.36919946203;3688.1517251032415;3796.2407518496134;3823.8852834414733;3839.654431101186;4321.805518751632;31680;31767.36465270705;31801.681983180104;32365;33362.6663733362;3386.3904497190497;3406.131436483681;3409.62494125646;3413.1637748751714;3428.7771294866;295792;299173;388452;391785;472826;60645.09032364518;60859;60936.69531652313;61026.69486652538;61110.38889611136;66316.33683663198;66326;66393.33606663968;66526.33473665202;66607.33392666011;18118.184681689356;18251.63496730058;18253.17860696272;18286.908565457088;18395.72406413905;14009;14018.719625607431;14078.507252246121;14110.71778564423;14139.222342771041;22342.66486002711;22427.551448970928;22496.77503224947;22589.322320330415;22621.20825771123;8259.917400825914;8358.665653373797;8405;8445;8519.872201916853;1042.4006196437078;1047.0994944347856;1109.1182509904645;1141.84585081013;1211.357980270458;29227;29282.414351712847;29398.412031759246;29401.264968375533;29874.402511950073;1073.7315671082229;1121.7027487715761;1126.3748619516084;1147.1912301827192;1153.9653810385703;14800.851991479947;14827.258637068104;14837.183954882585;15113.09321440717;15161.469348572748;566988;567909;570290;572835;825357;53668.73165634147;54536.72731636316;54590.72704636531;54679.72660136753;54726.45273547293;1465.8680718735152;1466.7139907717892;1472.536151112396;1481.0669278354567;1497.0867770659888;30934.69065309408;30987.84506077455;31326.530102048033;31540.684593153775;31921;52292;52880.73559632177;53199.73400132974;53431.46568534265;53484.46515534795;328445;332399;332528;332824;332897;45787;46089.76955115203;46148.30777538407;46258.53741462677;46411.53588464072;48546.75726621344;48888.2666760006;49077.01845963132;49142.262866057754;50060.49939500704;42056.78971605122;42289.365659515744;43584.564154359316;43651.34522982221;43901.56098438975;41207.381889272285;41715;41869.37195942002;42198.57801421946;42572.57427425686;41008.38487422751;41162.38256426096;41516.1696766069;44522.77738611286;45372.31941520814;33957.66042339545;34163.82918085493;34311.31377372488;35080.298394032485;35258.294834102664;25742.356441089123;26335.20994370172;26543.33641658974;26655.600165997137;26751.732482674925 04:05:25 INFO - 2016-01-20 04:05:25,633 DEBUG : BROWSER_OUTPUT: |2;jquery.html;377.6450136871339;378.49281962170704;386.1215734204684;388.7511992324913;393.19787633228214;15749.60625984351;17644;17816.64366712665;18718.625627487458;18817.717734233982;11587.188896777228;11804.350760708157;11898.702532436671;12124.575639852585;12195.146339756198;5204.219367094947;5318.6011049171275;5321.361436627591;5321.36143662761;5322;5299.788008479675;5476.561875050006;5572.749226284827;5614.719264036802;5615.971920140393;5386.138217885139;5542.889142217154;5640.971795141039;5641.830745077655;5651.2370829937845;5505.394406615269;5517.889642207133;5531.944680553183;5538.9169162462595;5541.9168712469345;5162.819301324474;5270.6837589744355;5302.973485132588;5306.52241298285;5321;13881.930590347085;21415;22010.88994555033;22159.667604985938;23072.653910191362;2250.223672832886;2266.1162146762777;2339.7660233976635;2397.832151749378;2417.6131818909066;10380.169586433067;10445.634402795942;10477.214208934283;10522.105621022223;10727.08819750322;480.9639277054235;481.49202591266203;481.816909574363;2006.7290915726337;2027.8365749430934;62020.68989655068;64365.03452448217;66521;66597.66701166512;69132.99999999949;10683.14534837211;10878.782424351626;11168.720781980515;11274.210805243718;11283.153763467773;14394.712105758035;14694.412223511154;14748.115113093249;14791.556253312418;14792.926035369754;8090.757277281691;8117.837643247102;8149.470284431493;8177.4684645497855;8185.3451723861945;7704.6532906019365;7721.459497835098;7724.6523906424345;7752.418568607377;7786.7663970080985;4776.567029891019;4799.208130658472;4849.733264670406;4881.585065269421;4930.6795058321095;1974.9111289991986;1976.3478052242726;1987.8707883987495;1992.1035534009754;1996.5008747813047;909.4452384045727;1016.1210552871861;1059.142094903131;1082.4154956323655;1117.3296022386667;16240.51278461648;17095.829041709672;17324.913375433294;17757.911210443865;18123;959.3955807841015;968.0754879090451;981.8772653418323;1000.4047591682937;1010.7877345757327;8721.60752766127;10016.599336026624;10148.898511014942;10155.695329140137;10210.948945255226;682656;682823;691541;692223;713040;86464;88938;89627.55186224027;89640.5517972419;90675;1209.5585111434264;1209.7520008398258;1220.8718084601167;1228.5270170984236;1252.3425201769144;15598.454054108051;16044.759328609847;16526.256318465938;16547.917260413622;16550.255238514055;36749.26501469902;37020.629793701715;37050.444243335834;38301.61698382981;38499.42250866183;46152.307715384966;47041;48336.758316208194;49981.25028124654;50654.74672626761;10045.598176072876;10386.636467723594;10429.06138447513;10473.266871318934;10535.63125290611;9687.903120968982;14240.43355230903;17385.47843564695;19153;19512.121954512364;15571.454999075431;15729.764053539435;16117.758233626739;16188;16503.33986640521;15937.282822272793;15975.520734377988;16353.672926541165;16367.526922577024;16646;15910.443134490237;16032.839671603135;16263.268152933382;16365.918170409072;16386.262618181972;10426.165906727292;10505.579776809147;10559.63041293551;10635.574577016832;10669.839952400875;15794.447194348142;15798.526044218692;16060.839391605934;16154.919225403797;16298.266578004255 04:05:25 INFO - 2016-01-20 04:05:25,633 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1610.0259343097425;1611.975820362694;1802.530937286112;1815.8456531194847;1845.9570342756347;7518.360939320158;7785;7898.210178982099;7913.762587122388;7917.366610671147;7923.128455869864;7950.920490795091;7965.601719913996;7973.122956474783;8015.438919275639;2313.81489480842;2341.4848733278736;2346.694929659142;2355.470019245673;2361.8464799788044;2337.55586438577;2345.9296221113395;2412.4089598048504;2415.2995631267;2415.987920060406;2255.7857003584713;2311.9653205201935;2314.467672435341;2318.6637937499054;2349.2717257650097;2289.1873384948353;2317.316391664463;2324.9883750581307;2328.895199716017;2339.894704738291;2346.577616029114;2392.377981724747;2396.3290278721984;2399.3521749127813;2403.6995375578053;7976.960115199387;8032.558209298486;8062.193780621949;8066.838663226761;8074.919250807476;4802.543758342952;4874.46380898101;4900.926486102711;4903.754812259408;4923.753812309406;3028.197527655173;3037.0888733379898;3061.7397521210723;3071.0479751277176;3076.061801150648;875.8598624220158;878.5519385113574;887.5562218890555;931.1014870649856;932.7388331267256;11015.063719583844;11025.393603351813;11086.667399978014;11088.889111108867;11102.167337449724;4154.065335299533;4224.767637779952;4241.151769646083;4253.787310634456;4253.893652658647;9033.81932361349;9090.36367454272;9094.317926155565;9102.86345704815;9123.589438475285;4927.507249275115;4929.06347793918;4933.038057578738;4961.727105009187;4966.230234313687;4563.361129441881;4589.33454649074;4595.793189306489;4604.884877878013;4609.239475486507;3595.982020089883;3620.420732682758;3622.746407751432;3642.5993140754495;3643.763155394944;1085.234909388879;1094.3433939636154;1110.74452875839;1112.0991996482874;1120.5573798349606;1004.6885465505717;1009.7778488732467;1099.9890001100046;1204.4579939027474;1408.4507042253529;7262.9273707262255;7265.273472652692;7280.563166210044;7348.706051757977;7526.774196774106;1061.4480470155477;1082.7076689293847;1113.7215696075982;1186.1222695205659;1186.2289511817387;6078.635281883101;6095.817125486243;6122.387761223931;6137.693115344215;6171.352008039091;9690.51547422626;9712.223022158352;9740.75648108803;9892.60429582823;9962;9433.339666223299;9702.369345992487;9757.609695612238;9765.316427849983;9789.657361992297;7560.054993125859;7594.278543538355;7670.501417407851;7683.654235559413;7685.269899359552;7331.3768329692575;7380.77857664271;7400.888986665312;7459.142198647008;7460.515066520658;8485.957570212357;8546.487210767375;8621.65513379483;8631.870521942301;8645.135486451305;8602.311815054905;8892.51091189965;8920.464772113693;8935.508547029976;8955.238804701412;6987.0567473392475;7096.0420343253;7100.254473280231;7103.218645949045;7103.928960710534;7894.171112033154;7912.36701063902;7921.762347129596;7940.364770818436;7948.483348582324;7038.718451261892;7071.82320441993;7071.893921591283;7406.925930740624;7484.962575187089;7276.017737605355;7400.814979625552;7425.108986921388;7489.887651685338;7490.662920168496;7429.182789893;7449.776506704808;7457.40340772726;7483.102027756704;7489.925100749141;6727.293634168342;6810.659467026728;6841.726330946905;6847.417969472651;6861.862762744817;6972.860542789014;6985.615791131537;7007.159140903124;7013.719451221894;7031.613261270679 04:05:25 INFO - 2016-01-20 04:05:25,634 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.88380160249517;378.2133163020917;378.6573151298076;379.42327661953846;381.39739212044964;6293.748250070003;6354.110424540568;6419.390157935;6453.257875344337;6475.255345635253;6232.15865858109;6336.936630633692;6375.426211640952;6379.776707815216;6389.393007664265;4942.406911170656;4944.752762361885;4964.429090654567;4969.751512424383;4978.427480839714;4970.6520543561965;4988.75056247188;5008.524190201925;5009;5012.699238045729;4772.952270477285;4863.392075990501;4915.943072239468;4916;4916.827911023115;4857.465678775332;4868.269759536062;4870.805167793284;4882.194437917739;4886.022795440926;4288.292431748758;4297.03316753731;4298.871033868989;4303.7417754934495;4305.655547556219;5997.6701281429505;6083.209182806251;6086.269647642267;6097.085437184413;6107.053406721965;5723.7996670116345;5723.828285151452;5724.513416359573;5725.427457254283;5732.31212254528;6780.389764921131;6781;6781.966090169567;6792.320767923217;6805.897911531331;4766.142094423002;4770.379850619397;4772.904541909177;4775.880602984953;4792.137415265251;6927.7228910843505;6992.230854605989;7070.9292907070785;7072.151341839012;7076.540024898365;4840.540148685869;4852.587530059985;4861.124997500484;4863.489333619919;4863.586595139382;4872.9512704873205;4891.755412229374;4909.828156014522;4913.533214344631;4923.261510773413;5518.53092487135;5645.379008309083;5675.290588676416;5677.829665109971;5682.6306290091015;6818.795436136924;6854.143232095988;6858.897116543256;6865.038894554767;6869.793906182823;1696.380821000326;1740.8607311415055;1744.9912750436167;1745.3018792483108;1747.9774332015659;1160.2458402038742;1178.9941050294694;1187.305426325592;1197.7963746163173;1199.904007679401;6522.119513865568;6525.575837570637;6541.313162118005;6542.509311801538;6548.9017664735065;6894.827879260538;6930.13373328334;6960.303969602999;6989.720411183597;7008.614526201108;6348.746050157942;6470.38531339522;6472.644004579794;6500.609963402211;6520.315366886409;3754.455603937414;3786.413105968579;3798.6961043116485;3810.3712887373827;3812.1994381179707;7095.645217739092;7095.751648692271;7140.393066589294;7170.641467926687;7177.282271772781;6995.090638217101;7084.822879427952;7109.573425594481;7143.464240182007;7149.463790215755;7079.150501939697;7119.715211391486;7131.750388736369;7132.857342853114;7135.322144396274;6950.235474097744;6952.130983627047;6953.096097507291;6958.373746362649;6969.651517424007;6784.898226526508;6820.522563420513;6885.552439091443;6960.338767817049;7020.438364930896;7317.67070481819;7323.157836848831;7324.230955749783;7324.523905946309;7342.559446433231;4873.610111191168;4898.412190537016;4908;4911.803527858846;4916.459189489082;7042.22535521082;7076.858462830817;7079.787606371817;7148.535345202546;7170.820729481805;6946.8610627788175;6954.948290254489;6968.930310696828;6970.477214209056;6998.195207551197;6932.792016239521;6941.34057264559;6946.340097690711;6956.2000369958105;6960.860782784417;6684.966575167287;6776.661166941732;6796.76211332601;6820.181578210647;6832.077669514751;6959.373656370951;6974.546654467444;6978;6987.650617469005;6990.126234220723;6674.632895190811;6783.084283621845;6789.898151527632;6791.388775010273;6796.66016699173 04:05:25 INFO - 2016-01-20 04:05:25,635 DEBUG : BROWSER_OUTPUT: |5;yui.html;793.8729803231485;801.2268161224417;806.2743530822263;834.0325222741621;885.3050355470955;14259.215743134124;14477.63805904853;14551.199684017374;14557.563273101823;14603.78094328586;12097.939510302436;13709.65725856854;13762.518311859087;13785.241811700353;13786.034977551575;714.1037997313365;899.5097671768868;899.5367385796287;918.5682729117304;936.8501039833628;929.869818225449;935.7099299217265;936.1153709744294;936.8220038192756;938.943663380196;970.2916870684404;971.480258061937;979.5200351827624;980.2256217588097;983.1348413396202;967.4195482710353;968.8256113899495;970.2335155227362;972.1882228339346;973.3089506450428;726.3970904149543;726.7492715013312;727.1201845766628;727.6580007396568;728;14692.338844752012;14892.851071489364;14893.776593351;14909.105453672815;14909.925450372679;12921.095523313372;12960.740785184244;12998.545050923267;13047.347632618332;13186.07697461178;10164.949175254076;10973.50619222137;11046.558137674483;11214.327140371604;11272.605458808903;3561.71506279497;3569.982150089233;3598.478220658016;3627.5828279747902;3631.6005239423644;48941.51058489441;48951.265731014064;48962.26556601654;49172.508274917505;49309;10607.787844243227;10720.785584288271;10834.241603087867;10896.291741036806;10942.562297508011;18692.906535467508;18706.625867482573;18712.906435467736;18719.812801871805;18737.250509979447;7132.536385135053;7214;7314.853702925911;7824.256695613907;7877.7636670899965;4401.471823381215;4464.732116073046;4500.482444518922;4511.751853648081;4562.794674239667;3141.183292344007;3155.432022235974;3197.424463596575;3205.102571280045;3212.3414699986447;582.033823852403;602.4276936909953;602.6534742522979;612.2989177391951;621.1645337021698;658;680.6120511308606;695.1866316409813;714.4962801225124;722.3210182428605;8948.418352807046;9195;9237.214836738818;9317.16145546904;9562.28282878787;585.5988647776202;622.1165944359021;632.8322994406486;722.9240929702305;737.9151397589238;3912.217556488714;3928.9017774555864;4320.611144996966;4360.2587560114225;4482.282834746425;57580;57771;57791.71104144453;58023.709881450326;58257.4174258252;53500.464995350325;53524.732376338645;53536.46463535393;53772.462275377526;54105;47393.28910066352;48171.5182848174;48188.27717584239;48625.27062094071;48740.756296219;9576.808463830544;9579.568919398504;9650.324477286522;9659.517024148905;9733.805323893625;37871.43192852165;38091.619083809914;39103.608963909996;39240.215195696495;39464.40803388009;45299.77350113228;46785.2982205274;46848;47023.52976470192;47847.282290766365;12006.819897701716;12118.515259389525;12334.32161231105;12412.193207441487;12619.684507887376;13094.541691040768;13170.341482926007;13384.799228011392;13498.52755153565;13626.182429054288;12331.630051098482;12340.691482713004;12389.194702344319;12473.251604903735;13210.933945330213;12315.549092798728;12894.226346419246;12952.870471295544;12958.092933494565;13248.80126798118;10043;12012.519499220283;12338.259704417764;12381.442835072263;12499.125061245626;10577.9471102644;10667.946660266649;10738.140948723927;11007.889921100686;11199.025568913194;9939.304248702521;9961.352512086982;10182.432331146518;10295.742606434898;10532.26274160832 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291525624__endTimestamp 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5629.09 Median:5804.22 stddev:616.75 (10.6%) stddev-sans-first:593.13 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: Values: 3391.1 3445.7 3455.0 3482.9 3483.8 5587.2 5644.2 5649.8 5685.7 5691.9 5643.2 5677.5 5682.1 5713.0 5744.3 5165.6 5226.1 5263.1 5282.9 5285.8 5093.9 5146.6 5220.6 5233.0 5257.7 5138.9 5221.6 5222.8 5234.8 5235.3 5176.9 5218.3 5236.5 5242.3 5265.6 4988.3 5045.7 5089.6 5106.5 5107.2 5429.6 5433.7 5470.8 5476.2 5491.6 6021.9 6047.3 6066.1 6079.8 6108.5 5789.3 5886.3 5905.3 5973.0 5982.2 5741.1 5761.0 5784.1 5792.2 5795.2 5992.3 6256.5 6268.6 6273.8 6289.4 5849.6 5869.3 5907.1 5912.5 5967.7 6000.9 6119.9 6133.7 6138.2 6140.2 5873.7 5927.8 6082.2 6098.1 6102.0 5942.4 5975.3 6017.4 6039.0 6063.2 4556.9 4592.5 4597.8 4603.6 4637.5 3961.3 4084.2 4099.0 4171.6 4173.7 5701.2 5743.8 5762.0 5787.3 5792.4 6109.5 6126.1 6126.2 6133.7 6142.4 5552.4 5624.5 5666.3 5733.7 5770.8 5268.9 5316.0 5336.1 5358.5 5358.5 6230.1 6235.4 6239.0 6243.1 6246.4 5949.9 6033.2 6135.0 6139.0 6143.0 6192.4 6216.6 6225.5 6249.8 6250.5 5863.8 6007.0 6036.8 6052.7 6063.5 5986.4 6081.3 6085.4 6099.8 6126.1 5828.3 5844.6 5858.9 5899.2 5900.6 5793.9 5846.6 5886.9 5889.8 5902.0 5735.4 5798.9 5804.2 5806.3 5839.9 5960.4 6025.6 6059.3 6091.0 6100.5 5594.2 5690.2 5773.0 5945.6 5945.7 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,636 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60981.12 Median:41939.48 stddev:123804.23 (295.2%) stddev-sans-first:124068.52 04:05:25 INFO - 2016-01-20 04:05:25,637 DEBUG : BROWSER_OUTPUT: Values: 598.3 640.9 640.9 644.5 651.8 38646.2 39074.0 39302.4 39312.2 39609.0 44926.6 45211.1 45485.3 45589.3 45606.0 8885.1 9069.1 9082.2 9114.2 9140.4 8954.9 9055.8 9062.0 9064.0 9102.7 8966.1 8972.0 8981.1 9055.9 9075.5 9022.8 9106.2 9108.1 9109.6 9116.3 8928.9 9038.0 9042.1 9042.1 9049.2 41169.4 41880.2 41998.8 42030.4 42053.4 3688.2 3796.2 3823.9 3839.7 4321.8 31680.0 31767.4 31801.7 32365.0 33362.7 3386.4 3406.1 3409.6 3413.2 3428.8 295792.0 299173.0 388452.0 391785.0 472826.0 60645.1 60859.0 60936.7 61026.7 61110.4 66316.3 66326.0 66393.3 66526.3 66607.3 18118.2 18251.6 18253.2 18286.9 18395.7 14009.0 14018.7 14078.5 14110.7 14139.2 22342.7 22427.6 22496.8 22589.3 22621.2 8259.9 8358.7 8405.0 8445.0 8519.9 1042.4 1047.1 1109.1 1141.8 1211.4 29227.0 29282.4 29398.4 29401.3 29874.4 1073.7 1121.7 1126.4 1147.2 1154.0 14800.9 14827.3 14837.2 15113.1 15161.5 566988.0 567909.0 570290.0 572835.0 825357.0 53668.7 54536.7 54590.7 54679.7 54726.5 1465.9 1466.7 1472.5 1481.1 1497.1 30934.7 30987.8 31326.5 31540.7 31921.0 52292.0 52880.7 53199.7 53431.5 53484.5 328445.0 332399.0 332528.0 332824.0 332897.0 45787.0 46089.8 46148.3 46258.5 46411.5 48546.8 48888.3 49077.0 49142.3 50060.5 42056.8 42289.4 43584.6 43651.3 43901.6 41207.4 41715.0 41869.4 42198.6 42572.6 41008.4 41162.4 41516.2 44522.8 45372.3 33957.7 34163.8 34311.3 35080.3 35258.3 25742.4 26335.2 26543.3 26655.6 26751.7 04:05:25 INFO - 2016-01-20 04:05:25,637 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,637 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33928.80 Median:2017.28 stddev:113111.99 (5607.1%) stddev-sans-first:113401.24 04:05:25 INFO - 2016-01-20 04:05:25,638 DEBUG : BROWSER_OUTPUT: Values: 377.6 378.5 386.1 388.8 393.2 15749.6 17644.0 17816.6 18718.6 18817.7 11587.2 11804.4 11898.7 12124.6 12195.1 5204.2 5318.6 5321.4 5321.4 5322.0 5299.8 5476.6 5572.7 5614.7 5616.0 5386.1 5542.9 5641.0 5641.8 5651.2 5505.4 5517.9 5531.9 5538.9 5541.9 5162.8 5270.7 5303.0 5306.5 5321.0 13881.9 21415.0 22010.9 22159.7 23072.7 2250.2 2266.1 2339.8 2397.8 2417.6 10380.2 10445.6 10477.2 10522.1 10727.1 481.0 481.5 481.8 2006.7 2027.8 62020.7 64365.0 66521.0 66597.7 69133.0 10683.1 10878.8 11168.7 11274.2 11283.2 14394.7 14694.4 14748.1 14791.6 14792.9 8090.8 8117.8 8149.5 8177.5 8185.3 7704.7 7721.5 7724.7 7752.4 7786.8 4776.6 4799.2 4849.7 4881.6 4930.7 1974.9 1976.3 1987.9 1992.1 1996.5 909.4 1016.1 1059.1 1082.4 1117.3 16240.5 17095.8 17324.9 17757.9 18123.0 959.4 968.1 981.9 1000.4 1010.8 8721.6 10016.6 10148.9 10155.7 10210.9 682656.0 682823.0 691541.0 692223.0 713040.0 86464.0 88938.0 89627.6 89640.6 90675.0 1209.6 1209.8 1220.9 1228.5 1252.3 15598.5 16044.8 16526.3 16547.9 16550.3 36749.3 37020.6 37050.4 38301.6 38499.4 46152.3 47041.0 48336.8 49981.3 50654.7 10045.6 10386.6 10429.1 10473.3 10535.6 9687.9 14240.4 17385.5 19153.0 19512.1 15571.5 15729.8 16117.8 16188.0 16503.3 15937.3 15975.5 16353.7 16367.5 16646.0 15910.4 16032.8 16263.3 16365.9 16386.3 10426.2 10505.6 10559.6 10635.6 10669.8 15794.4 15798.5 16060.8 16154.9 16298.3 04:05:25 INFO - 2016-01-20 04:05:25,638 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,638 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5650.18 Median:6979.24 stddev:2931.79 (42.0%) stddev-sans-first:2924.29 04:05:25 INFO - 2016-01-20 04:05:25,639 DEBUG : BROWSER_OUTPUT: Values: 1610.0 1612.0 1802.5 1815.8 1846.0 7518.4 7785.0 7898.2 7913.8 7917.4 7923.1 7950.9 7965.6 7973.1 8015.4 2313.8 2341.5 2346.7 2355.5 2361.8 2337.6 2345.9 2412.4 2415.3 2416.0 2255.8 2312.0 2314.5 2318.7 2349.3 2289.2 2317.3 2325.0 2328.9 2339.9 2346.6 2392.4 2396.3 2399.4 2403.7 7977.0 8032.6 8062.2 8066.8 8074.9 4802.5 4874.5 4900.9 4903.8 4923.8 3028.2 3037.1 3061.7 3071.0 3076.1 875.9 878.6 887.6 931.1 932.7 11015.1 11025.4 11086.7 11088.9 11102.2 4154.1 4224.8 4241.2 4253.8 4253.9 9033.8 9090.4 9094.3 9102.9 9123.6 4927.5 4929.1 4933.0 4961.7 4966.2 4563.4 4589.3 4595.8 4604.9 4609.2 3596.0 3620.4 3622.7 3642.6 3643.8 1085.2 1094.3 1110.7 1112.1 1120.6 1004.7 1009.8 1100.0 1204.5 1408.5 7262.9 7265.3 7280.6 7348.7 7526.8 1061.4 1082.7 1113.7 1186.1 1186.2 6078.6 6095.8 6122.4 6137.7 6171.4 9690.5 9712.2 9740.8 9892.6 9962.0 9433.3 9702.4 9757.6 9765.3 9789.7 7560.1 7594.3 7670.5 7683.7 7685.3 7331.4 7380.8 7400.9 7459.1 7460.5 8486.0 8546.5 8621.7 8631.9 8645.1 8602.3 8892.5 8920.5 8935.5 8955.2 6987.1 7096.0 7100.3 7103.2 7103.9 7894.2 7912.4 7921.8 7940.4 7948.5 7038.7 7071.8 7071.9 7406.9 7485.0 7276.0 7400.8 7425.1 7489.9 7490.7 7429.2 7449.8 7457.4 7483.1 7489.9 6727.3 6810.7 6841.7 6847.4 6861.9 6972.9 6985.6 7007.2 7013.7 7031.6 04:05:25 INFO - 2016-01-20 04:05:25,639 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,639 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5705.97 Median:6471.51 stddev:1706.62 (26.4%) stddev-sans-first:1663.73 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: Values: 368.9 378.2 378.7 379.4 381.4 6293.7 6354.1 6419.4 6453.3 6475.3 6232.2 6336.9 6375.4 6379.8 6389.4 4942.4 4944.8 4964.4 4969.8 4978.4 4970.7 4988.8 5008.5 5009.0 5012.7 4773.0 4863.4 4915.9 4916.0 4916.8 4857.5 4868.3 4870.8 4882.2 4886.0 4288.3 4297.0 4298.9 4303.7 4305.7 5997.7 6083.2 6086.3 6097.1 6107.1 5723.8 5723.8 5724.5 5725.4 5732.3 6780.4 6781.0 6782.0 6792.3 6805.9 4766.1 4770.4 4772.9 4775.9 4792.1 6927.7 6992.2 7070.9 7072.2 7076.5 4840.5 4852.6 4861.1 4863.5 4863.6 4873.0 4891.8 4909.8 4913.5 4923.3 5518.5 5645.4 5675.3 5677.8 5682.6 6818.8 6854.1 6858.9 6865.0 6869.8 1696.4 1740.9 1745.0 1745.3 1748.0 1160.2 1179.0 1187.3 1197.8 1199.9 6522.1 6525.6 6541.3 6542.5 6548.9 6894.8 6930.1 6960.3 6989.7 7008.6 6348.7 6470.4 6472.6 6500.6 6520.3 3754.5 3786.4 3798.7 3810.4 3812.2 7095.6 7095.8 7140.4 7170.6 7177.3 6995.1 7084.8 7109.6 7143.5 7149.5 7079.2 7119.7 7131.8 7132.9 7135.3 6950.2 6952.1 6953.1 6958.4 6969.7 6784.9 6820.5 6885.6 6960.3 7020.4 7317.7 7323.2 7324.2 7324.5 7342.6 4873.6 4898.4 4908.0 4911.8 4916.5 7042.2 7076.9 7079.8 7148.5 7170.8 6946.9 6954.9 6968.9 6970.5 6998.2 6932.8 6941.3 6946.3 6956.2 6960.9 6685.0 6776.7 6796.8 6820.2 6832.1 6959.4 6974.5 6978.0 6987.7 6990.1 6674.6 6783.1 6789.9 6791.4 6796.7 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14546.66 Median:4506.12 stddev:16480.26 (365.7%) stddev-sans-first:16494.13 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: Values: 793.9 801.2 806.3 834.0 885.3 14259.2 14477.6 14551.2 14557.6 14603.8 12097.9 13709.7 13762.5 13785.2 13786.0 714.1 899.5 899.5 918.6 936.9 929.9 935.7 936.1 936.8 938.9 970.3 971.5 979.5 980.2 983.1 967.4 968.8 970.2 972.2 973.3 726.4 726.7 727.1 727.7 728.0 14692.3 14892.9 14893.8 14909.1 14909.9 12921.1 12960.7 12998.5 13047.3 13186.1 10164.9 10973.5 11046.6 11214.3 11272.6 3561.7 3570.0 3598.5 3627.6 3631.6 48941.5 48951.3 48962.3 49172.5 49309.0 10607.8 10720.8 10834.2 10896.3 10942.6 18692.9 18706.6 18712.9 18719.8 18737.3 7132.5 7214.0 7314.9 7824.3 7877.8 4401.5 4464.7 4500.5 4511.8 4562.8 3141.2 3155.4 3197.4 3205.1 3212.3 582.0 602.4 602.7 612.3 621.2 658.0 680.6 695.2 714.5 722.3 8948.4 9195.0 9237.2 9317.2 9562.3 585.6 622.1 632.8 722.9 737.9 3912.2 3928.9 4320.6 4360.3 4482.3 57580.0 57771.0 57791.7 58023.7 58257.4 53500.5 53524.7 53536.5 53772.5 54105.0 47393.3 48171.5 48188.3 48625.3 48740.8 9576.8 9579.6 9650.3 9659.5 9733.8 37871.4 38091.6 39103.6 39240.2 39464.4 45299.8 46785.3 46848.0 47023.5 47847.3 12006.8 12118.5 12334.3 12412.2 12619.7 13094.5 13170.3 13384.8 13498.5 13626.2 12331.6 12340.7 12389.2 12473.3 13210.9 12315.5 12894.2 12952.9 12958.1 13248.8 10043.0 12012.5 12338.3 12381.4 12499.1 10577.9 10667.9 10738.1 11007.9 11199.0 9939.3 9961.4 10182.4 10295.7 10532.3 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:25 INFO - 2016-01-20 04:05:25,640 DEBUG : BROWSER_OUTPUT: 04:05:26 INFO - 2016-01-20 04:05:26,381 INFO : Browser exited with error code: 0 04:05:26 INFO - 2016-01-20 04:05:26,400 INFO : Completed test dromaeo_css (00:18:28) 04:05:26 INFO - 2016-01-20 04:05:26,400 INFO : Starting test kraken 04:05:26 INFO - 2016-01-20 04:05:26,400 DEBUG : operating with platform_type : linux_ 04:05:26 INFO - 2016-01-20 04:05:26,400 INFO : Initialising browser for kraken test... 04:05:26 INFO - 2016-01-20 04:05:26,406 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGztH8k/profile http://localhost:56361/getInfo.html 04:05:30 INFO - 2016-01-20 04:05:30,140 DEBUG : BROWSER_OUTPUT: 04:05:30 INFO - 2016-01-20 04:05:30,140 DEBUG : BROWSER_OUTPUT: (process:29464): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:30 INFO - 2016-01-20 04:05:30,963 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:30 INFO - 2016-01-20 04:05:30,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:30 INFO - 2016-01-20 04:05:30,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:30 INFO - 2016-01-20 04:05:30,963 DEBUG : BROWSER_OUTPUT: __metrics 04:05:31 INFO - 2016-01-20 04:05:31,997 INFO : Browser initialized. 04:05:31 INFO - 2016-01-20 04:05:31,997 INFO : Running cycle 1/1 for kraken test... 04:05:31 INFO - 2016-01-20 04:05:31,998 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGztH8k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:05:33 INFO - 2016-01-20 04:05:33,314 DEBUG : BROWSER_OUTPUT: 04:05:33 INFO - 2016-01-20 04:05:33,315 DEBUG : BROWSER_OUTPUT: (process:29579): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:43 INFO - 2016-01-20 04:05:43,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 136523776 04:05:43 INFO - 2016-01-20 04:05:43,817 DEBUG : BROWSER_OUTPUT: 04:05:46 INFO - 2016-01-20 04:05:46,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56361/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:46 INFO - 2016-01-20 04:05:46,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 138047488 04:05:46 INFO - 2016-01-20 04:05:46,879 DEBUG : BROWSER_OUTPUT: 04:05:49 INFO - 2016-01-20 04:05:49,484 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56361/tests/kraken/driver.html?testName=audio-dft) 04:05:50 INFO - 2016-01-20 04:05:50,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 138186752 04:05:50 INFO - 2016-01-20 04:05:50,087 DEBUG : BROWSER_OUTPUT: 04:05:52 INFO - 2016-01-20 04:05:52,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56361/tests/kraken/driver.html?testName=audio-fft) 04:05:53 INFO - 2016-01-20 04:05:53,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 04:05:53 INFO - 2016-01-20 04:05:53,493 DEBUG : BROWSER_OUTPUT: 04:05:55 INFO - 2016-01-20 04:05:55,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56361/tests/kraken/driver.html?testName=audio-oscillator) 04:05:56 INFO - 2016-01-20 04:05:56,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 139087872 04:05:56 INFO - 2016-01-20 04:05:56,105 DEBUG : BROWSER_OUTPUT: 04:05:58 INFO - 2016-01-20 04:05:58,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:58 INFO - 2016-01-20 04:05:58,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 138362880 04:05:58 INFO - 2016-01-20 04:05:58,848 DEBUG : BROWSER_OUTPUT: 04:06:01 INFO - 2016-01-20 04:06:01,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56361/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:02 INFO - 2016-01-20 04:06:02,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 04:06:02 INFO - 2016-01-20 04:06:02,369 DEBUG : BROWSER_OUTPUT: 04:06:05 INFO - 2016-01-20 04:06:05,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56361/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:06 INFO - 2016-01-20 04:06:06,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 04:06:06 INFO - 2016-01-20 04:06:06,335 DEBUG : BROWSER_OUTPUT: 04:06:09 INFO - 2016-01-20 04:06:09,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56361/tests/kraken/driver.html?testName=json-parse-financial) 04:06:09 INFO - 2016-01-20 04:06:09,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 139370496 04:06:09 INFO - 2016-01-20 04:06:09,693 DEBUG : BROWSER_OUTPUT: 04:06:11 INFO - 2016-01-20 04:06:11,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:11 INFO - 2016-01-20 04:06:11,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 139464704 04:06:11 INFO - 2016-01-20 04:06:11,845 DEBUG : BROWSER_OUTPUT: 04:06:13 INFO - 2016-01-20 04:06:13,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:14 INFO - 2016-01-20 04:06:14,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 139055104 04:06:14 INFO - 2016-01-20 04:06:14,196 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2016-01-20 04:06:16,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:16 INFO - 2016-01-20 04:06:16,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 04:06:16 INFO - 2016-01-20 04:06:16,776 DEBUG : BROWSER_OUTPUT: 04:06:19 INFO - 2016-01-20 04:06:19,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:19 INFO - 2016-01-20 04:06:19,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 139354112 04:06:19 INFO - 2016-01-20 04:06:19,766 DEBUG : BROWSER_OUTPUT: 04:06:22 INFO - 2016-01-20 04:06:22,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:22 INFO - 2016-01-20 04:06:22,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 139468800 04:06:22 INFO - 2016-01-20 04:06:22,876 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56361/tests/kraken/driver.html?testName=ai-astar) 04:06:24 INFO - 2016-01-20 04:06:24,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 04:06:24 INFO - 2016-01-20 04:06:24,781 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,784 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:24 INFO - 2016-01-20 04:06:24,784 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;105;110;108;109;120;111;110;108;109 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;125;147;165;124;151;155;129;163;126 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;160;162;161;162;162;163;164 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;75;155;76;70;71;73;157;73 04:06:24 INFO - 2016-01-20 04:06:24,785 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;136;92;92;94;134;92;93;129 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;112;110;109;110;109;109;110;109;110;109 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;146;146;147;147;146;146;146;146;145 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;95;96;96;96;96;96 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;63;59;59;60;59;58;60;60 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;66;63;62;62;63;63 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;81;81;81;81;82;82;82;81 04:06:24 INFO - 2016-01-20 04:06:24,786 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;111;123;124;112;115;123;117;114;115 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;143;135;145;148;146;145;136;154;141 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;65;69;66;70;65;63;66 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,692 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291584782__endTimestamp 04:06:24 INFO - 2016-01-20 04:06:24,787 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,791 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:24 INFO - 2016-01-20 04:06:24,791 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:24 INFO - 2016-01-20 04:06:24,791 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,791 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:110.00 stddev:4.20 (3.8%) stddev-sans-first:4.12 04:06:24 INFO - 2016-01-20 04:06:24,791 DEBUG : BROWSER_OUTPUT: Values: 115.0 105.0 110.0 108.0 109.0 120.0 111.0 110.0 108.0 109.0 04:06:24 INFO - 2016-01-20 04:06:24,792 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,792 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.00 stddev:16.37 (10.7%) stddev-sans-first:16.87 04:06:24 INFO - 2016-01-20 04:06:24,792 DEBUG : BROWSER_OUTPUT: Values: 155.0 125.0 147.0 165.0 124.0 151.0 155.0 129.0 163.0 126.0 04:06:24 INFO - 2016-01-20 04:06:24,792 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,792 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 160.0 162.0 161.0 162.0 162.0 163.0 164.0 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.00 Median:73.00 stddev:34.87 (47.8%) stddev-sans-first:36.71 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 75.0 155.0 76.0 70.0 71.0 73.0 157.0 73.0 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.50 stddev:19.48 (21.1%) stddev-sans-first:20.18 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 136.0 92.0 92.0 94.0 134.0 92.0 93.0 129.0 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:0.53 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: Values: 112.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 109.0 04:06:24 INFO - 2016-01-20 04:06:24,793 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:0.60 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: Values: 149.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 145.0 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:1.32 (2.2%) stddev-sans-first:1.39 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 63.0 59.0 59.0 60.0 59.0 58.0 60.0 60.0 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 66.0 63.0 62.0 62.0 63.0 63.0 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:06:24 INFO - 2016-01-20 04:06:24,794 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 81.0 81.0 81.0 81.0 82.0 82.0 82.0 81.0 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:116.00 stddev:4.80 (4.1%) stddev-sans-first:4.99 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: Values: 114.0 111.0 123.0 124.0 112.0 115.0 123.0 117.0 114.0 115.0 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:145.00 stddev:5.54 (3.8%) stddev-sans-first:5.87 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 135.0 145.0 148.0 146.0 145.0 136.0 154.0 141.0 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.01 (3.0%) stddev-sans-first:2.13 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 65.0 69.0 66.0 70.0 65.0 63.0 66.0 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:24 INFO - 2016-01-20 04:06:24,795 DEBUG : BROWSER_OUTPUT: 04:06:25 INFO - 2016-01-20 04:06:25,633 INFO : Browser exited with error code: 0 04:06:25 INFO - 2016-01-20 04:06:25,683 INFO : Completed test kraken (00:00:59) 04:06:25 INFO - 2016-01-20 04:06:25,683 INFO : Starting test v8_7 04:06:25 INFO - 2016-01-20 04:06:25,683 DEBUG : operating with platform_type : linux_ 04:06:25 INFO - 2016-01-20 04:06:25,683 INFO : Initialising browser for v8_7 test... 04:06:25 INFO - 2016-01-20 04:06:25,690 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXn4r_3/profile http://localhost:56361/getInfo.html 04:06:29 INFO - 2016-01-20 04:06:29,331 DEBUG : BROWSER_OUTPUT: 04:06:29 INFO - 2016-01-20 04:06:29,331 DEBUG : BROWSER_OUTPUT: (process:29888): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:30 INFO - 2016-01-20 04:06:30,125 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:30 INFO - 2016-01-20 04:06:30,125 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:30 INFO - 2016-01-20 04:06:30,125 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:30 INFO - 2016-01-20 04:06:30,125 DEBUG : BROWSER_OUTPUT: __metrics 04:06:31 INFO - 2016-01-20 04:06:31,209 INFO : Browser initialized. 04:06:31 INFO - 2016-01-20 04:06:31,209 INFO : Running cycle 1/1 for v8_7 test... 04:06:31 INFO - 2016-01-20 04:06:31,210 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXn4r_3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:32 INFO - 2016-01-20 04:06:32,508 DEBUG : BROWSER_OUTPUT: 04:06:32 INFO - 2016-01-20 04:06:32,509 DEBUG : BROWSER_OUTPUT: (process:30003): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:43 INFO - 2016-01-20 04:06:43,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 136310784 04:06:43 INFO - 2016-01-20 04:06:43,011 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56361/tests/v8_7/run.html (next: http://localhost:56361/tests/v8_7/run.html) 04:07:04 INFO - 2016-01-20 04:07:04,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 136249344 04:07:04 INFO - 2016-01-20 04:07:04,616 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: |0;Richards;164.2845408247084 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.65193370165747 04:07:04 INFO - 2016-01-20 04:07:04,617 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5263.1578947368425 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |4;RayTrace;945.179584120983 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |5;Earley;553.0973451327434 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |6;Boyer;11076.923076923076 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |8;Splay;521.9206680584551 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:07:04 INFO - 2016-01-20 04:07:04,618 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: __startTimestamp1453291624613__endTimestamp 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.28 Median:164.28 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,619 DEBUG : BROWSER_OUTPUT: Values: 164.3 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.65 Median:172.65 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: Values: 172.7 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,620 DEBUG : BROWSER_OUTPUT: Values: 281.1 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: Values: 5263.2 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:945.18 Median:945.18 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: Values: 945.2 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:553.10 Median:553.10 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: Values: 553.1 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: Values: 11076.9 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,621 DEBUG : BROWSER_OUTPUT: Values: 24238.1 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:521.92 Median:521.92 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: Values: 521.9 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:04 INFO - 2016-01-20 04:07:04,622 DEBUG : BROWSER_OUTPUT: 04:07:05 INFO - 2016-01-20 04:07:05,497 INFO : Browser exited with error code: 0 04:07:05 INFO - 2016-01-20 04:07:05,512 INFO : Completed test v8_7 (00:00:39) 04:07:05 INFO - 2016-01-20 04:07:05,662 INFO : Completed test suite (00:20:08) 04:07:05 INFO - 2016-01-20 04:07:05,662 DEBUG : Working with test: dromaeo_css 04:07:05 INFO - 2016-01-20 04:07:05,662 DEBUG : Generating results file: dromaeo_css 04:07:05 INFO - 2016-01-20 04:07:05,663 DEBUG : Working with test: kraken 04:07:05 INFO - 2016-01-20 04:07:05,664 DEBUG : Generating results file: kraken 04:07:05 INFO - 2016-01-20 04:07:05,664 INFO : javascript benchmark 04:07:05 INFO - 2016-01-20 04:07:05,664 DEBUG : Working with test: v8_7 04:07:05 INFO - 2016-01-20 04:07:05,664 DEBUG : Generating results file: v8_7 04:07:05 INFO - 2016-01-20 04:07:05,665 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:05 INFO - 2016-01-20 04:07:05,770 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:07:05 INFO - 2016-01-20 04:07:05,770 DEBUG : process_Request line: dromaeo_css 7456.05 graph.html#tests=[[72,52,43]] 04:07:05 INFO - 2016-01-20 04:07:05,770 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:05 INFO - 2016-01-20 04:07:05,802 DEBUG : process_Request line: kraken 1495.00 graph.html#tests=[[232,52,43]] 04:07:05 INFO - 2016-01-20 04:07:05,802 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:05 INFO - 2016-01-20 04:07:05,834 DEBUG : process_Request line: v8_7 23027.46 graph.html#tests=[[230,52,43]] 04:07:05 INFO - 2016-01-20 04:07:05,835 INFO : javascript benchmark 04:07:05 INFO - 2016-01-20 04:07:05,839 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3391.084407210053, 3445.7071148952323, 3455.0, 3482.860685572578, 3483.7909725416475, 5587.161925711145, 5644.181593668925, 5649.8305050848485, 5685.715714214293, 5691.857703557408, 5643.238162848014, 5677.48902598766, 5682.062459694145, 5713.0, 5744.33940096889, 5165.612579056567, 5226.05930932432, 5263.131583288753, 5282.947170528284, 5285.7885684572575, 5093.898122037575, 5146.5625421839, 5220.556252718524, 5233.031889100528, 5257.7108259045735, 5138.871528211787, 5221.6083793715625, 5222.791088356461, 5234.7644356004075, 5235.319408476893, 5176.896462070775, 5218.295530103444, 5236.502532259429, 5242.266082748418, 5265.631405801595, 4988.276699878534, 5045.747712614355, 5089.618278629081, 5106.540411362958, 5107.20838270065, 5429.56563474921, 5433.728313584305, 5470.8085217017615, 5476.151196564539, 5491.588130890199, 6021.909671354933, 6047.274327080734, 6066.059760737093, 6079.817605471843, 6108.450239478469, 5789.334226563957, 5886.293644762613, 5905.320888097838, 5972.970135149297, 5982.162497250389, 5741.081426971665, 5760.9711951440395, 5784.13238014297, 5792.160136780143, 5795.159701843251, 5992.34084250732, 6256.468200202943, 6268.592541484789, 6273.843153921097, 6289.402506761941, 5849.561282903799, 5869.295684517885, 5907.1434641976675, 5912.526997840248, 5967.701614919237, 6000.8799824004145, 6119.938800612026, 6133.693315334304, 6138.202033735586, 6140.232470941132, 5873.706314684248, 5927.792527261525, 6082.239720034996, 6098.14625952367, 6102.0, 5942.435468630473, 5975.282966044016, 6017.368176341509, 6038.969805150946, 6063.151158837766, 4556.908861822812, 4592.471865735483, 4597.816087356468, 4603.631709463235, 4637.513061128533, 3961.3067713150085, 4084.244414783275, 4099.0, 4171.6036976487185, 4173.707840451139, 5701.2018317435595, 5743.770249189985, 5761.971190144022, 5787.276590426197, 5792.420757924174, 6109.541784366191, 6126.08108783686, 6126.23422072241, 6133.723982420802, 6142.385761423822, 5552.444755524415, 5624.465675760796, 5666.320041595035, 5733.684647344353, 5770.769169233267, 5268.92096618551, 5316.043112239757, 5336.119540275811, 5358.517733404013, 5358.544523715528, 6230.127782110508, 6235.376462353819, 6239.032949892774, 6243.0635404688755, 6246.375362463808, 5949.940500594938, 6033.18551995475, 6135.018317212141, 6139.0, 6143.020634991936, 6192.3807619239515, 6216.595921265103, 6225.470834979077, 6249.812505624838, 6250.499960003098, 5863.765449381977, 6007.008843540942, 6036.758529658764, 6052.656515732597, 6063.484603808725, 5986.431289027535, 6081.27024757032, 6085.391460853879, 6099.847503812262, 6126.1423400724825, 5828.271466066742, 5844.590878638454, 5858.9121163181735, 5899.203607512931, 5900.586958912835, 5793.855153621024, 5846.590738648254, 5886.941130588811, 5889.823305300848, 5902.026165682614, 5735.426457354231, 5798.942010580009, 5804.21643078179, 5806.303243610625, 5839.883202336015, 5960.374160713062, 6025.638461692312, 6059.33347331802, 6091.025435930407, 6100.511959043355, 5594.188842617717, 5690.203371528072, 5772.9711351442975, 5945.554083443672, 5945.732442040205], "unit": "ms", "name": "dojo.html", "value": 5589.671844692027}, {"lowerIsBetter": false, "replicates": [598.2820615261685, 640.9166808314919, 640.9487241020715, 644.4876323322958, 651.7783953455826, 38646.22707545851, 39074.0, 39302.41046384303, 39312.21375572487, 39609.0, 44926.550734492645, 45211.09577808442, 45485.31772023422, 45589.31616025754, 45606.0, 8885.111488851127, 9069.138431848964, 9082.228010619072, 9114.179723824855, 9140.360174787767, 8954.910450895506, 9055.773605659879, 9061.954690226572, 9063.95468022659, 9102.681406150787, 8966.103389661046, 8971.95514022429, 8981.101889811, 9055.864162037575, 9075.54622268884, 9022.774430639254, 9106.225970792491, 9108.134727200939, 9109.635614575442, 9116.270698344117, 8928.910710892873, 9037.954810225907, 9042.095790420972, 9042.140996605312, 9049.2308153807, 41169.382459263135, 41880.1623967519, 41998.79000605008, 42030.36954445686, 42053.36919946203, 3688.1517251032415, 3796.2407518496134, 3823.8852834414733, 3839.654431101186, 4321.805518751632, 31680.0, 31767.36465270705, 31801.681983180104, 32365.0, 33362.6663733362, 3386.3904497190497, 3406.131436483681, 3409.62494125646, 3413.1637748751714, 3428.7771294866, 295792.0, 299173.0, 388452.0, 391785.0, 472826.0, 60645.09032364518, 60859.0, 60936.69531652313, 61026.69486652538, 61110.38889611136, 66316.33683663198, 66326.0, 66393.33606663968, 66526.33473665202, 66607.33392666011, 18118.184681689356, 18251.63496730058, 18253.17860696272, 18286.908565457088, 18395.72406413905, 14009.0, 14018.719625607431, 14078.507252246121, 14110.71778564423, 14139.222342771041, 22342.66486002711, 22427.551448970928, 22496.77503224947, 22589.322320330415, 22621.20825771123, 8259.917400825914, 8358.665653373797, 8405.0, 8445.0, 8519.872201916853, 1042.4006196437078, 1047.0994944347856, 1109.1182509904645, 1141.84585081013, 1211.357980270458, 29227.0, 29282.414351712847, 29398.412031759246, 29401.264968375533, 29874.402511950073, 1073.7315671082229, 1121.7027487715761, 1126.3748619516084, 1147.1912301827192, 1153.9653810385703, 14800.851991479947, 14827.258637068104, 14837.183954882585, 15113.09321440717, 15161.469348572748, 566988.0, 567909.0, 570290.0, 572835.0, 825357.0, 53668.73165634147, 54536.72731636316, 54590.72704636531, 54679.72660136753, 54726.45273547293, 1465.8680718735152, 1466.7139907717892, 1472.536151112396, 1481.0669278354567, 1497.0867770659888, 30934.69065309408, 30987.84506077455, 31326.530102048033, 31540.684593153775, 31921.0, 52292.0, 52880.73559632177, 53199.73400132974, 53431.46568534265, 53484.46515534795, 328445.0, 332399.0, 332528.0, 332824.0, 332897.0, 45787.0, 46089.76955115203, 46148.30777538407, 46258.53741462677, 46411.53588464072, 48546.75726621344, 48888.2666760006, 49077.01845963132, 49142.262866057754, 50060.49939500704, 42056.78971605122, 42289.365659515744, 43584.564154359316, 43651.34522982221, 43901.56098438975, 41207.381889272285, 41715.0, 41869.37195942002, 42198.57801421946, 42572.57427425686, 41008.38487422751, 41162.38256426096, 41516.1696766069, 44522.77738611286, 45372.31941520814, 33957.66042339545, 34163.82918085493, 34311.31377372488, 35080.298394032485, 35258.294834102664, 25742.356441089123, 26335.20994370172, 26543.33641658974, 26655.600165997137, 26751.732482674925], "unit": "ms", "name": "ext.html", "value": 20644.509122610853}, {"lowerIsBetter": false, "replicates": [377.6450136871339, 378.49281962170704, 386.1215734204684, 388.7511992324913, 393.19787633228214, 15749.60625984351, 17644.0, 17816.64366712665, 18718.625627487458, 18817.717734233982, 11587.188896777228, 11804.350760708157, 11898.702532436671, 12124.575639852585, 12195.146339756198, 5204.219367094947, 5318.6011049171275, 5321.361436627591, 5321.36143662761, 5322.0, 5299.788008479675, 5476.561875050006, 5572.749226284827, 5614.719264036802, 5615.971920140393, 5386.138217885139, 5542.889142217154, 5640.971795141039, 5641.830745077655, 5651.2370829937845, 5505.394406615269, 5517.889642207133, 5531.944680553183, 5538.9169162462595, 5541.9168712469345, 5162.819301324474, 5270.6837589744355, 5302.973485132588, 5306.52241298285, 5321.0, 13881.930590347085, 21415.0, 22010.88994555033, 22159.667604985938, 23072.653910191362, 2250.223672832886, 2266.1162146762777, 2339.7660233976635, 2397.832151749378, 2417.6131818909066, 10380.169586433067, 10445.634402795942, 10477.214208934283, 10522.105621022223, 10727.08819750322, 480.9639277054235, 481.49202591266203, 481.816909574363, 2006.7290915726337, 2027.8365749430934, 62020.68989655068, 64365.03452448217, 66521.0, 66597.66701166512, 69132.99999999949, 10683.14534837211, 10878.782424351626, 11168.720781980515, 11274.210805243718, 11283.153763467773, 14394.712105758035, 14694.412223511154, 14748.115113093249, 14791.556253312418, 14792.926035369754, 8090.757277281691, 8117.837643247102, 8149.470284431493, 8177.4684645497855, 8185.3451723861945, 7704.6532906019365, 7721.459497835098, 7724.6523906424345, 7752.418568607377, 7786.7663970080985, 4776.567029891019, 4799.208130658472, 4849.733264670406, 4881.585065269421, 4930.6795058321095, 1974.9111289991986, 1976.3478052242726, 1987.8707883987495, 1992.1035534009754, 1996.5008747813047, 909.4452384045727, 1016.1210552871861, 1059.142094903131, 1082.4154956323655, 1117.3296022386667, 16240.51278461648, 17095.829041709672, 17324.913375433294, 17757.911210443865, 18123.0, 959.3955807841015, 968.0754879090451, 981.8772653418323, 1000.4047591682937, 1010.7877345757327, 8721.60752766127, 10016.599336026624, 10148.898511014942, 10155.695329140137, 10210.948945255226, 682656.0, 682823.0, 691541.0, 692223.0, 713040.0, 86464.0, 88938.0, 89627.55186224027, 89640.5517972419, 90675.0, 1209.5585111434264, 1209.7520008398258, 1220.8718084601167, 1228.5270170984236, 1252.3425201769144, 15598.454054108051, 16044.759328609847, 16526.256318465938, 16547.917260413622, 16550.255238514055, 36749.26501469902, 37020.629793701715, 37050.444243335834, 38301.61698382981, 38499.42250866183, 46152.307715384966, 47041.0, 48336.758316208194, 49981.25028124654, 50654.74672626761, 10045.598176072876, 10386.636467723594, 10429.06138447513, 10473.266871318934, 10535.63125290611, 9687.903120968982, 14240.43355230903, 17385.47843564695, 19153.0, 19512.121954512364, 15571.454999075431, 15729.764053539435, 16117.758233626739, 16188.0, 16503.33986640521, 15937.282822272793, 15975.520734377988, 16353.672926541165, 16367.526922577024, 16646.0, 15910.443134490237, 16032.839671603135, 16263.268152933382, 16365.918170409072, 16386.262618181972, 10426.165906727292, 10505.579776809147, 10559.63041293551, 10635.574577016832, 10669.839952400875, 15794.447194348142, 15798.526044218692, 16060.839391605934, 16154.919225403797, 16298.266578004255], "unit": "ms", "name": "jquery.html", "value": 9263.832426053492}, {"lowerIsBetter": false, "replicates": [1610.0259343097425, 1611.975820362694, 1802.530937286112, 1815.8456531194847, 1845.9570342756347, 7518.360939320158, 7785.0, 7898.210178982099, 7913.762587122388, 7917.366610671147, 7923.128455869864, 7950.920490795091, 7965.601719913996, 7973.122956474783, 8015.438919275639, 2313.81489480842, 2341.4848733278736, 2346.694929659142, 2355.470019245673, 2361.8464799788044, 2337.55586438577, 2345.9296221113395, 2412.4089598048504, 2415.2995631267, 2415.987920060406, 2255.7857003584713, 2311.9653205201935, 2314.467672435341, 2318.6637937499054, 2349.2717257650097, 2289.1873384948353, 2317.316391664463, 2324.9883750581307, 2328.895199716017, 2339.894704738291, 2346.577616029114, 2392.377981724747, 2396.3290278721984, 2399.3521749127813, 2403.6995375578053, 7976.960115199387, 8032.558209298486, 8062.193780621949, 8066.838663226761, 8074.919250807476, 4802.543758342952, 4874.46380898101, 4900.926486102711, 4903.754812259408, 4923.753812309406, 3028.197527655173, 3037.0888733379898, 3061.7397521210723, 3071.0479751277176, 3076.061801150648, 875.8598624220158, 878.5519385113574, 887.5562218890555, 931.1014870649856, 932.7388331267256, 11015.063719583844, 11025.393603351813, 11086.667399978014, 11088.889111108867, 11102.167337449724, 4154.065335299533, 4224.767637779952, 4241.151769646083, 4253.787310634456, 4253.893652658647, 9033.81932361349, 9090.36367454272, 9094.317926155565, 9102.86345704815, 9123.589438475285, 4927.507249275115, 4929.06347793918, 4933.038057578738, 4961.727105009187, 4966.230234313687, 4563.361129441881, 4589.33454649074, 4595.793189306489, 4604.884877878013, 4609.239475486507, 3595.982020089883, 3620.420732682758, 3622.746407751432, 3642.5993140754495, 3643.763155394944, 1085.234909388879, 1094.3433939636154, 1110.74452875839, 1112.0991996482874, 1120.5573798349606, 1004.6885465505717, 1009.7778488732467, 1099.9890001100046, 1204.4579939027474, 1408.4507042253529, 7262.9273707262255, 7265.273472652692, 7280.563166210044, 7348.706051757977, 7526.774196774106, 1061.4480470155477, 1082.7076689293847, 1113.7215696075982, 1186.1222695205659, 1186.2289511817387, 6078.635281883101, 6095.817125486243, 6122.387761223931, 6137.693115344215, 6171.352008039091, 9690.51547422626, 9712.223022158352, 9740.75648108803, 9892.60429582823, 9962.0, 9433.339666223299, 9702.369345992487, 9757.609695612238, 9765.316427849983, 9789.657361992297, 7560.054993125859, 7594.278543538355, 7670.501417407851, 7683.654235559413, 7685.269899359552, 7331.3768329692575, 7380.77857664271, 7400.888986665312, 7459.142198647008, 7460.515066520658, 8485.957570212357, 8546.487210767375, 8621.65513379483, 8631.870521942301, 8645.135486451305, 8602.311815054905, 8892.51091189965, 8920.464772113693, 8935.508547029976, 8955.238804701412, 6987.0567473392475, 7096.0420343253, 7100.254473280231, 7103.218645949045, 7103.928960710534, 7894.171112033154, 7912.36701063902, 7921.762347129596, 7940.364770818436, 7948.483348582324, 7038.718451261892, 7071.82320441993, 7071.893921591283, 7406.925930740624, 7484.962575187089, 7276.017737605355, 7400.814979625552, 7425.108986921388, 7489.887651685338, 7490.662920168496, 7429.182789893, 7449.776506704808, 7457.40340772726, 7483.102027756704, 7489.925100749141, 6727.293634168342, 6810.659467026728, 6841.726330946905, 6847.417969472651, 6861.862762744817, 6972.860542789014, 6985.615791131537, 7007.159140903124, 7013.719451221894, 7031.613261270679], "unit": "ms", "name": "mootools.html", "value": 4615.9014804074695}, {"lowerIsBetter": false, "replicates": [368.88380160249517, 378.2133163020917, 378.6573151298076, 379.42327661953846, 381.39739212044964, 6293.748250070003, 6354.110424540568, 6419.390157935, 6453.257875344337, 6475.255345635253, 6232.15865858109, 6336.936630633692, 6375.426211640952, 6379.776707815216, 6389.393007664265, 4942.406911170656, 4944.752762361885, 4964.429090654567, 4969.751512424383, 4978.427480839714, 4970.6520543561965, 4988.75056247188, 5008.524190201925, 5009.0, 5012.699238045729, 4772.952270477285, 4863.392075990501, 4915.943072239468, 4916.0, 4916.827911023115, 4857.465678775332, 4868.269759536062, 4870.805167793284, 4882.194437917739, 4886.022795440926, 4288.292431748758, 4297.03316753731, 4298.871033868989, 4303.7417754934495, 4305.655547556219, 5997.6701281429505, 6083.209182806251, 6086.269647642267, 6097.085437184413, 6107.053406721965, 5723.7996670116345, 5723.828285151452, 5724.513416359573, 5725.427457254283, 5732.31212254528, 6780.389764921131, 6781.0, 6781.966090169567, 6792.320767923217, 6805.897911531331, 4766.142094423002, 4770.379850619397, 4772.904541909177, 4775.880602984953, 4792.137415265251, 6927.7228910843505, 6992.230854605989, 7070.9292907070785, 7072.151341839012, 7076.540024898365, 4840.540148685869, 4852.587530059985, 4861.124997500484, 4863.489333619919, 4863.586595139382, 4872.9512704873205, 4891.755412229374, 4909.828156014522, 4913.533214344631, 4923.261510773413, 5518.53092487135, 5645.379008309083, 5675.290588676416, 5677.829665109971, 5682.6306290091015, 6818.795436136924, 6854.143232095988, 6858.897116543256, 6865.038894554767, 6869.793906182823, 1696.380821000326, 1740.8607311415055, 1744.9912750436167, 1745.3018792483108, 1747.9774332015659, 1160.2458402038742, 1178.9941050294694, 1187.305426325592, 1197.7963746163173, 1199.904007679401, 6522.119513865568, 6525.575837570637, 6541.313162118005, 6542.509311801538, 6548.9017664735065, 6894.827879260538, 6930.13373328334, 6960.303969602999, 6989.720411183597, 7008.614526201108, 6348.746050157942, 6470.38531339522, 6472.644004579794, 6500.609963402211, 6520.315366886409, 3754.455603937414, 3786.413105968579, 3798.6961043116485, 3810.3712887373827, 3812.1994381179707, 7095.645217739092, 7095.751648692271, 7140.393066589294, 7170.641467926687, 7177.282271772781, 6995.090638217101, 7084.822879427952, 7109.573425594481, 7143.464240182007, 7149.463790215755, 7079.150501939697, 7119.715211391486, 7131.750388736369, 7132.857342853114, 7135.322144396274, 6950.235474097744, 6952.130983627047, 6953.096097507291, 6958.373746362649, 6969.651517424007, 6784.898226526508, 6820.522563420513, 6885.552439091443, 6960.338767817049, 7020.438364930896, 7317.67070481819, 7323.157836848831, 7324.230955749783, 7324.523905946309, 7342.559446433231, 4873.610111191168, 4898.412190537016, 4908.0, 4911.803527858846, 4916.459189489082, 7042.22535521082, 7076.858462830817, 7079.787606371817, 7148.535345202546, 7170.820729481805, 6946.8610627788175, 6954.948290254489, 6968.930310696828, 6970.477214209056, 6998.195207551197, 6932.792016239521, 6941.34057264559, 6946.340097690711, 6956.2000369958105, 6960.860782784417, 6684.966575167287, 6776.661166941732, 6796.76211332601, 6820.181578210647, 6832.077669514751, 6959.373656370951, 6974.546654467444, 6978.0, 6987.650617469005, 6990.126234220723, 6674.632895190811, 6783.084283621845, 6789.898151527632, 6791.388775010273, 6796.66016699173], "unit": "ms", "name": "prototype.html", "value": 5157.450583572251}, {"lowerIsBetter": false, "replicates": [793.8729803231485, 801.2268161224417, 806.2743530822263, 834.0325222741621, 885.3050355470955, 14259.215743134124, 14477.63805904853, 14551.199684017374, 14557.563273101823, 14603.78094328586, 12097.939510302436, 13709.65725856854, 13762.518311859087, 13785.241811700353, 13786.034977551575, 714.1037997313365, 899.5097671768868, 899.5367385796287, 918.5682729117304, 936.8501039833628, 929.869818225449, 935.7099299217265, 936.1153709744294, 936.8220038192756, 938.943663380196, 970.2916870684404, 971.480258061937, 979.5200351827624, 980.2256217588097, 983.1348413396202, 967.4195482710353, 968.8256113899495, 970.2335155227362, 972.1882228339346, 973.3089506450428, 726.3970904149543, 726.7492715013312, 727.1201845766628, 727.6580007396568, 728.0, 14692.338844752012, 14892.851071489364, 14893.776593351, 14909.105453672815, 14909.925450372679, 12921.095523313372, 12960.740785184244, 12998.545050923267, 13047.347632618332, 13186.07697461178, 10164.949175254076, 10973.50619222137, 11046.558137674483, 11214.327140371604, 11272.605458808903, 3561.71506279497, 3569.982150089233, 3598.478220658016, 3627.5828279747902, 3631.6005239423644, 48941.51058489441, 48951.265731014064, 48962.26556601654, 49172.508274917505, 49309.0, 10607.787844243227, 10720.785584288271, 10834.241603087867, 10896.291741036806, 10942.562297508011, 18692.906535467508, 18706.625867482573, 18712.906435467736, 18719.812801871805, 18737.250509979447, 7132.536385135053, 7214.0, 7314.853702925911, 7824.256695613907, 7877.7636670899965, 4401.471823381215, 4464.732116073046, 4500.482444518922, 4511.751853648081, 4562.794674239667, 3141.183292344007, 3155.432022235974, 3197.424463596575, 3205.102571280045, 3212.3414699986447, 582.033823852403, 602.4276936909953, 602.6534742522979, 612.2989177391951, 621.1645337021698, 658.0, 680.6120511308606, 695.1866316409813, 714.4962801225124, 722.3210182428605, 8948.418352807046, 9195.0, 9237.214836738818, 9317.16145546904, 9562.28282878787, 585.5988647776202, 622.1165944359021, 632.8322994406486, 722.9240929702305, 737.9151397589238, 3912.217556488714, 3928.9017774555864, 4320.611144996966, 4360.2587560114225, 4482.282834746425, 57580.0, 57771.0, 57791.71104144453, 58023.709881450326, 58257.4174258252, 53500.464995350325, 53524.732376338645, 53536.46463535393, 53772.462275377526, 54105.0, 47393.28910066352, 48171.5182848174, 48188.27717584239, 48625.27062094071, 48740.756296219, 9576.808463830544, 9579.568919398504, 9650.324477286522, 9659.517024148905, 9733.805323893625, 37871.43192852165, 38091.619083809914, 39103.608963909996, 39240.215195696495, 39464.40803388009, 45299.77350113228, 46785.2982205274, 46848.0, 47023.52976470192, 47847.282290766365, 12006.819897701716, 12118.515259389525, 12334.32161231105, 12412.193207441487, 12619.684507887376, 13094.541691040768, 13170.341482926007, 13384.799228011392, 13498.52755153565, 13626.182429054288, 12331.630051098482, 12340.691482713004, 12389.194702344319, 12473.251604903735, 13210.933945330213, 12315.549092798728, 12894.226346419246, 12952.870471295544, 12958.092933494565, 13248.80126798118, 10043.0, 12012.519499220283, 12338.259704417764, 12381.442835072263, 12499.125061245626, 10577.9471102644, 10667.946660266649, 10738.140948723927, 11007.889921100686, 11199.025568913194, 9939.304248702521, 9961.352512086982, 10182.432331146518, 10295.742606434898, 10532.26274160832], "unit": "ms", "name": "yui.html", "value": 6750.6063754028955}], "name": "dromaeo_css", "value": 7456.055245367368}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 105.0, 110.0, 108.0, 109.0, 120.0, 111.0, 110.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 147.0, 165.0, 124.0, 151.0, 155.0, 129.0, 163.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 75.0, 155.0, 76.0, 70.0, 71.0, 73.0, 157.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 92.0, 92.0, 94.0, 134.0, 92.0, 93.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 63.0, 59.0, 59.0, 60.0, 59.0, 58.0, 60.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 66.0, 63.0, 62.0, 62.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 81.0, 81.0, 81.0, 82.0, 82.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [114.0, 111.0, 123.0, 124.0, 112.0, 115.0, 123.0, 117.0, 114.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 135.0, 145.0, 148.0, 146.0, 145.0, 136.0, 154.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 65.0, 69.0, 66.0, 70.0, 65.0, 63.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1494.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.2845408247084], "unit": "score", "name": "Richards", "value": 214.88327399999997}, {"lowerIsBetter": false, "replicates": [172.65193370165747], "unit": "score", "name": "DeltaBlue", "value": 382.9554560000001}, {"lowerIsBetter": false, "replicates": [281.135788585887], "unit": "score", "name": "Encrypt", "value": 946.8058169999996}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [945.179584120983], "unit": "score", "name": "RayTrace", "value": 782.908362}, {"lowerIsBetter": false, "replicates": [553.0973451327434], "unit": "score", "name": "Earley", "value": 1204.9651040000003}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [521.9206680584551], "unit": "score", "name": "Splay", "value": 156.13675599999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23027.459765891654}]} 04:07:05 INFO - RETURN: dromaeo_css: 7456.05 04:07:05 INFO - RETURN: kraken: 1495.00 04:07:05 INFO - RETURN: v8_7: 23027.46 04:07:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23027.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1495.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7456.05"}}} 04:07:05 INFO - Return code: 0 04:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:05 INFO - # TBPL SUCCESS # 04:07:05 INFO - Running post-action listener: _resource_record_post_action 04:07:05 INFO - Running post-run listener: _resource_record_post_run 04:07:07 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 529350656; Read time: 0; Write time: 582244 04:07:07 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 255111168; Read time: 0; Write time: 396160 04:07:07 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 274239488; Read time: 0; Write time: 186084 04:07:07 INFO - Running post-run listener: _upload_blobber_files 04:07:07 INFO - Blob upload gear active. 04:07:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:07 INFO - Copying logs to upload dir... 04:07:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.671852 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-20 04:07:06.476753) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-20 04:07:06.479854) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010073 build_url: 'https://queue.taskcluster.net/v1/task/AWCGZLCNSaO8rFhIepoFiA/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-20 04:07:06.531415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:07:06.531732) ========= 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=eca2ab57546de7b41f256b19000001ef-1453290366.384221-898897373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 04:07:06.581433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:07:06.581808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 04:07:06.582099) ========= ========= Total master_lag: 0.28 =========