builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1453405118.06 results: success (0) buildid: 20160121092133 builduid: 46f51eb5b71240af9e74cb1bf4dcaa96 revision: 30d486237af363a74149d4cb58fe55dbb3993a3f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.059561) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.060145) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.060499) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006458 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.084493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.084811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.130450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.130938) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.180989) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.181307) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.181700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.182026) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 11:38:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-21 11:38:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166081 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.360858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.361226) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022441 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.412310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.412713) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 30d486237af363a74149d4cb58fe55dbb3993a3f --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 30d486237af363a74149d4cb58fe55dbb3993a3f --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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 11:38:38,949 truncating revision to first 12 chars 2016-01-21 11:38:38,949 Setting DEBUG logging. 2016-01-21 11:38:38,949 attempt 1/10 2016-01-21 11:38:38,949 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/30d486237af3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 11:38:39,208 unpacking tar archive at: mozilla-aurora-30d486237af3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.996242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:38.996596) ========= echo 30d486237af363a74149d4cb58fe55dbb3993a3f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'30d486237af363a74149d4cb58fe55dbb3993a3f'] 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 30d486237af363a74149d4cb58fe55dbb3993a3f program finished with exit code 0 elapsedTime=0.004690 script_repo_revision: '30d486237af363a74149d4cb58fe55dbb3993a3f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:39.056264) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:39.056573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 11:38:39.068243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-21 11:38:39.068573) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:38:39 INFO - MultiFileLogger online at 20160121 11:38:39 in /builds/slave/test-pgo 11:38:39 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 11:38:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:38:39 INFO - {'append_to_log': False, 11:38:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:38:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:38:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:38:39 INFO - 'branch': 'Mozilla-Aurora', 11:38:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:39 INFO - 'config_files': ('talos/linux_config.py',), 11:38:39 INFO - 'default_actions': ('clobber', 11:38:39 INFO - 'read-buildbot-config', 11:38:39 INFO - 'download-and-extract', 11:38:39 INFO - 'populate-webroot', 11:38:39 INFO - 'create-virtualenv', 11:38:39 INFO - 'install', 11:38:39 INFO - 'run-tests'), 11:38:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:39 INFO - 'download_minidump_stackwalk': True, 11:38:39 INFO - 'download_symbols': 'ondemand', 11:38:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:39 INFO - 'installer_path': 'installer.exe', 11:38:39 INFO - 'log_level': 'info', 11:38:39 INFO - 'log_name': 'talos', 11:38:39 INFO - 'log_to_console': True, 11:38:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:38:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:38:39 INFO - 'opt_config_files': (), 11:38:39 INFO - 'pip_index': False, 11:38:39 INFO - 'sps_profile': False, 11:38:39 INFO - 'sps_profile_interval': 0, 11:38:39 INFO - 'suite': 'dromaeojs-e10s', 11:38:39 INFO - 'system_bits': '32', 11:38:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:39 INFO - 'title': 'talos-linux64-ix-012', 11:38:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:39 INFO - 'use_talos_json': True, 11:38:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:38:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:39 INFO - 'work_dir': 'build'} 11:38:39 INFO - ##### 11:38:39 INFO - ##### Running clobber step. 11:38:39 INFO - ##### 11:38:39 INFO - Running pre-action listener: _resource_record_pre_action 11:38:39 INFO - Running main action method: clobber 11:38:39 INFO - rmtree: /builds/slave/test-pgo/build 11:38:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:38:40 INFO - Running post-action listener: _resource_record_post_action 11:38:40 INFO - ##### 11:38:40 INFO - ##### Running read-buildbot-config step. 11:38:40 INFO - ##### 11:38:40 INFO - Running pre-action listener: _resource_record_pre_action 11:38:40 INFO - Running main action method: read_buildbot_config 11:38:40 INFO - Using buildbot properties: 11:38:40 INFO - { 11:38:40 INFO - "properties": { 11:38:40 INFO - "buildnumber": 99, 11:38:40 INFO - "product": "firefox", 11:38:40 INFO - "script_repo_revision": "production", 11:38:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:38:40 INFO - "repository": "", 11:38:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:38:40 INFO - "buildid": "20160121092133", 11:38:40 INFO - "slavename": "talos-linux64-ix-012", 11:38:40 INFO - "pgo_build": "True", 11:38:40 INFO - "basedir": "/builds/slave/test-pgo", 11:38:40 INFO - "project": "", 11:38:40 INFO - "platform": "ubuntu64_hw", 11:38:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:38:40 INFO - "slavebuilddir": "test", 11:38:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:38:40 INFO - "branch": "mozilla-aurora", 11:38:40 INFO - "repo_path": "releases/mozilla-aurora", 11:38:40 INFO - "stage_platform": "linux64-pgo", 11:38:40 INFO - "builduid": "46f51eb5b71240af9e74cb1bf4dcaa96", 11:38:40 INFO - "revision": "30d486237af363a74149d4cb58fe55dbb3993a3f" 11:38:40 INFO - }, 11:38:40 INFO - "sourcestamp": { 11:38:40 INFO - "repository": "", 11:38:40 INFO - "hasPatch": false, 11:38:40 INFO - "project": "", 11:38:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:38:40 INFO - "changes": [ 11:38:40 INFO - { 11:38:40 INFO - "category": null, 11:38:40 INFO - "files": [ 11:38:40 INFO - { 11:38:40 INFO - "url": null, 11:38:40 INFO - "name": "https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:38:40 INFO - } 11:38:40 INFO - ], 11:38:40 INFO - "repository": "", 11:38:40 INFO - "rev": "30d486237af363a74149d4cb58fe55dbb3993a3f", 11:38:40 INFO - "who": "vdjeric@mozilla.com", 11:38:40 INFO - "when": 1453405033, 11:38:40 INFO - "number": 7494934, 11:38:40 INFO - "comments": "Bug 1228437 - Add BHR stats from e10s child process. B2G fix by Ting-Yu Chou. r=nchen,a=sylvestre", 11:38:40 INFO - "project": "", 11:38:40 INFO - "at": "Thu 21 Jan 2016 11:37:13", 11:38:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:38:40 INFO - "revlink": "", 11:38:40 INFO - "properties": [ 11:38:40 INFO - [ 11:38:40 INFO - "buildid", 11:38:40 INFO - "20160121092133", 11:38:40 INFO - "Change" 11:38:40 INFO - ], 11:38:40 INFO - [ 11:38:40 INFO - "builduid", 11:38:40 INFO - "46f51eb5b71240af9e74cb1bf4dcaa96", 11:38:40 INFO - "Change" 11:38:40 INFO - ], 11:38:40 INFO - [ 11:38:40 INFO - "pgo_build", 11:38:40 INFO - "True", 11:38:40 INFO - "Change" 11:38:40 INFO - ] 11:38:40 INFO - ], 11:38:40 INFO - "revision": "30d486237af363a74149d4cb58fe55dbb3993a3f" 11:38:40 INFO - } 11:38:40 INFO - ], 11:38:40 INFO - "revision": "30d486237af363a74149d4cb58fe55dbb3993a3f" 11:38:40 INFO - } 11:38:40 INFO - } 11:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:38:40 INFO - Running post-action listener: _resource_record_post_action 11:38:40 INFO - ##### 11:38:40 INFO - ##### Running download-and-extract step. 11:38:40 INFO - ##### 11:38:40 INFO - Running pre-action listener: _resource_record_pre_action 11:38:40 INFO - Running main action method: download_and_extract 11:38:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:40 INFO - https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/test_packages.json 11:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/test_packages.json 11:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:38:42 INFO - Downloaded 1302 bytes. 11:38:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:38:42 INFO - Using the following test package requirements: 11:38:42 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:38:42 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:38:42 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'jsshell-linux-x86_64.zip'], 11:38:42 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:38:42 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:38:42 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:38:42 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:38:42 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:38:42 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:38:42 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:38:42 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:38:42 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:42 INFO - https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:43 INFO - Downloaded 23159812 bytes. 11:38:43 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 11:38:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:43 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 11:38:44 INFO - Return code: 0 11:38:44 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 11:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:44 INFO - https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:46 INFO - Downloaded 23159812 bytes. 11:38:46 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 11:38:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:38:46 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 11:38:48 INFO - Return code: 0 11:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:48 INFO - https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:49 INFO - Downloaded 11132038 bytes. 11:38:49 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 11:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:38:49 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 11:38:49 INFO - Return code: 0 11:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:49 INFO - https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:38:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:38:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:38:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/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 11:38:50 INFO - Downloaded 58140229 bytes. 11:38:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:38:50 INFO - mkdir: /builds/slave/test-pgo/properties 11:38:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:38:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:38:50 INFO - Contents: 11:38:50 INFO - build_url:https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - Running post-action listener: set_extra_try_arguments 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running populate-webroot step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: populate_webroot 11:38:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:50 INFO - '--tppagecycles', 11:38:50 INFO - '7'], 11:38:50 INFO - 'tests': ['tsvgm']}}, 11:38:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:38:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:38:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:38:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['damp', 'tps']}, 11:38:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['damp', 'tps']}, 11:38:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:38:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:50 INFO - 'other': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'other_l64': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'other_nol64': {'tests': ['a11yr', 11:38:50 INFO - 'ts_paint', 11:38:50 INFO - 'tpaint', 11:38:50 INFO - 'sessionrestore', 11:38:50 INFO - 'sessionrestore_no_auto_restore']}, 11:38:50 INFO - 'svgr': {'tests': ['tsvgx', 11:38:50 INFO - 'tsvgr_opacity', 11:38:50 INFO - 'tart', 11:38:50 INFO - 'tscrollx', 11:38:50 INFO - 'cart']}, 11:38:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['tsvgx', 11:38:50 INFO - 'tsvgr_opacity', 11:38:50 INFO - 'tart', 11:38:50 INFO - 'tscrollx', 11:38:50 INFO - 'cart']}, 11:38:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'tests': ['tp5o']}, 11:38:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--e10s'], 11:38:50 INFO - 'tests': ['tp5o']}, 11:38:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--xperf_path', 11:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:50 INFO - 'tests': ['tp5n']}, 11:38:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:38:50 INFO - 'talos_options': ['--e10s', 11:38:50 INFO - '--xperf_path', 11:38:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:50 INFO - 'tests': ['tp5n']}}, 11:38:50 INFO - 'talos.zip': {'path': '', 11:38:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:50 INFO - Running post-action listener: _resource_record_post_action 11:38:50 INFO - ##### 11:38:50 INFO - ##### Running create-virtualenv step. 11:38:50 INFO - ##### 11:38:50 INFO - Running pre-action listener: _resource_record_pre_action 11:38:50 INFO - Running main action method: create_virtualenv 11:38:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:38:50 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 11:38:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:38:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:50 INFO - Using real prefix '/usr' 11:38:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:38:51 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:53 INFO - Installing pip.................done. 11:38:53 INFO - Return code: 0 11:38:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:38:53 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')]} 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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')]} 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:38:53 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 11:38:53 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 11:38:53 INFO - Using env: {'DISPLAY': ':0', 11:38:53 INFO - 'HOME': '/home/cltbld', 11:38:53 INFO - 'LANG': 'en_US.UTF-8', 11:38:53 INFO - 'LANGUAGE': 'en_US:en', 11:38:53 INFO - 'LOGNAME': 'cltbld', 11:38:53 INFO - 'MAIL': '/var/mail/cltbld', 11:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:53 INFO - 'MOZ_NO_REMOTE': '1', 11:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:53 INFO - 'NO_EM_RESTART': '1', 11:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:38:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:38:53 INFO - 'SHELL': '/bin/bash', 11:38:53 INFO - 'SHLVL': '1', 11:38:53 INFO - 'TERM': 'linux', 11:38:53 INFO - 'TMOUT': '86400', 11:38:53 INFO - 'USER': 'cltbld', 11:38:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:53 INFO - '_': '/tools/buildbot/bin/python'} 11:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:53 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 11:38:53 INFO - Cleaning up... 11:38:53 INFO - Return code: 0 11:38:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:38:53 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')]} 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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')]} 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:53 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:38:53 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 11:38:53 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 11:38:53 INFO - Using env: {'DISPLAY': ':0', 11:38:53 INFO - 'HOME': '/home/cltbld', 11:38:53 INFO - 'LANG': 'en_US.UTF-8', 11:38:53 INFO - 'LANGUAGE': 'en_US:en', 11:38:53 INFO - 'LOGNAME': 'cltbld', 11:38:53 INFO - 'MAIL': '/var/mail/cltbld', 11:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:53 INFO - 'MOZ_NO_REMOTE': '1', 11:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:53 INFO - 'NO_EM_RESTART': '1', 11:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:38:53 INFO - 'PWD': '/builds/slave/test-pgo', 11:38:53 INFO - 'SHELL': '/bin/bash', 11:38:53 INFO - 'SHLVL': '1', 11:38:53 INFO - 'TERM': 'linux', 11:38:53 INFO - 'TMOUT': '86400', 11:38:53 INFO - 'USER': 'cltbld', 11:38:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:53 INFO - '_': '/tools/buildbot/bin/python'} 11:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:53 INFO - Downloading/unpacking psutil>=0.7.1 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:55 INFO - Installing collected packages: psutil 11:38:55 INFO - Running setup.py install for psutil 11:38:55 INFO - building 'psutil._psutil_linux' extension 11:38:55 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 11:38:55 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 11:38:56 INFO - building 'psutil._psutil_posix' extension 11:38:56 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 11:38:56 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 11:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:56 INFO - Successfully installed psutil 11:38:56 INFO - Cleaning up... 11:38:56 INFO - Return code: 0 11:38:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:38: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')]} 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38: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')]} 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:56 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:38:56 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 11:38:56 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 11:38:56 INFO - Using env: {'DISPLAY': ':0', 11:38:56 INFO - 'HOME': '/home/cltbld', 11:38:56 INFO - 'LANG': 'en_US.UTF-8', 11:38:56 INFO - 'LANGUAGE': 'en_US:en', 11:38:56 INFO - 'LOGNAME': 'cltbld', 11:38:56 INFO - 'MAIL': '/var/mail/cltbld', 11:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:56 INFO - 'MOZ_NO_REMOTE': '1', 11:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:56 INFO - 'NO_EM_RESTART': '1', 11:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:38:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:38:56 INFO - 'SHELL': '/bin/bash', 11:38:56 INFO - 'SHLVL': '1', 11:38:56 INFO - 'TERM': 'linux', 11:38:56 INFO - 'TMOUT': '86400', 11:38:56 INFO - 'USER': 'cltbld', 11:38:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:56 INFO - '_': '/tools/buildbot/bin/python'} 11:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:38:58 INFO - Installing collected packages: mozsystemmonitor 11:38:58 INFO - Running setup.py install for mozsystemmonitor 11:38:58 INFO - Successfully installed mozsystemmonitor 11:38:58 INFO - Cleaning up... 11:38:58 INFO - Return code: 0 11:38:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:58 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:38:58 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 11:38:58 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 11:38:58 INFO - Using env: {'DISPLAY': ':0', 11:38:58 INFO - 'HOME': '/home/cltbld', 11:38:58 INFO - 'LANG': 'en_US.UTF-8', 11:38:58 INFO - 'LANGUAGE': 'en_US:en', 11:38:58 INFO - 'LOGNAME': 'cltbld', 11:38:58 INFO - 'MAIL': '/var/mail/cltbld', 11:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:58 INFO - 'MOZ_NO_REMOTE': '1', 11:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:58 INFO - 'NO_EM_RESTART': '1', 11:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:38:58 INFO - 'PWD': '/builds/slave/test-pgo', 11:38:58 INFO - 'SHELL': '/bin/bash', 11:38:58 INFO - 'SHLVL': '1', 11:38:58 INFO - 'TERM': 'linux', 11:38:58 INFO - 'TMOUT': '86400', 11:38:58 INFO - 'USER': 'cltbld', 11:38:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:58 INFO - '_': '/tools/buildbot/bin/python'} 11:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:58 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:58 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 11:38:58 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 11:38:58 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 11:38:58 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 11:38:58 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 11:38:58 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 11:39:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:39:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 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 11:39:01 INFO - Downloading docopt-0.6.1.tar.gz 11:39:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:01 INFO - Running setup.py install for blobuploader 11:39:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:39:01 INFO - Running setup.py install for requests 11:39:01 INFO - Running setup.py install for docopt 11:39:01 INFO - Successfully installed blobuploader requests docopt 11:39:01 INFO - Cleaning up... 11:39:01 INFO - Return code: 0 11:39:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:01 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:39:01 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 11:39:01 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 11:39:01 INFO - Using env: {'DISPLAY': ':0', 11:39:01 INFO - 'HOME': '/home/cltbld', 11:39:01 INFO - 'LANG': 'en_US.UTF-8', 11:39:01 INFO - 'LANGUAGE': 'en_US:en', 11:39:01 INFO - 'LOGNAME': 'cltbld', 11:39:01 INFO - 'MAIL': '/var/mail/cltbld', 11:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:01 INFO - 'MOZ_NO_REMOTE': '1', 11:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:01 INFO - 'NO_EM_RESTART': '1', 11:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:01 INFO - 'SHELL': '/bin/bash', 11:39:01 INFO - 'SHLVL': '1', 11:39:01 INFO - 'TERM': 'linux', 11:39:01 INFO - 'TMOUT': '86400', 11:39:01 INFO - 'USER': 'cltbld', 11:39:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:01 INFO - '_': '/tools/buildbot/bin/python'} 11:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:39:02 INFO - Running setup.py (path:/tmp/pip-qmuS3e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:39:02 INFO - Running setup.py (path:/tmp/pip-d0qnKW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:39:02 INFO - Running setup.py (path:/tmp/pip-NupNTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:39:02 INFO - Running setup.py (path:/tmp/pip-RUw3tt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:39:02 INFO - Running setup.py (path:/tmp/pip-EgbICP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:39:02 INFO - Running setup.py (path:/tmp/pip-3bbzd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:39:02 INFO - Running setup.py (path:/tmp/pip-TOQzp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:39:02 INFO - Running setup.py (path:/tmp/pip-7jxq5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:39:02 INFO - Running setup.py (path:/tmp/pip-Tcdlqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:39:02 INFO - Running setup.py (path:/tmp/pip-OBDbaZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:39:02 INFO - Running setup.py (path:/tmp/pip-9x2f1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:39:02 INFO - Running setup.py (path:/tmp/pip-5xK_ae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:39:02 INFO - Running setup.py (path:/tmp/pip-6LuGfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:39:02 INFO - Running setup.py (path:/tmp/pip-aJCa71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:39:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:39:02 INFO - Running setup.py (path:/tmp/pip-n54Z7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:39:03 INFO - Running setup.py (path:/tmp/pip-eMKJmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:39:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:39:03 INFO - Running setup.py (path:/tmp/pip-OX81km-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:39:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:03 INFO - Running setup.py install for manifestparser 11:39:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:39:03 INFO - Running setup.py install for mozcrash 11:39:03 INFO - Running setup.py install for mozdebug 11:39:03 INFO - Running setup.py install for mozdevice 11:39:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:39:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:39:03 INFO - Running setup.py install for mozfile 11:39:03 INFO - Running setup.py install for mozhttpd 11:39:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:39:03 INFO - Running setup.py install for mozinfo 11:39:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:39:03 INFO - Running setup.py install for mozInstall 11:39:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Running setup.py install for mozleak 11:39:04 INFO - Running setup.py install for mozlog 11:39:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Running setup.py install for moznetwork 11:39:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Running setup.py install for mozprocess 11:39:04 INFO - Running setup.py install for mozprofile 11:39:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Running setup.py install for mozrunner 11:39:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Running setup.py install for mozscreenshot 11:39:04 INFO - Running setup.py install for moztest 11:39:04 INFO - Running setup.py install for mozversion 11:39:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:39:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:04 INFO - Cleaning up... 11:39:04 INFO - Return code: 0 11:39:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:04 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:39:04 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 11:39:04 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 11:39:04 INFO - Using env: {'DISPLAY': ':0', 11:39:04 INFO - 'HOME': '/home/cltbld', 11:39:04 INFO - 'LANG': 'en_US.UTF-8', 11:39:04 INFO - 'LANGUAGE': 'en_US:en', 11:39:04 INFO - 'LOGNAME': 'cltbld', 11:39:04 INFO - 'MAIL': '/var/mail/cltbld', 11:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:04 INFO - 'MOZ_NO_REMOTE': '1', 11:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:04 INFO - 'NO_EM_RESTART': '1', 11:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:04 INFO - 'SHELL': '/bin/bash', 11:39:04 INFO - 'SHLVL': '1', 11:39:04 INFO - 'TERM': 'linux', 11:39:04 INFO - 'TMOUT': '86400', 11:39:04 INFO - 'USER': 'cltbld', 11:39:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:05 INFO - '_': '/tools/buildbot/bin/python'} 11:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:39:05 INFO - Running setup.py (path:/tmp/pip-Rft8r1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:39:05 INFO - Running setup.py (path:/tmp/pip-TT3MsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:39:05 INFO - Running setup.py (path:/tmp/pip-ZU3uTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:39:05 INFO - Running setup.py (path:/tmp/pip-hawgPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:39:05 INFO - Running setup.py (path:/tmp/pip-fSMcwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:39:05 INFO - Running setup.py (path:/tmp/pip-Q0qCn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:39:05 INFO - Running setup.py (path:/tmp/pip-CKPGU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:39:05 INFO - Running setup.py (path:/tmp/pip-DfIwR4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:39:05 INFO - Running setup.py (path:/tmp/pip-FruUdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:39:05 INFO - Running setup.py (path:/tmp/pip-1kFgt2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:39:05 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)) 11:39:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:39:05 INFO - Running setup.py (path:/tmp/pip-8_drIX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:39:06 INFO - Running setup.py (path:/tmp/pip-x90RSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:39:06 INFO - Running setup.py (path:/tmp/pip-c5Wsrh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:39:06 INFO - Running setup.py (path:/tmp/pip-UTn0Fy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:39:06 INFO - Running setup.py (path:/tmp/pip-lPr4D6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:39:06 INFO - Running setup.py (path:/tmp/pip-mftYiP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:39:06 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)) 11:39:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:39:06 INFO - Running setup.py (path:/tmp/pip-hvovRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 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)) 11:39:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:08 INFO - Downloading blessings-1.6.tar.gz 11:39:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:08 INFO - Installing collected packages: blessings 11:39:08 INFO - Running setup.py install for blessings 11:39:08 INFO - Successfully installed blessings 11:39:08 INFO - Cleaning up... 11:39:08 INFO - Return code: 0 11:39:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:39:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:39:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:39:08 INFO - Reading from file tmpfile_stdout 11:39:08 INFO - Current package versions: 11:39:08 INFO - argparse == 1.2.1 11:39:08 INFO - blessings == 1.6 11:39:08 INFO - blobuploader == 1.2.4 11:39:08 INFO - docopt == 0.6.1 11:39:08 INFO - manifestparser == 1.1 11:39:08 INFO - mozInstall == 1.12 11:39:08 INFO - mozcrash == 0.16 11:39:08 INFO - mozdebug == 0.1 11:39:08 INFO - mozdevice == 0.47 11:39:08 INFO - mozfile == 1.2 11:39:08 INFO - mozhttpd == 0.7 11:39:08 INFO - mozinfo == 0.9 11:39:08 INFO - mozleak == 0.1 11:39:08 INFO - mozlog == 3.1 11:39:08 INFO - moznetwork == 0.27 11:39:08 INFO - mozprocess == 0.22 11:39:08 INFO - mozprofile == 0.27 11:39:08 INFO - mozrunner == 6.11 11:39:08 INFO - mozscreenshot == 0.1 11:39:08 INFO - mozsystemmonitor == 0.0 11:39:08 INFO - moztest == 0.7 11:39:08 INFO - mozversion == 1.4 11:39:08 INFO - psutil == 3.1.1 11:39:08 INFO - requests == 1.2.3 11:39:08 INFO - wsgiref == 0.1.2 11:39:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:39:08 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')]} 11:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:08 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')]} 11:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:08 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:39:08 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 11:39:08 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 11:39:08 INFO - Using env: {'DISPLAY': ':0', 11:39:08 INFO - 'HOME': '/home/cltbld', 11:39:08 INFO - 'LANG': 'en_US.UTF-8', 11:39:08 INFO - 'LANGUAGE': 'en_US:en', 11:39:08 INFO - 'LOGNAME': 'cltbld', 11:39:08 INFO - 'MAIL': '/var/mail/cltbld', 11:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:08 INFO - 'MOZ_NO_REMOTE': '1', 11:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:08 INFO - 'NO_EM_RESTART': '1', 11:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:08 INFO - 'SHELL': '/bin/bash', 11:39:08 INFO - 'SHLVL': '1', 11:39:08 INFO - 'TERM': 'linux', 11:39:08 INFO - 'TMOUT': '86400', 11:39:08 INFO - 'USER': 'cltbld', 11:39:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:08 INFO - '_': '/tools/buildbot/bin/python'} 11:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 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)) 11:39:08 INFO - Cleaning up... 11:39:08 INFO - Return code: 0 11:39:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:39:08 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')]} 11:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:08 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')]} 11:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:08 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:39:08 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 11:39:08 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 11:39:08 INFO - Using env: {'DISPLAY': ':0', 11:39:08 INFO - 'HOME': '/home/cltbld', 11:39:08 INFO - 'LANG': 'en_US.UTF-8', 11:39:08 INFO - 'LANGUAGE': 'en_US:en', 11:39:08 INFO - 'LOGNAME': 'cltbld', 11:39:08 INFO - 'MAIL': '/var/mail/cltbld', 11:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:08 INFO - 'MOZ_NO_REMOTE': '1', 11:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:08 INFO - 'NO_EM_RESTART': '1', 11:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:08 INFO - 'SHELL': '/bin/bash', 11:39:08 INFO - 'SHLVL': '1', 11:39:08 INFO - 'TERM': 'linux', 11:39:08 INFO - 'TMOUT': '86400', 11:39:08 INFO - 'USER': 'cltbld', 11:39:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:08 INFO - '_': '/tools/buildbot/bin/python'} 11:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:09 INFO - Downloading/unpacking jsonschema 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:09 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 11:39:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:10 INFO - Downloading/unpacking functools32 (from jsonschema) 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:10 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 11:39:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:11 INFO - warning: no files found matching '*.txt' 11:39:11 INFO - no previously-included directories found matching 'build' 11:39:11 INFO - no previously-included directories found matching 'dist' 11:39:11 INFO - no previously-included directories found matching '.git*' 11:39:11 INFO - Installing collected packages: jsonschema, functools32 11:39:11 INFO - Running setup.py install for functools32 11:39:11 INFO - warning: no files found matching '*.txt' 11:39:11 INFO - no previously-included directories found matching 'build' 11:39:11 INFO - no previously-included directories found matching 'dist' 11:39:11 INFO - no previously-included directories found matching '.git*' 11:39:11 INFO - Successfully installed jsonschema functools32 11:39:11 INFO - Cleaning up... 11:39:11 INFO - Return code: 0 11:39:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:11 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 0x7f00c4121f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b58450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', '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 11:39:11 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 11:39:11 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 11:39:11 INFO - Using env: {'DISPLAY': ':0', 11:39:11 INFO - 'HOME': '/home/cltbld', 11:39:11 INFO - 'LANG': 'en_US.UTF-8', 11:39:11 INFO - 'LANGUAGE': 'en_US:en', 11:39:11 INFO - 'LOGNAME': 'cltbld', 11:39:11 INFO - 'MAIL': '/var/mail/cltbld', 11:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:11 INFO - 'MOZ_NO_REMOTE': '1', 11:39:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:11 INFO - 'NO_EM_RESTART': '1', 11:39:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:11 INFO - 'SHELL': '/bin/bash', 11:39:11 INFO - 'SHLVL': '1', 11:39:11 INFO - 'TERM': 'linux', 11:39:11 INFO - 'TMOUT': '86400', 11:39:11 INFO - 'USER': 'cltbld', 11:39:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:11 INFO - '_': '/tools/buildbot/bin/python'} 11:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:11 INFO - Downloading/unpacking flake8 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:11 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 11:39:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:39:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:39:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 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 11:39:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:14 INFO - no previously-included directories found matching 'docs/_build' 11:39:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:39:14 INFO - Running setup.py install for pep8 11:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:39:14 INFO - no previously-included directories found matching 'docs/_build' 11:39:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:39:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:39:14 INFO - Cleaning up... 11:39:14 INFO - Return code: 0 11:39:14 INFO - Running post-action listener: _resource_record_post_action 11:39:14 INFO - Running post-action listener: _start_resource_monitoring 11:39:14 INFO - Starting resource monitoring. 11:39:14 INFO - ##### 11:39:14 INFO - ##### Running install step. 11:39:14 INFO - ##### 11:39:14 INFO - Running pre-action listener: _resource_record_pre_action 11:39:14 INFO - Running main action method: install 11:39:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:39:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:39:14 INFO - Reading from file tmpfile_stdout 11:39:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:39:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:39:14 INFO - Reading from file tmpfile_stdout 11:39:14 INFO - Output received: 11:39:14 INFO - Usage: mozinstall [options] installer 11:39:14 INFO - Options: 11:39:14 INFO - -h, --help show this help message and exit 11:39:14 INFO - -d DEST, --destination=DEST 11:39:14 INFO - Directory to install application into. [default: 11:39:14 INFO - "/builds/slave/test-pgo"] 11:39:14 INFO - --app=APP Application being installed. [default: firefox] 11:39:14 INFO - mkdir: /builds/slave/test-pgo/build/application 11:39:14 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'] 11:39:14 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 11:39:29 INFO - Reading from file tmpfile_stdout 11:39:29 INFO - Output received: 11:39:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:39:29 INFO - Running post-action listener: _resource_record_post_action 11:39:29 INFO - ##### 11:39:29 INFO - ##### Running run-tests step. 11:39:29 INFO - ##### 11:39:29 INFO - Running pre-action listener: _resource_record_pre_action 11:39:29 INFO - Running main action method: run_tests 11:39:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:39:29 INFO - Python 2.7.3 11:39:29 INFO - Return code: 0 11:39:29 INFO - grabbing minidump binary from tooltool 11:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:29 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 0x2beaa50>, '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 0x2b56550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b569e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:39:29 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 11:39:29 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 11:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:29 INFO - Return code: 0 11:39:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:39:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:39:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:39:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:39:30 INFO - Return code: 0 11:39:30 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/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:39:30 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/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 11:39:30 INFO - Using env: {'DISPLAY': ':0', 11:39:30 INFO - 'HOME': '/home/cltbld', 11:39:30 INFO - 'LANG': 'en_US.UTF-8', 11:39:30 INFO - 'LANGUAGE': 'en_US:en', 11:39:30 INFO - 'LOGNAME': 'cltbld', 11:39:30 INFO - 'MAIL': '/var/mail/cltbld', 11:39:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:39:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:30 INFO - 'MOZ_NO_REMOTE': '1', 11:39:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:30 INFO - 'NO_EM_RESTART': '1', 11:39:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:39:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:39:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:39:30 INFO - 'SHELL': '/bin/bash', 11:39:30 INFO - 'SHLVL': '1', 11:39:30 INFO - 'TERM': 'linux', 11:39:30 INFO - 'TMOUT': '86400', 11:39:30 INFO - 'USER': 'cltbld', 11:39:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513', 11:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:30 INFO - '_': '/tools/buildbot/bin/python'} 11:39:30 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/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 11:39:30 INFO - mozversion INFO | application_buildid: 20160121092133 11:39:30 INFO - mozversion INFO | application_changeset: 30d486237af363a74149d4cb58fe55dbb3993a3f 11:39:30 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:39:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:30 INFO - mozversion INFO | application_name: Firefox 11:39:30 INFO - mozversion INFO | application_remotingname: firefox-dev 11:39:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:30 INFO - mozversion INFO | application_vendor: Mozilla 11:39:30 INFO - mozversion INFO | application_version: 45.0a2 11:39:30 INFO - mozversion INFO | platform_buildid: 20160121092133 11:39:30 INFO - mozversion INFO | platform_changeset: 30d486237af363a74149d4cb58fe55dbb3993a3f 11:39:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:39:30 INFO - mozversion INFO | platform_version: 45.0a2 11:39:30 INFO - 2016-01-21 11:39:30,526 DEBUG : using testdate: 1453405170 11:39:30 INFO - 2016-01-21 11:39:30,526 DEBUG : actual date: 1453405170 11:39:30 INFO - 2016-01-21 11:39:30,573 INFO : starting webserver on 'localhost:36016' 11:39:30 INFO - 2016-01-21 11:39:30,574 INFO : Starting test suite talos-linux64-ix-012.e 11:39:30 INFO - 2016-01-21 11:39:30,574 INFO : Starting test dromaeo_css 11:39:30 INFO - 2016-01-21 11:39:30,575 DEBUG : operating with platform_type : linux_ 11:39:30 INFO - 2016-01-21 11:39:30,575 INFO : Initialising browser for dromaeo_css test... 11:39:30 INFO - 2016-01-21 11:39:30,592 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLURRxb/profile http://localhost:36016/getInfo.html 11:39:33 INFO - 2016-01-21 11:39:33,672 DEBUG : BROWSER_OUTPUT: 11:39:33 INFO - 2016-01-21 11:39:33,673 DEBUG : BROWSER_OUTPUT: (process:19490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:39:34 INFO - 2016-01-21 11:39:34,379 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:39:34 INFO - 2016-01-21 11:39:34,379 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:39:34 INFO - 2016-01-21 11:39:34,379 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:39:34 INFO - 2016-01-21 11:39:34,380 DEBUG : BROWSER_OUTPUT: __metrics 11:39:35 INFO - 2016-01-21 11:39:35,301 INFO : Browser initialized. 11:39:35 INFO - 2016-01-21 11:39:35,302 INFO : Running cycle 1/1 for dromaeo_css test... 11:39:35 INFO - 2016-01-21 11:39:35,302 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLURRxb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:39:36 INFO - 2016-01-21 11:39:36,557 DEBUG : BROWSER_OUTPUT: 11:39:36 INFO - 2016-01-21 11:39:36,558 DEBUG : BROWSER_OUTPUT: (process:19604): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:39:47 INFO - 2016-01-21 11:39:47,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 137097216 11:39:47 INFO - 2016-01-21 11:39:47,062 DEBUG : BROWSER_OUTPUT: 11:40:36 INFO - 2016-01-21 11:40:36,679 DEBUG : BROWSER_OUTPUT: 1453405236677 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] 11:42:44 INFO - 2016-01-21 11:42:44,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36016/tests/dromaeo/cssquery-ext.html) 11:42:45 INFO - 2016-01-21 11:42:45,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 140759040 11:42:45 INFO - 2016-01-21 11:42:45,709 DEBUG : BROWSER_OUTPUT: 11:45:47 INFO - 2016-01-21 11:45:47,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-ext.html (next: http://localhost:36016/tests/dromaeo/cssquery-jquery.html) 11:45:48 INFO - 2016-01-21 11:45:48,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 139243520 11:45:48 INFO - 2016-01-21 11:45:48,206 DEBUG : BROWSER_OUTPUT: 11:48:49 INFO - 2016-01-21 11:48:49,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36016/tests/dromaeo/cssquery-mootools.html) 11:48:50 INFO - 2016-01-21 11:48:50,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 139198464 11:48:50 INFO - 2016-01-21 11:48:50,375 DEBUG : BROWSER_OUTPUT: 11:51:51 INFO - 2016-01-21 11:51:51,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36016/tests/dromaeo/cssquery-prototype.html) 11:51:52 INFO - 2016-01-21 11:51:52,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 139776000 11:51:52 INFO - 2016-01-21 11:51:52,544 DEBUG : BROWSER_OUTPUT: 11:54:54 INFO - 2016-01-21 11:54:54,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36016/tests/dromaeo/cssquery-yui.html) 11:54:55 INFO - 2016-01-21 11:54:55,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 138625024 11:54:55 INFO - 2016-01-21 11:54:55,390 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/dromaeo/cssquery-yui.html (next: http://localhost:36016/tests/dromaeo/cssquery-dojo.html) 11:57:57 INFO - 2016-01-21 11:57:57,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 141303808 11:57:57 INFO - 2016-01-21 11:57:57,692 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,692 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:57:57 INFO - 2016-01-21 11:57:57,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:57:57 INFO - 2016-01-21 11:57:57,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:57:57 INFO - 2016-01-21 11:57:57,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:57:57 INFO - 2016-01-21 11:57:57,694 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3271.820049897256;3294.802311861287;3326.1185785766793;3339.4656854903205;3344.046946620214;5405.6216064875425;5433.022056029918;5474.91787623186;5489.066858634032;5498.505134537891;5424.16772490725;5464.23500709901;5473.616846820724;5475.780968761254;5508.063629183039;4974.925376119361;5021.07110184617;5048.7223202723835;5062.936783275498;5082.847514574569;4840.903181936359;5002.774875130628;5037.4710655381205;5045.571126454256;5115;4988.301637770715;5056.140456122468;5065.848024559269;5065.949340506585;5116.027954688616;5089.923651145235;5164.870878228036;5171.663841850268;5185.429602743695;5207.9479205207845;4799.448063472711;4882.682625629358;4898.975505122487;5061.873453163664;5079.31429257053;5279.577633789326;5300.496452836975;5339.5461385782255;5370.91943620846;5374.220737993008;5959.880802383971;5991.850203744898;6022.8494287642725;6027.336992930774;6035.637861728311;5797.797077102281;5909.7636094556165;5921.8815623687715;5999.370066143079;6024.186734790791;5555.2500412444615;5558.888822223533;5566.888662226774;5568.1091025435735;5571.777128914839;5940.049592065248;5944.613600115978;5954.8809023819285;5963.254593175853;5972.223610930638;5746.080627099644;5764.279465066867;5807.303123625192;5856.970715146397;5864.70676466175;5840.970795145997;5886.3230728465915;5898.705064746746;5919.052951527735;5959.851003724855;5719.4852463277675;5888.116782482576;5889.880922624688;5923.08192230205;5928.199693041384;5847.473727364472;5870.853228669317;5891.911621325684;5952.523798096142;5963.671998040149;4476.865694029184;4480.081583275421;4489.551044895485;4500.167469018242;4527.796249168795;3908.8241029153755;4034.9596504034585;4042.130941847458;4044.4742183515955;4051.3922911562913;5452.972735136299;5511.641743286674;5538.944610553843;5542.639728417721;5545.833624991256;5991.400859913973;5993.550483713739;6030.728617212236;6050;6052.394760523913;5483.396826349178;5592.3009623797025;5602.2717046783655;5708.143778433186;5741.081426971665;5098.388193416739;5143.71709555978;5147.897042059138;5170.224466330081;5216.686998780086;5974.163617093611;6059.0608455689435;6092.45167934888;6095.451409373178;6095.756169753249;5783.19035335045;5924.733386997509;6005.759769609254;6026.306974697965;6026.90959635597;5891.823245302648;6054.212952316171;6078.331383547717;6084.543659225487;6116;5830.2129212555765;5877.265341832271;5880.206172166874;5885.558583106199;5900.232969713909;5790.971045144747;5840.853978650568;5873.94126058751;5957.731902064331;5985.670788106696;5820.505257053198;5851.414858514285;5854.151148083589;5855.297364316139;5860.238169037998;5781.132830075522;5789.2763404574425;5790.507806836466;5834.03738383162;5846.619969702126;5454.2091396746455;5518.586106042143;5629.014922388647;5706.172604972173;5721.370649228498;5744.655320680772;5747.885042299215;5791.913121303268;5794.855128621818;5839.678817664899;5678.602497825113;5694.772209111755;5696.715164241854;5715.685637289989;5723.227364305765 11:57:57 INFO - 2016-01-21 11:57:57,695 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.3710176553227;587.0372588954115;590.3830497130497;639.1307821362949;651.3063587279544;32528.18679533013;33145.50281745776;40648;41236.79381603095;41309.58690413102;46093.30860037094;46364.304535432;46626.76686616571;46640.300395494094;46700.06599868001;8910.866337004934;9047.728568142966;9090.54547272637;9120.17918387345;9139.817203655923;8931.24084452819;8961.865572016424;9042.095790420972;9042.773930651754;9062.320325975545;9020.143086406813;9062.501562414065;9064.365494415393;9110.180083792457;9122.954385228064;8996.505192214425;9048.366614337;9077.682281120162;9092.545192769192;9098.727038188865;8919.73240802777;9036.954815225947;9077.228435582983;9080.31897607682;9113.134252246093;43029;43292.13415731699;43432.348514772304;43462;43774.124517509474;3689.760165589228;3734.3651579231323;3754.9249015019545;3919.314120029012;4209.705320627558;36127.63872361269;36309.63690363115;36382.63617363819;36640.63359366399;36684;4048.3725022621247;4156.8129434175535;4165.541790403053;4189.099343641132;4251.171021650779;291032;297331;299531.5023424891;299681;301718;49334.25998610024;51741.7412912933;69615.30384696089;70735.64632176909;71088.2891171092;73642.63178684072;74024;74186;74252;74485.6275718618;16411.753823692656;16425.6714865702;16453.259603317878;16558.503244902673;16658.83341166597;12407.25556466615;12457.377131143407;12486.12597118193;12514.436850341757;12516.74966500665;23073.19243826458;23506.529869402515;23563.293101206993;23879;23884.88057559701;9200.81598368029;9399.57701903416;9514.809703805886;9577.425354478613;9580.425174489414;966.7631430299481;972.8540718892082;1088.78768640116;1088.8240700043934;1092.9562268034008;28159.15522534327;28445.715542844722;28753.281167970967;29290.267743306587;29366.265843354086;1089.9400532970603;1090.6837017265063;1092.4428541443922;1203.9518419263131;1204.2533629149982;15500;15593.844061559466;15610.45363412275;17648;17929.820701792814;600955;748752;761098;839263;839747;60725.39274607286;61128;61485.385146147964;61534.38465615376;61760.07359889605;1460.1093333066822;1465.5823090419178;1482.651576879454;1511.2519302945113;1513.2585033333587;31337.8433107833;32007.359852803278;32477.675223247465;34500.82749586236;34946;54809.177862332894;55970;56055.71972140113;56121.71939140278;56522;315424;316716;317415;317713;318049;47220.76389618167;47432.525674742814;48417.75791121022;48716.512834871195;48790.268145978545;50141;50591.49408505868;50741.49258507515;51039.234411483114;51441.22838157356;42196;42270.57729422666;42604.14791704211;43771;43803.78098109616;42145.578544214164;42566;43268.35097473604;43342.34986475142;43559.128817424105;41496.377554336104;41683;41788.58211417847;41847.790761046;42959.78520107379;34139.65860341365;34310.48534272038;34751.826240868635;35075;35176.472352914214;26925.461490770467;27460.725392745815;27526.311842203304;27658.585121222794;27734.08650871246 11:57:57 INFO - 2016-01-21 11:57:57,696 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.6230494828514;389.2409800888268;389.5247797686822;390.8885967499263;392.0649251535088;16089;17149.914250428763;17590.472285831413;18584.628307433843;18652.90673546632;17141.82858171418;18098.00460974646;18211.817881821178;18279.54301142472;18307.633847323046;4758.643101767364;4927.630427717935;4950.653454258203;4955.182394904855;4963.379577552806;4951.3810773653295;5268.394134674523;5442.047641662713;5442.612133905848;5443.156310771837;5321.840344789663;5378.596605254602;5396.83809485716;5662;5665.915011274814;5624.915626265589;5641.887162256773;5643.8024669136585;5644.717764111778;5659.320881494205;5372.140457526816;5453.072977593779;5457.918131228034;5495.340559132889;5607.943920560824;13793.379297931617;13839.105443414786;14073.577792666236;20830.062647180912;21123.260685876074;2237.694412691813;2256.6615007748806;2325.476767727265;2347.624380099176;2507.360623041131;10412.79174416515;10428.478576071242;10493.213009024277;12256.142070055099;13461.192328460324;1848.334599544163;1858.479625704805;1870.3734249026593;1908.23670531787;1961.264525802824;63211.36788632101;66102.66948665274;66974.3302566973;67128.66435667839;68350;10511.579536818595;10834;10951.233413660968;10974.780504390028;10978.945105274423;14345.928270358581;14399.856001440061;14469.49356772508;14489.710205795825;14542.054766440147;8018.79953001168;8036.598170091472;8043.436959412902;8100.635471403801;8127.2279133482225;7864.803379915548;8007.079185893696;8022.638981245858;8023.83952320962;8042.276195142348;4617.884552886205;4651.162790697639;4726.196546587088;4749.667523273338;4829.95170048302;1914.5405102775233;2018.3743039657752;2020.8989550522415;2027.3477116150584;2035.7048228006856;946.1910066892846;953.7091187187835;958.9808203835884;1044.6552637629563;1059.0891833023593;15062.548123556311;16641.50075497737;17382.739258911126;17446.825531744773;17584.208710608054;929.9953500232456;985.0887928665956;1045.8169820281573;1081.5457507846722;1106.0484852700897;6436.935630643728;6719.126513553305;9747;10037.297389182688;10181.440020798778;663126;677469;680268;684296;694238;83025.58487207646;83101.16898830935;84570.5771471151;91725;93404.0659593409;494.0464902737751;503.57447956476716;505.0807530294828;506.40750322122466;506.50362644607753;10167.491625418552;10607.893921060691;10613;10680.679579612624;10843.024127828534;37299;38446;38486;39246.60753392544;39590.40614390844;52404;54341.72829135829;54377.728111360775;55578.44421555733;55836.16245756398;9626.518674066128;10548.894511054792;10633.149348051982;10637.893621063691;10650.147988160774;16811.7478237829;17361.392351267645;18205;18249.543761406072;18435.631287374446;15085.924570377078;15175.392984280947;15435.61410964735;15495.30271137779;15556;13910.165390076629;14247.786283205967;14532.85467145315;14601.85398146005;14977.400903963719;15374;15516.301766420313;15621.14083725406;15691.764623530427;16616.667666646357;10461.68614941553;10544.472776361305;10547.630832920811;10565.735856603646;10637.787244255227;11283.266587671775;11342.659720208407;12757.234565926074;15762.290696918437;16130.193490325202 11:57:57 INFO - 2016-01-21 11:57:57,696 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1567.4905655661912;1590.9499730178086;1834.6055598046416;1867.2997625890291;1876.540247639328;7943.285104340608;8290.502569845814;8432.620532076056;8441.07148213696;8477.91522084779;8421.873671894911;8508.319334453245;8550.95724521378;8566.528840913763;8569.65721371146;2312.3409828198924;2338.029717667166;2344.5779759643256;2344.812415006795;2347.1315613223132;2352.882355882208;2367.538330025646;2387.2599494156866;2393.0069021356117;2393.246127469841;2207.701960235364;2241.3948233976816;2244.438890277431;2308.2959697292317;2319.536092781442;2255.616545187322;2317.2932255662017;2321.7562155973633;2349.9765002349927;2352.3178278299356;2344.2498400511845;2359.9174028908906;2367.5146594948164;2377.3581133093967;2378.108209421467;8283.29591984682;8396.160383961555;8413;8416.452930559493;8431.873521897176;4906.852794416173;4958.504149585049;4976.129177393942;5000.299958005846;5025.899482010339;3139.827309497977;3156.636986746508;3199.232184275757;3211.4379983502795;3219.0825614699697;1062.1078294232805;1066.8186408310605;1073.8389241613743;1083.4636854756945;1089.1885545268826;11253.212275140744;11370.204085714004;11389.658310250707;11403.486843092081;11419.257748246337;4234.576542345741;4236;4304.698671092993;4317.956820431756;4321.2005778931;9286.117818807203;9301.34890557668;9323.393979391318;9329.44023358587;9333.673321433716;4833.9033219335415;4849.612031037508;4871.293662419001;4871.464138944713;4877.244027175793;4436.82252709888;4445.466544014739;4470.798814053375;4477.865664030084;4494.415725955605;3447.620761716209;3475.461303497962;3487.442009278503;3501.9299614007577;3537.345591065661;1039.896010398954;1050.485262221506;1051.6319288249204;1056.5140035583718;1060.4273692206277;994.4679596415883;1059.3537941855461;1233.7532493501335;1422.7439060968918;1520.9239538023055;7562.281583249583;7631.847363052708;7661.808454788675;7662.578558179353;7672.961635191788;683.4873844616537;684.750066225824;691.3294104718415;696.993030069703;830.9127541608165;6077.6353418795015;6116;6170.10533472644;6191.19514463117;6192.442680158807;9106.453612783254;9173;9409.90590094104;9413.811723765486;9550.856737148948;9187.356885018118;9302.767430814283;9303.813923721487;9355.06449355059;9399.483028433502;7098.893516597255;7169.211386747454;7187.065681461272;7205.279472052753;7264.636768161571;7229.349358557755;7246.456515761444;7273.0181425509;7287.052683151156;7316.707331706672;8142.267195952392;8299.700916161848;8377.916220837957;8383.203595658646;8497.532635705096;8566.571671416528;8567.357448191535;8674.739757807276;8692.174243446863;8785.516796575994;6747.325267473213;6847.486438517031;6887.5178737487895;6890.827729306607;6899.068625735462;7730.994970654004;7731.922680773345;7773.572453515111;7785;7794.1816109309975;7116.608586527791;7191.892121618284;7334.193238743627;7370.6314684266645;7414.703411863465;7379.446541509516;7459.776206713807;7527.059117610299;7640.044994375703;7667.156612772702;7487.925120748941;7521.811954701177;7556.546607203585;7559.1684914660445;7574.659140338808;6503.447206987459;6797.218319893078;7000.579965202104;7024.016637670832;7064.540804847874;6910.447164226749;6948.861022779617;6972.546784458994;6976.5465244758925;6980.301969802979 11:57:57 INFO - 2016-01-21 11:57:57,697 DEBUG : BROWSER_OUTPUT: |4;prototype.html;364.7884227148254;374.3766628563441;375.494959279769;375.8909916124324;380.528145100076;6445.3554644535525;6475.449586785123;6495.740170393178;6522.771702990402;6679.697458995498;6423.582467139633;6446.065320528521;6448.097266382711;6476.708548115334;6479.74081036758;4853.247746599282;4865.440474345442;4870.488598697121;4878.975605121987;4897.90204195915;4880.731559764212;4885.242787367946;4887.706737595738;4905.779239934212;4907.6073914086965;4717.1037502874515;4731.313959475874;4791.233402655575;4792.496787837262;4865.6107511399005;4746.145693775119;4751.406074240737;4759.619230461555;4761.547652972962;4767.475577686451;4150.3566947123245;4171.874843754692;4183.5398106208295;4186.058136919169;4192.266353388145;6101.145839582462;6104.267487901436;6106.603070800384;6114.327423983358;6115.143879856823;5542.612017158801;5601.663900166003;5603.8879222415735;5623.156526521014;5639.887202255932;6789.524733268673;6793.388595026471;6802.081718967926;6802.14973128359;6804.829879253059;4613.83851565197;4642.117997580449;4642.930356044662;4645.9303110453375;4656.976715116437;6802.65986700663;6964.607078584303;7025.543339682904;7034.3669069783455;7053.541519801248;4901.215805471179;4971.403431588233;4993.076280888047;4995.9508503214;5014.749262536859;5080.212567052113;5084.49155084496;5088.033273677989;5089.211172268304;5091.9236211456855;5781.5952883298605;5787.710614469344;5791.247137872049;5794.913076303858;5806.042003069446;6715.46276297895;6768.187817461936;6811.318868113149;6813.420859226922;6867.07294515244;1779.599590092219;1805.2237537858846;1806.864485163618;1809.384809164864;1812.8368446839847;1196.126827415991;1233.1429656388723;1235.5119727707686;1239.1573729863599;1239.4050855589367;6698.129243198353;6704.363085506869;6717.496187785936;6724;6726.428253598499;7098.432125429953;7140.393066589398;7141.821454463576;7159;7159.677814498256;6538.574992625464;6656.603622695826;6691.933080669229;6774.72901083961;6775.424088952395;3826.8277927492773;3873.903152421212;3880.941785873214;3884.1649045455365;3884.320243957296;7324.08448943882;7347.971284020241;7354.227806080392;7355.2277010913085;7357;7234.710611575478;7349.412047036224;7375.741849035258;7386.039814824038;7392.371648409945;7306.378957788541;7331.156916954512;7331.230220826843;7359.7056117755765;7374.262573742582;7097.680604372712;7172.820679483055;7223.061002069698;7223.602701851449;7229.168645605612;7053.188883278283;7072.9646351767915;7090.574565526085;7108.893366599608;7120.1099862517185;7201.891971620535;7273;7300.817479563053;7348.448866334939;7350.779476615497;4739.786709598007;4803.807847686054;4825.30033145199;4836.105320515716;4857.854264372075;7169.103862017248;7183.640817959185;7202.207757146814;7212.062431884031;7212.170600381023;6992.405645520188;6992.650367481708;6999.440044796303;7003.719851205895;7012.403945664676;6842.521023528504;6904.896426553706;6979.965100174467;6982.546134501241;6997.370236678723;6807.9319206807295;6854.417374523022;6863.245043045161;6865.313468653095;6866.450683945172;6976.825579360557;6978.965105174441;7018.789436316919;7033.648317583998;7042.718291268292;6628.337166283333;6825.146856642919;6833.58998460094;6838.213605435439;6902.8619427612175 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: |5;yui.html;784.3529088501987;787.2127872127869;805.4804651000109;938.9999650372353;950.2445555783154;14580.56258312251;14629.268536573181;14663.633409164762;14698.779518307221;14714.264286785672;13766.862331376684;13851.238181900017;13857.584272471817;13877;13885.722285554308;751.6730222353267;770.410635863562;897.8653202019684;919.3013309884469;926.8609708543705;920.5213289089669;921.0421161991554;925.5742358515057;927.0451435021938;928.2434815625244;969.2633598465181;971.1502435369052;975.8828940527111;977.6480467031863;978.0561757903622;957.530809903146;958.8993155718618;960.4861399151421;961;963.373807025432;720.8918662200659;721.2282857342645;723.023917711091;725.6952080126307;727.2182403915812;14116.435342586285;14264.072835265675;14273.857261427356;14298.928505357511;14354.354054067488;12670.873291267062;12691.238525688488;13009.34953252343;13211.471541138342;13375.531856385078;10800.405977671226;10914.617988370448;10916.617918372818;10996;11987.820182697267;3901.960980390188;3956.1296514766705;3977.8209980550946;3994.7802870842384;4062.7968601569805;49347.50652493465;49664;49817.75091124521;49910.75044624753;51472.74263628695;11026.558937642565;11088.55645774176;11168.497417616065;11232.269902456314;11471.139664525193;18752.249910003447;18882.339118131073;19160.80839191618;19189.32837350686;19193.32823351176;8115.431919765678;8300.750977470685;8321.459105158145;8332.5000499969;8469.957650211709;4838.7338696371335;4889.584385327287;4949.727764972889;5000.199968005102;5045.369328833895;3205.7114859662743;3230.80615163091;3235.8705651774135;3246.6753324667343;3247.3342964692656;567.0558520064129;568.9203511508392;575.4245754245754;576.4811669497486;587;590.9793157239476;707.7947395255318;733.9926600734032;735.1472292141091;751.2825251884437;9008.954955225314;9076.455412675261;9182.816343673223;9209.21721653667;9540.093691099335;624.6782906803;714.989275160873;735.8565079809492;776.65050727173;791.4697152907565;4102.630763231324;4154.252234597741;4276.679249056333;4342.761148136883;4445.177642136216;58013.70993145092;58681;58929.41070589325;59082.70458647679;59108;52592.73703631534;52839.471605283456;53456.46543534593;53886.19170712364;54040.729796350766;47171.29243061357;47884.5211547887;48286;48567;48875.511244887806;8322.958385208036;8557.700480483154;8705.173008564176;9091.181793638605;9871.605135794774;35454;35569.28861422809;36368;36456.27087458183;36548.08629784277;47622.76188619035;48190.27714584354;48560.757196213795;48582;48695;12572.434240459384;12736.554220602235;12772.425240863997;12823.294718790556;12962.740745184854;12118.909298163207;12150.331731754839;12532.310722910328;12799.360031998176;12819.102662813886;12212.816807747713;12422.937885310515;12492.750144997231;12546.686332841751;13009.02432317561;12047.759044818878;12116;12169.878301216875;12193.451294691937;12344.321062341658;10914.035473614826;11296.774064518828;11498;12022.33877136731;12466;10128.848067279145;10498.486798622574;10611.363318200623;10618.787624247627;10876.564937402416;10623.628173013907;10738.463076846283;10814.188935830001;10946.17903657213;10991.230613856953 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406277690__endTimestamp 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,699 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:57:57 INFO - 2016-01-21 11:57:57,700 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:57:57 INFO - 2016-01-21 11:57:57,700 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,700 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5489.11 Median:5719.49 stddev:611.45 (10.7%) stddev-sans-first:588.06 11:57:57 INFO - 2016-01-21 11:57:57,700 DEBUG : BROWSER_OUTPUT: Values: 3271.8 3294.8 3326.1 3339.5 3344.0 5405.6 5433.0 5474.9 5489.1 5498.5 5424.2 5464.2 5473.6 5475.8 5508.1 4974.9 5021.1 5048.7 5062.9 5082.8 4840.9 5002.8 5037.5 5045.6 5115.0 4988.3 5056.1 5065.8 5065.9 5116.0 5089.9 5164.9 5171.7 5185.4 5207.9 4799.4 4882.7 4899.0 5061.9 5079.3 5279.6 5300.5 5339.5 5370.9 5374.2 5959.9 5991.9 6022.8 6027.3 6035.6 5797.8 5909.8 5921.9 5999.4 6024.2 5555.3 5558.9 5566.9 5568.1 5571.8 5940.0 5944.6 5954.9 5963.3 5972.2 5746.1 5764.3 5807.3 5857.0 5864.7 5841.0 5886.3 5898.7 5919.1 5959.9 5719.5 5888.1 5889.9 5923.1 5928.2 5847.5 5870.9 5891.9 5952.5 5963.7 4476.9 4480.1 4489.6 4500.2 4527.8 3908.8 4035.0 4042.1 4044.5 4051.4 5453.0 5511.6 5538.9 5542.6 5545.8 5991.4 5993.6 6030.7 6050.0 6052.4 5483.4 5592.3 5602.3 5708.1 5741.1 5098.4 5143.7 5147.9 5170.2 5216.7 5974.2 6059.1 6092.5 6095.5 6095.8 5783.2 5924.7 6005.8 6026.3 6026.9 5891.8 6054.2 6078.3 6084.5 6116.0 5830.2 5877.3 5880.2 5885.6 5900.2 5791.0 5840.9 5873.9 5957.7 5985.7 5820.5 5851.4 5854.2 5855.3 5860.2 5781.1 5789.3 5790.5 5834.0 5846.6 5454.2 5518.6 5629.0 5706.2 5721.4 5744.7 5747.9 5791.9 5794.9 5839.7 5678.6 5694.8 5696.7 5715.7 5723.2 11:57:57 INFO - 2016-01-21 11:57:57,701 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,701 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:63266.84 Median:42585.07 stddev:136445.43 (320.4%) stddev-sans-first:136746.94 11:57:57 INFO - 2016-01-21 11:57:57,701 DEBUG : BROWSER_OUTPUT: Values: 550.4 587.0 590.4 639.1 651.3 32528.2 33145.5 40648.0 41236.8 41309.6 46093.3 46364.3 46626.8 46640.3 46700.1 8910.9 9047.7 9090.5 9120.2 9139.8 8931.2 8961.9 9042.1 9042.8 9062.3 9020.1 9062.5 9064.4 9110.2 9123.0 8996.5 9048.4 9077.7 9092.5 9098.7 8919.7 9037.0 9077.2 9080.3 9113.1 43029.0 43292.1 43432.3 43462.0 43774.1 3689.8 3734.4 3754.9 3919.3 4209.7 36127.6 36309.6 36382.6 36640.6 36684.0 4048.4 4156.8 4165.5 4189.1 4251.2 291032.0 297331.0 299531.5 299681.0 301718.0 49334.3 51741.7 69615.3 70735.6 71088.3 73642.6 74024.0 74186.0 74252.0 74485.6 16411.8 16425.7 16453.3 16558.5 16658.8 12407.3 12457.4 12486.1 12514.4 12516.7 23073.2 23506.5 23563.3 23879.0 23884.9 9200.8 9399.6 9514.8 9577.4 9580.4 966.8 972.9 1088.8 1088.8 1093.0 28159.2 28445.7 28753.3 29290.3 29366.3 1089.9 1090.7 1092.4 1204.0 1204.3 15500.0 15593.8 15610.5 17648.0 17929.8 600955.0 748752.0 761098.0 839263.0 839747.0 60725.4 61128.0 61485.4 61534.4 61760.1 1460.1 1465.6 1482.7 1511.3 1513.3 31337.8 32007.4 32477.7 34500.8 34946.0 54809.2 55970.0 56055.7 56121.7 56522.0 315424.0 316716.0 317415.0 317713.0 318049.0 47220.8 47432.5 48417.8 48716.5 48790.3 50141.0 50591.5 50741.5 51039.2 51441.2 42196.0 42270.6 42604.1 43771.0 43803.8 42145.6 42566.0 43268.4 43342.3 43559.1 41496.4 41683.0 41788.6 41847.8 42959.8 34139.7 34310.5 34751.8 35075.0 35176.5 26925.5 27460.7 27526.3 27658.6 27734.1 11:57:57 INFO - 2016-01-21 11:57:57,701 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,702 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33504.43 Median:11680.48 stddev:111114.36 (951.3%) stddev-sans-first:111398.23 11:57:57 INFO - 2016-01-21 11:57:57,703 DEBUG : BROWSER_OUTPUT: Values: 384.6 389.2 389.5 390.9 392.1 16089.0 17149.9 17590.5 18584.6 18652.9 17141.8 18098.0 18211.8 18279.5 18307.6 4758.6 4927.6 4950.7 4955.2 4963.4 4951.4 5268.4 5442.0 5442.6 5443.2 5321.8 5378.6 5396.8 5662.0 5665.9 5624.9 5641.9 5643.8 5644.7 5659.3 5372.1 5453.1 5457.9 5495.3 5607.9 13793.4 13839.1 14073.6 20830.1 21123.3 2237.7 2256.7 2325.5 2347.6 2507.4 10412.8 10428.5 10493.2 12256.1 13461.2 1848.3 1858.5 1870.4 1908.2 1961.3 63211.4 66102.7 66974.3 67128.7 68350.0 10511.6 10834.0 10951.2 10974.8 10978.9 14345.9 14399.9 14469.5 14489.7 14542.1 8018.8 8036.6 8043.4 8100.6 8127.2 7864.8 8007.1 8022.6 8023.8 8042.3 4617.9 4651.2 4726.2 4749.7 4830.0 1914.5 2018.4 2020.9 2027.3 2035.7 946.2 953.7 959.0 1044.7 1059.1 15062.5 16641.5 17382.7 17446.8 17584.2 930.0 985.1 1045.8 1081.5 1106.0 6436.9 6719.1 9747.0 10037.3 10181.4 663126.0 677469.0 680268.0 684296.0 694238.0 83025.6 83101.2 84570.6 91725.0 93404.1 494.0 503.6 505.1 506.4 506.5 10167.5 10607.9 10613.0 10680.7 10843.0 37299.0 38446.0 38486.0 39246.6 39590.4 52404.0 54341.7 54377.7 55578.4 55836.2 9626.5 10548.9 10633.1 10637.9 10650.1 16811.7 17361.4 18205.0 18249.5 18435.6 15085.9 15175.4 15435.6 15495.3 15556.0 13910.2 14247.8 14532.9 14601.9 14977.4 15374.0 15516.3 15621.1 15691.8 16616.7 10461.7 10544.5 10547.6 10565.7 10637.8 11283.3 11342.7 12757.2 15762.3 16130.2 11:57:57 INFO - 2016-01-21 11:57:57,703 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,704 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5649.06 Median:6889.17 stddev:2950.81 (42.8%) stddev-sans-first:2943.14 11:57:57 INFO - 2016-01-21 11:57:57,705 DEBUG : BROWSER_OUTPUT: Values: 1567.5 1590.9 1834.6 1867.3 1876.5 7943.3 8290.5 8432.6 8441.1 8477.9 8421.9 8508.3 8551.0 8566.5 8569.7 2312.3 2338.0 2344.6 2344.8 2347.1 2352.9 2367.5 2387.3 2393.0 2393.2 2207.7 2241.4 2244.4 2308.3 2319.5 2255.6 2317.3 2321.8 2350.0 2352.3 2344.2 2359.9 2367.5 2377.4 2378.1 8283.3 8396.2 8413.0 8416.5 8431.9 4906.9 4958.5 4976.1 5000.3 5025.9 3139.8 3156.6 3199.2 3211.4 3219.1 1062.1 1066.8 1073.8 1083.5 1089.2 11253.2 11370.2 11389.7 11403.5 11419.3 4234.6 4236.0 4304.7 4318.0 4321.2 9286.1 9301.3 9323.4 9329.4 9333.7 4833.9 4849.6 4871.3 4871.5 4877.2 4436.8 4445.5 4470.8 4477.9 4494.4 3447.6 3475.5 3487.4 3501.9 3537.3 1039.9 1050.5 1051.6 1056.5 1060.4 994.5 1059.4 1233.8 1422.7 1520.9 7562.3 7631.8 7661.8 7662.6 7673.0 683.5 684.8 691.3 697.0 830.9 6077.6 6116.0 6170.1 6191.2 6192.4 9106.5 9173.0 9409.9 9413.8 9550.9 9187.4 9302.8 9303.8 9355.1 9399.5 7098.9 7169.2 7187.1 7205.3 7264.6 7229.3 7246.5 7273.0 7287.1 7316.7 8142.3 8299.7 8377.9 8383.2 8497.5 8566.6 8567.4 8674.7 8692.2 8785.5 6747.3 6847.5 6887.5 6890.8 6899.1 7731.0 7731.9 7773.6 7785.0 7794.2 7116.6 7191.9 7334.2 7370.6 7414.7 7379.4 7459.8 7527.1 7640.0 7667.2 7487.9 7521.8 7556.5 7559.2 7574.7 6503.4 6797.2 7000.6 7024.0 7064.5 6910.4 6948.9 6972.5 6976.5 6980.3 11:57:57 INFO - 2016-01-21 11:57:57,705 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,706 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5757.71 Median:6642.47 stddev:1745.91 (26.3%) stddev-sans-first:1703.24 11:57:57 INFO - 2016-01-21 11:57:57,707 DEBUG : BROWSER_OUTPUT: Values: 364.8 374.4 375.5 375.9 380.5 6445.4 6475.4 6495.7 6522.8 6679.7 6423.6 6446.1 6448.1 6476.7 6479.7 4853.2 4865.4 4870.5 4879.0 4897.9 4880.7 4885.2 4887.7 4905.8 4907.6 4717.1 4731.3 4791.2 4792.5 4865.6 4746.1 4751.4 4759.6 4761.5 4767.5 4150.4 4171.9 4183.5 4186.1 4192.3 6101.1 6104.3 6106.6 6114.3 6115.1 5542.6 5601.7 5603.9 5623.2 5639.9 6789.5 6793.4 6802.1 6802.1 6804.8 4613.8 4642.1 4642.9 4645.9 4657.0 6802.7 6964.6 7025.5 7034.4 7053.5 4901.2 4971.4 4993.1 4996.0 5014.7 5080.2 5084.5 5088.0 5089.2 5091.9 5781.6 5787.7 5791.2 5794.9 5806.0 6715.5 6768.2 6811.3 6813.4 6867.1 1779.6 1805.2 1806.9 1809.4 1812.8 1196.1 1233.1 1235.5 1239.2 1239.4 6698.1 6704.4 6717.5 6724.0 6726.4 7098.4 7140.4 7141.8 7159.0 7159.7 6538.6 6656.6 6691.9 6774.7 6775.4 3826.8 3873.9 3880.9 3884.2 3884.3 7324.1 7348.0 7354.2 7355.2 7357.0 7234.7 7349.4 7375.7 7386.0 7392.4 7306.4 7331.2 7331.2 7359.7 7374.3 7097.7 7172.8 7223.1 7223.6 7229.2 7053.2 7073.0 7090.6 7108.9 7120.1 7201.9 7273.0 7300.8 7348.4 7350.8 4739.8 4803.8 4825.3 4836.1 4857.9 7169.1 7183.6 7202.2 7212.1 7212.2 6992.4 6992.7 6999.4 7003.7 7012.4 6842.5 6904.9 6980.0 6982.5 6997.4 6807.9 6854.4 6863.2 6865.3 6866.5 6976.8 6979.0 7018.8 7033.6 7042.7 6628.3 6825.1 6833.6 6838.2 6902.9 11:57:57 INFO - 2016-01-21 11:57:57,707 DEBUG : BROWSER_OUTPUT: 11:57:57 INFO - 2016-01-21 11:57:57,707 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14582.38 Median:47397.03 stddev:16541.72 (34.9%) stddev-sans-first:16555.67 11:57:57 INFO - 2016-01-21 11:57:57,709 DEBUG : BROWSER_OUTPUT: Values: 784.4 787.2 805.5 939.0 950.2 14580.6 14629.3 14663.6 14698.8 14714.3 13766.9 13851.2 13857.6 13877.0 13885.7 751.7 770.4 897.9 919.3 926.9 920.5 921.0 925.6 927.0 928.2 969.3 971.2 975.9 977.6 978.1 957.5 958.9 960.5 961.0 963.4 720.9 721.2 723.0 725.7 727.2 14116.4 14264.1 14273.9 14298.9 14354.4 12670.9 12691.2 13009.3 13211.5 13375.5 10800.4 10914.6 10916.6 10996.0 11987.8 3902.0 3956.1 3977.8 3994.8 4062.8 49347.5 49664.0 49817.8 49910.8 51472.7 11026.6 11088.6 11168.5 11232.3 11471.1 18752.2 18882.3 19160.8 19189.3 19193.3 8115.4 8300.8 8321.5 8332.5 8470.0 4838.7 4889.6 4949.7 5000.2 5045.4 3205.7 3230.8 3235.9 3246.7 3247.3 567.1 568.9 575.4 576.5 587.0 591.0 707.8 734.0 735.1 751.3 9009.0 9076.5 9182.8 9209.2 9540.1 624.7 715.0 735.9 776.7 791.5 4102.6 4154.3 4276.7 4342.8 4445.2 58013.7 58681.0 58929.4 59082.7 59108.0 52592.7 52839.5 53456.5 53886.2 54040.7 47171.3 47884.5 48286.0 48567.0 48875.5 8323.0 8557.7 8705.2 9091.2 9871.6 35454.0 35569.3 36368.0 36456.3 36548.1 47622.8 48190.3 48560.8 48582.0 48695.0 12572.4 12736.6 12772.4 12823.3 12962.7 12118.9 12150.3 12532.3 12799.4 12819.1 12212.8 12422.9 12492.8 12546.7 13009.0 12047.8 12116.0 12169.9 12193.5 12344.3 10914.0 11296.8 11498.0 12022.3 12466.0 10128.8 10498.5 10611.4 10618.8 10876.6 10623.6 10738.5 10814.2 10946.2 10991.2 11:57:57 INFO - 2016-01-21 11:57:57,709 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:57:57 INFO - 2016-01-21 11:57:57,709 DEBUG : BROWSER_OUTPUT: 11:57:58 INFO - 2016-01-21 11:57:58,346 INFO : Browser exited with error code: 0 11:57:58 INFO - 2016-01-21 11:57:58,362 INFO : Completed test dromaeo_css (00:18:27) 11:57:58 INFO - 2016-01-21 11:57:58,362 INFO : Starting test kraken 11:57:58 INFO - 2016-01-21 11:57:58,362 DEBUG : operating with platform_type : linux_ 11:57:58 INFO - 2016-01-21 11:57:58,362 INFO : Initialising browser for kraken test... 11:57:58 INFO - 2016-01-21 11:57:58,368 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph2SKqg/profile http://localhost:36016/getInfo.html 11:58:01 INFO - 2016-01-21 11:58:01,479 DEBUG : BROWSER_OUTPUT: 11:58:01 INFO - 2016-01-21 11:58:01,479 DEBUG : BROWSER_OUTPUT: (process:19872): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:58:02 INFO - 2016-01-21 11:58:02,220 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:58:02 INFO - 2016-01-21 11:58:02,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:58:02 INFO - 2016-01-21 11:58:02,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:58:02 INFO - 2016-01-21 11:58:02,220 DEBUG : BROWSER_OUTPUT: __metrics 11:58:03 INFO - 2016-01-21 11:58:03,149 INFO : Browser initialized. 11:58:03 INFO - 2016-01-21 11:58:03,150 INFO : Running cycle 1/1 for kraken test... 11:58:03 INFO - 2016-01-21 11:58:03,150 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph2SKqg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:58:04 INFO - 2016-01-21 11:58:04,448 DEBUG : BROWSER_OUTPUT: 11:58:04 INFO - 2016-01-21 11:58:04,448 DEBUG : BROWSER_OUTPUT: (process:19987): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:58:14 INFO - 2016-01-21 11:58:14,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 136810496 11:58:14 INFO - 2016-01-21 11:58:14,957 DEBUG : BROWSER_OUTPUT: 11:58:17 INFO - 2016-01-21 11:58:17,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36016/tests/kraken/driver.html?testName=audio-beat-detection) 11:58:18 INFO - 2016-01-21 11:58:18,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 137719808 11:58:18 INFO - 2016-01-21 11:58:18,019 DEBUG : BROWSER_OUTPUT: 11:58:20 INFO - 2016-01-21 11:58:20,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36016/tests/kraken/driver.html?testName=audio-dft) 11:58:21 INFO - 2016-01-21 11:58:21,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 11:58:21 INFO - 2016-01-21 11:58:21,230 DEBUG : BROWSER_OUTPUT: 11:58:24 INFO - 2016-01-21 11:58:24,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36016/tests/kraken/driver.html?testName=audio-fft) 11:58:24 INFO - 2016-01-21 11:58:24,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 137998336 11:58:24 INFO - 2016-01-21 11:58:24,641 DEBUG : BROWSER_OUTPUT: 11:58:26 INFO - 2016-01-21 11:58:26,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36016/tests/kraken/driver.html?testName=audio-oscillator) 11:58:27 INFO - 2016-01-21 11:58:27,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 137748480 11:58:27 INFO - 2016-01-21 11:58:27,247 DEBUG : BROWSER_OUTPUT: 11:58:29 INFO - 2016-01-21 11:58:29,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36016/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:30 INFO - 2016-01-21 11:58:30,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 137801728 11:58:30 INFO - 2016-01-21 11:58:30,009 DEBUG : BROWSER_OUTPUT: 11:58:32 INFO - 2016-01-21 11:58:32,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36016/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:33 INFO - 2016-01-21 11:58:33,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 11:58:33 INFO - 2016-01-21 11:58:33,491 DEBUG : BROWSER_OUTPUT: 11:58:36 INFO - 2016-01-21 11:58:36,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36016/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:37 INFO - 2016-01-21 11:58:37,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 137957376 11:58:37 INFO - 2016-01-21 11:58:37,419 DEBUG : BROWSER_OUTPUT: 11:58:40 INFO - 2016-01-21 11:58:40,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36016/tests/kraken/driver.html?testName=json-parse-financial) 11:58:40 INFO - 2016-01-21 11:58:40,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 138493952 11:58:40 INFO - 2016-01-21 11:58:40,781 DEBUG : BROWSER_OUTPUT: 11:58:42 INFO - 2016-01-21 11:58:42,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36016/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:42 INFO - 2016-01-21 11:58:42,917 DEBUG : BROWSER_OUTPUT: RSS: Main: 138248192 11:58:42 INFO - 2016-01-21 11:58:42,918 DEBUG : BROWSER_OUTPUT: 11:58:44 INFO - 2016-01-21 11:58:44,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:45 INFO - 2016-01-21 11:58:45,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 11:58:45 INFO - 2016-01-21 11:58:45,295 DEBUG : BROWSER_OUTPUT: 11:58:47 INFO - 2016-01-21 11:58:47,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:47 INFO - 2016-01-21 11:58:47,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 138469376 11:58:47 INFO - 2016-01-21 11:58:47,935 DEBUG : BROWSER_OUTPUT: 11:58:50 INFO - 2016-01-21 11:58:50,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:50 INFO - 2016-01-21 11:58:50,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 11:58:50 INFO - 2016-01-21 11:58:50,956 DEBUG : BROWSER_OUTPUT: 11:58:53 INFO - 2016-01-21 11:58:53,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:54 INFO - 2016-01-21 11:58:54,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 11:58:54 INFO - 2016-01-21 11:58:54,086 DEBUG : BROWSER_OUTPUT: 11:58:55 INFO - 2016-01-21 11:58:55,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36016/tests/kraken/driver.html?testName=ai-astar) 11:58:56 INFO - 2016-01-21 11:58:56,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 140075008 11:58:56 INFO - 2016-01-21 11:58:56,020 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,024 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:58:56 INFO - 2016-01-21 11:58:56,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:58:56 INFO - 2016-01-21 11:58:56,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:58:56 INFO - 2016-01-21 11:58:56,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:58:56 INFO - 2016-01-21 11:58:56,024 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;103;111;110;110;123;111;111;112;111 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;125;152;155;127;154;154;125;159;126 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;160;162;162;161;160;164;163 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |3;audio-fft;79;70;72;161;72;73;73;73;163;72 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;138;92;93;93;133;91;93;134 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;110;109;110;110 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;148;146;146;147;147;147;150;146 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;96;96;96;97;96 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;62;63;60;60;61;60;60;57 11:58:56 INFO - 2016-01-21 11:58:56,025 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;65;64;65;64;65;64;64 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;81;83;90;83;82;81;82;82;89 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;116;123;114;121;115;121;119;136;118 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;146;146;152;147;155;140;145;145;146 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;69;69;76;68;65;67;67;67 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,711 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406336022__endTimestamp 11:58:56 INFO - 2016-01-21 11:58:56,026 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.85 (4.4%) stddev-sans-first:5.12 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: Values: 110.0 103.0 111.0 110.0 110.0 123.0 111.0 111.0 112.0 111.0 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:153.00 stddev:14.83 (9.7%) stddev-sans-first:15.43 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: Values: 151.0 125.0 152.0 155.0 127.0 154.0 154.0 125.0 159.0 126.0 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 160.0 162.0 162.0 161.0 160.0 164.0 163.0 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,030 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.80 Median:72.50 stddev:37.60 (51.9%) stddev-sans-first:39.64 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: Values: 79.0 70.0 72.0 161.0 72.0 73.0 73.0 73.0 163.0 72.0 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:92.00 stddev:20.68 (22.5%) stddev-sans-first:21.38 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 138.0 92.0 93.0 93.0 133.0 91.0 93.0 134.0 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 148.0 146.0 146.0 147.0 147.0 147.0 150.0 146.0 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:58:56 INFO - 2016-01-21 11:58:56,031 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 96.0 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:1.62 (2.7%) stddev-sans-first:1.66 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 62.0 63.0 60.0 60.0 61.0 60.0 60.0 57.0 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 65.0 64.0 65.0 64.0 65.0 64.0 64.0 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.40 (4.1%) stddev-sans-first:3.39 11:58:56 INFO - 2016-01-21 11:58:56,032 DEBUG : BROWSER_OUTPUT: Values: 80.0 81.0 83.0 90.0 83.0 82.0 81.0 82.0 82.0 89.0 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.00 stddev:6.47 (5.3%) stddev-sans-first:6.60 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: Values: 126.0 116.0 123.0 114.0 121.0 115.0 121.0 119.0 136.0 118.0 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:146.00 stddev:4.11 (2.8%) stddev-sans-first:4.31 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 152.0 147.0 155.0 140.0 145.0 145.0 146.0 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.95 (4.3%) stddev-sans-first:3.09 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 69.0 76.0 68.0 65.0 67.0 67.0 67.0 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:58:56 INFO - 2016-01-21 11:58:56,033 DEBUG : BROWSER_OUTPUT: 11:58:56 INFO - 2016-01-21 11:58:56,842 INFO : Browser exited with error code: 0 11:58:56 INFO - 2016-01-21 11:58:56,892 INFO : Completed test kraken (00:00:58) 11:58:56 INFO - 2016-01-21 11:58:56,892 INFO : Starting test v8_7 11:58:56 INFO - 2016-01-21 11:58:56,892 DEBUG : operating with platform_type : linux_ 11:58:56 INFO - 2016-01-21 11:58:56,893 INFO : Initialising browser for v8_7 test... 11:58:56 INFO - 2016-01-21 11:58:56,899 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCrDauo/profile http://localhost:36016/getInfo.html 11:59:00 INFO - 2016-01-21 11:59:00,202 DEBUG : BROWSER_OUTPUT: 11:59:00 INFO - 2016-01-21 11:59:00,203 DEBUG : BROWSER_OUTPUT: (process:20295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:59:00 INFO - 2016-01-21 11:59:00,909 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:59:00 INFO - 2016-01-21 11:59:00,909 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:59:00 INFO - 2016-01-21 11:59:00,910 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:59:00 INFO - 2016-01-21 11:59:00,910 DEBUG : BROWSER_OUTPUT: __metrics 11:59:01 INFO - 2016-01-21 11:59:01,785 INFO : Browser initialized. 11:59:01 INFO - 2016-01-21 11:59:01,786 INFO : Running cycle 1/1 for v8_7 test... 11:59:01 INFO - 2016-01-21 11:59:01,786 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCrDauo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:59:03 INFO - 2016-01-21 11:59:03,058 DEBUG : BROWSER_OUTPUT: 11:59:03 INFO - 2016-01-21 11:59:03,058 DEBUG : BROWSER_OUTPUT: (process:20411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:59:13 INFO - 2016-01-21 11:59:13,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 136581120 11:59:13 INFO - 2016-01-21 11:59:13,562 DEBUG : BROWSER_OUTPUT: 11:59:34 INFO - 2016-01-21 11:59:34,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36016/tests/v8_7/run.html (next: http://localhost:36016/tests/v8_7/run.html) 11:59:35 INFO - 2016-01-21 11:59:35,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 135036928 11:59:35 INFO - 2016-01-21 11:59:35,155 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,155 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:59:35 INFO - 2016-01-21 11:59:35,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: |0;Richards;166.77785190126752 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.55085039916696 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 11:59:35 INFO - 2016-01-21 11:59:35,156 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |5;Earley;545.5537370430987 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |6;Boyer;11065.934065934065 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |8;Splay;520.0208008320333 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:59:35 INFO - 2016-01-21 11:59:35,157 DEBUG : BROWSER_OUTPUT: __startTimestamp1453406375154__endTimestamp 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: Values: 166.8 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.55 Median:173.55 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: Values: 173.6 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,158 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: Values: 5148.7 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: Values: 949.7 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:545.55 Median:545.55 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: Values: 545.6 11:59:35 INFO - 2016-01-21 11:59:35,159 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11065.93 Median:11065.93 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: Values: 11065.9 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: Values: 24238.1 11:59:35 INFO - 2016-01-21 11:59:35,160 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:520.02 Median:520.02 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: Values: 520.0 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:59:35 INFO - 2016-01-21 11:59:35,161 DEBUG : BROWSER_OUTPUT: 11:59:35 INFO - 2016-01-21 11:59:35,982 INFO : Browser exited with error code: 0 11:59:36 INFO - 2016-01-21 11:59:36,000 INFO : Completed test v8_7 (00:00:39) 11:59:36 INFO - 2016-01-21 11:59:36,212 INFO : Completed test suite (00:20:05) 11:59:36 INFO - 2016-01-21 11:59:36,213 DEBUG : Working with test: dromaeo_css 11:59:36 INFO - 2016-01-21 11:59:36,213 DEBUG : Generating results file: dromaeo_css 11:59:36 INFO - 2016-01-21 11:59:36,214 DEBUG : Working with test: kraken 11:59:36 INFO - 2016-01-21 11:59:36,214 DEBUG : Generating results file: kraken 11:59:36 INFO - 2016-01-21 11:59:36,214 INFO : javascript benchmark 11:59:36 INFO - 2016-01-21 11:59:36,214 DEBUG : Working with test: v8_7 11:59:36 INFO - 2016-01-21 11:59:36,215 DEBUG : Generating results file: v8_7 11:59:36 INFO - 2016-01-21 11:59:36,215 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:59:36 INFO - 2016-01-21 11:59:36,279 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:59:36 INFO - 2016-01-21 11:59:36,280 DEBUG : process_Request line: dromaeo_css 7429.46 graph.html#tests=[[72,52,43]] 11:59:36 INFO - 2016-01-21 11:59:36,280 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:59:36 INFO - 2016-01-21 11:59:36,314 DEBUG : process_Request line: kraken 1507.90 graph.html#tests=[[232,52,43]] 11:59:36 INFO - 2016-01-21 11:59:36,314 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:59:36 INFO - 2016-01-21 11:59:36,343 DEBUG : process_Request line: v8_7 23075.39 graph.html#tests=[[230,52,43]] 11:59:36 INFO - 2016-01-21 11:59:36,344 INFO : javascript benchmark 11:59:36 INFO - 2016-01-21 11:59:36,348 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.820049897256, 3294.802311861287, 3326.1185785766793, 3339.4656854903205, 3344.046946620214, 5405.6216064875425, 5433.022056029918, 5474.91787623186, 5489.066858634032, 5498.505134537891, 5424.16772490725, 5464.23500709901, 5473.616846820724, 5475.780968761254, 5508.063629183039, 4974.925376119361, 5021.07110184617, 5048.7223202723835, 5062.936783275498, 5082.847514574569, 4840.903181936359, 5002.774875130628, 5037.4710655381205, 5045.571126454256, 5115.0, 4988.301637770715, 5056.140456122468, 5065.848024559269, 5065.949340506585, 5116.027954688616, 5089.923651145235, 5164.870878228036, 5171.663841850268, 5185.429602743695, 5207.9479205207845, 4799.448063472711, 4882.682625629358, 4898.975505122487, 5061.873453163664, 5079.31429257053, 5279.577633789326, 5300.496452836975, 5339.5461385782255, 5370.91943620846, 5374.220737993008, 5959.880802383971, 5991.850203744898, 6022.8494287642725, 6027.336992930774, 6035.637861728311, 5797.797077102281, 5909.7636094556165, 5921.8815623687715, 5999.370066143079, 6024.186734790791, 5555.2500412444615, 5558.888822223533, 5566.888662226774, 5568.1091025435735, 5571.777128914839, 5940.049592065248, 5944.613600115978, 5954.8809023819285, 5963.254593175853, 5972.223610930638, 5746.080627099644, 5764.279465066867, 5807.303123625192, 5856.970715146397, 5864.70676466175, 5840.970795145997, 5886.3230728465915, 5898.705064746746, 5919.052951527735, 5959.851003724855, 5719.4852463277675, 5888.116782482576, 5889.880922624688, 5923.08192230205, 5928.199693041384, 5847.473727364472, 5870.853228669317, 5891.911621325684, 5952.523798096142, 5963.671998040149, 4476.865694029184, 4480.081583275421, 4489.551044895485, 4500.167469018242, 4527.796249168795, 3908.8241029153755, 4034.9596504034585, 4042.130941847458, 4044.4742183515955, 4051.3922911562913, 5452.972735136299, 5511.641743286674, 5538.944610553843, 5542.639728417721, 5545.833624991256, 5991.400859913973, 5993.550483713739, 6030.728617212236, 6050.0, 6052.394760523913, 5483.396826349178, 5592.3009623797025, 5602.2717046783655, 5708.143778433186, 5741.081426971665, 5098.388193416739, 5143.71709555978, 5147.897042059138, 5170.224466330081, 5216.686998780086, 5974.163617093611, 6059.0608455689435, 6092.45167934888, 6095.451409373178, 6095.756169753249, 5783.19035335045, 5924.733386997509, 6005.759769609254, 6026.306974697965, 6026.90959635597, 5891.823245302648, 6054.212952316171, 6078.331383547717, 6084.543659225487, 6116.0, 5830.2129212555765, 5877.265341832271, 5880.206172166874, 5885.558583106199, 5900.232969713909, 5790.971045144747, 5840.853978650568, 5873.94126058751, 5957.731902064331, 5985.670788106696, 5820.505257053198, 5851.414858514285, 5854.151148083589, 5855.297364316139, 5860.238169037998, 5781.132830075522, 5789.2763404574425, 5790.507806836466, 5834.03738383162, 5846.619969702126, 5454.2091396746455, 5518.586106042143, 5629.014922388647, 5706.172604972173, 5721.370649228498, 5744.655320680772, 5747.885042299215, 5791.913121303268, 5794.855128621818, 5839.678817664899, 5678.602497825113, 5694.772209111755, 5696.715164241854, 5715.685637289989, 5723.227364305765], "unit": "ms", "name": "dojo.html", "value": 5449.264362089753}, {"lowerIsBetter": false, "replicates": [550.3710176553227, 587.0372588954115, 590.3830497130497, 639.1307821362949, 651.3063587279544, 32528.18679533013, 33145.50281745776, 40648.0, 41236.79381603095, 41309.58690413102, 46093.30860037094, 46364.304535432, 46626.76686616571, 46640.300395494094, 46700.06599868001, 8910.866337004934, 9047.728568142966, 9090.54547272637, 9120.17918387345, 9139.817203655923, 8931.24084452819, 8961.865572016424, 9042.095790420972, 9042.773930651754, 9062.320325975545, 9020.143086406813, 9062.501562414065, 9064.365494415393, 9110.180083792457, 9122.954385228064, 8996.505192214425, 9048.366614337, 9077.682281120162, 9092.545192769192, 9098.727038188865, 8919.73240802777, 9036.954815225947, 9077.228435582983, 9080.31897607682, 9113.134252246093, 43029.0, 43292.13415731699, 43432.348514772304, 43462.0, 43774.124517509474, 3689.760165589228, 3734.3651579231323, 3754.9249015019545, 3919.314120029012, 4209.705320627558, 36127.63872361269, 36309.63690363115, 36382.63617363819, 36640.63359366399, 36684.0, 4048.3725022621247, 4156.8129434175535, 4165.541790403053, 4189.099343641132, 4251.171021650779, 291032.0, 297331.0, 299531.5023424891, 299681.0, 301718.0, 49334.25998610024, 51741.7412912933, 69615.30384696089, 70735.64632176909, 71088.2891171092, 73642.63178684072, 74024.0, 74186.0, 74252.0, 74485.6275718618, 16411.753823692656, 16425.6714865702, 16453.259603317878, 16558.503244902673, 16658.83341166597, 12407.25556466615, 12457.377131143407, 12486.12597118193, 12514.436850341757, 12516.74966500665, 23073.19243826458, 23506.529869402515, 23563.293101206993, 23879.0, 23884.88057559701, 9200.81598368029, 9399.57701903416, 9514.809703805886, 9577.425354478613, 9580.425174489414, 966.7631430299481, 972.8540718892082, 1088.78768640116, 1088.8240700043934, 1092.9562268034008, 28159.15522534327, 28445.715542844722, 28753.281167970967, 29290.267743306587, 29366.265843354086, 1089.9400532970603, 1090.6837017265063, 1092.4428541443922, 1203.9518419263131, 1204.2533629149982, 15500.0, 15593.844061559466, 15610.45363412275, 17648.0, 17929.820701792814, 600955.0, 748752.0, 761098.0, 839263.0, 839747.0, 60725.39274607286, 61128.0, 61485.385146147964, 61534.38465615376, 61760.07359889605, 1460.1093333066822, 1465.5823090419178, 1482.651576879454, 1511.2519302945113, 1513.2585033333587, 31337.8433107833, 32007.359852803278, 32477.675223247465, 34500.82749586236, 34946.0, 54809.177862332894, 55970.0, 56055.71972140113, 56121.71939140278, 56522.0, 315424.0, 316716.0, 317415.0, 317713.0, 318049.0, 47220.76389618167, 47432.525674742814, 48417.75791121022, 48716.512834871195, 48790.268145978545, 50141.0, 50591.49408505868, 50741.49258507515, 51039.234411483114, 51441.22838157356, 42196.0, 42270.57729422666, 42604.14791704211, 43771.0, 43803.78098109616, 42145.578544214164, 42566.0, 43268.35097473604, 43342.34986475142, 43559.128817424105, 41496.377554336104, 41683.0, 41788.58211417847, 41847.790761046, 42959.78520107379, 34139.65860341365, 34310.48534272038, 34751.826240868635, 35075.0, 35176.472352914214, 26925.461490770467, 27460.725392745815, 27526.311842203304, 27658.585121222794, 27734.08650871246], "unit": "ms", "name": "ext.html", "value": 21039.62810269012}, {"lowerIsBetter": false, "replicates": [384.6230494828514, 389.2409800888268, 389.5247797686822, 390.8885967499263, 392.0649251535088, 16089.0, 17149.914250428763, 17590.472285831413, 18584.628307433843, 18652.90673546632, 17141.82858171418, 18098.00460974646, 18211.817881821178, 18279.54301142472, 18307.633847323046, 4758.643101767364, 4927.630427717935, 4950.653454258203, 4955.182394904855, 4963.379577552806, 4951.3810773653295, 5268.394134674523, 5442.047641662713, 5442.612133905848, 5443.156310771837, 5321.840344789663, 5378.596605254602, 5396.83809485716, 5662.0, 5665.915011274814, 5624.915626265589, 5641.887162256773, 5643.8024669136585, 5644.717764111778, 5659.320881494205, 5372.140457526816, 5453.072977593779, 5457.918131228034, 5495.340559132889, 5607.943920560824, 13793.379297931617, 13839.105443414786, 14073.577792666236, 20830.062647180912, 21123.260685876074, 2237.694412691813, 2256.6615007748806, 2325.476767727265, 2347.624380099176, 2507.360623041131, 10412.79174416515, 10428.478576071242, 10493.213009024277, 12256.142070055099, 13461.192328460324, 1848.334599544163, 1858.479625704805, 1870.3734249026593, 1908.23670531787, 1961.264525802824, 63211.36788632101, 66102.66948665274, 66974.3302566973, 67128.66435667839, 68350.0, 10511.579536818595, 10834.0, 10951.233413660968, 10974.780504390028, 10978.945105274423, 14345.928270358581, 14399.856001440061, 14469.49356772508, 14489.710205795825, 14542.054766440147, 8018.79953001168, 8036.598170091472, 8043.436959412902, 8100.635471403801, 8127.2279133482225, 7864.803379915548, 8007.079185893696, 8022.638981245858, 8023.83952320962, 8042.276195142348, 4617.884552886205, 4651.162790697639, 4726.196546587088, 4749.667523273338, 4829.95170048302, 1914.5405102775233, 2018.3743039657752, 2020.8989550522415, 2027.3477116150584, 2035.7048228006856, 946.1910066892846, 953.7091187187835, 958.9808203835884, 1044.6552637629563, 1059.0891833023593, 15062.548123556311, 16641.50075497737, 17382.739258911126, 17446.825531744773, 17584.208710608054, 929.9953500232456, 985.0887928665956, 1045.8169820281573, 1081.5457507846722, 1106.0484852700897, 6436.935630643728, 6719.126513553305, 9747.0, 10037.297389182688, 10181.440020798778, 663126.0, 677469.0, 680268.0, 684296.0, 694238.0, 83025.58487207646, 83101.16898830935, 84570.5771471151, 91725.0, 93404.0659593409, 494.0464902737751, 503.57447956476716, 505.0807530294828, 506.40750322122466, 506.50362644607753, 10167.491625418552, 10607.893921060691, 10613.0, 10680.679579612624, 10843.024127828534, 37299.0, 38446.0, 38486.0, 39246.60753392544, 39590.40614390844, 52404.0, 54341.72829135829, 54377.728111360775, 55578.44421555733, 55836.16245756398, 9626.518674066128, 10548.894511054792, 10633.149348051982, 10637.893621063691, 10650.147988160774, 16811.7478237829, 17361.392351267645, 18205.0, 18249.543761406072, 18435.631287374446, 15085.924570377078, 15175.392984280947, 15435.61410964735, 15495.30271137779, 15556.0, 13910.165390076629, 14247.786283205967, 14532.85467145315, 14601.85398146005, 14977.400903963719, 15374.0, 15516.301766420313, 15621.14083725406, 15691.764623530427, 16616.667666646357, 10461.68614941553, 10544.472776361305, 10547.630832920811, 10565.735856603646, 10637.787244255227, 11283.266587671775, 11342.659720208407, 12757.234565926074, 15762.290696918437, 16130.193490325202], "unit": "ms", "name": "jquery.html", "value": 9041.636498432255}, {"lowerIsBetter": false, "replicates": [1567.4905655661912, 1590.9499730178086, 1834.6055598046416, 1867.2997625890291, 1876.540247639328, 7943.285104340608, 8290.502569845814, 8432.620532076056, 8441.07148213696, 8477.91522084779, 8421.873671894911, 8508.319334453245, 8550.95724521378, 8566.528840913763, 8569.65721371146, 2312.3409828198924, 2338.029717667166, 2344.5779759643256, 2344.812415006795, 2347.1315613223132, 2352.882355882208, 2367.538330025646, 2387.2599494156866, 2393.0069021356117, 2393.246127469841, 2207.701960235364, 2241.3948233976816, 2244.438890277431, 2308.2959697292317, 2319.536092781442, 2255.616545187322, 2317.2932255662017, 2321.7562155973633, 2349.9765002349927, 2352.3178278299356, 2344.2498400511845, 2359.9174028908906, 2367.5146594948164, 2377.3581133093967, 2378.108209421467, 8283.29591984682, 8396.160383961555, 8413.0, 8416.452930559493, 8431.873521897176, 4906.852794416173, 4958.504149585049, 4976.129177393942, 5000.299958005846, 5025.899482010339, 3139.827309497977, 3156.636986746508, 3199.232184275757, 3211.4379983502795, 3219.0825614699697, 1062.1078294232805, 1066.8186408310605, 1073.8389241613743, 1083.4636854756945, 1089.1885545268826, 11253.212275140744, 11370.204085714004, 11389.658310250707, 11403.486843092081, 11419.257748246337, 4234.576542345741, 4236.0, 4304.698671092993, 4317.956820431756, 4321.2005778931, 9286.117818807203, 9301.34890557668, 9323.393979391318, 9329.44023358587, 9333.673321433716, 4833.9033219335415, 4849.612031037508, 4871.293662419001, 4871.464138944713, 4877.244027175793, 4436.82252709888, 4445.466544014739, 4470.798814053375, 4477.865664030084, 4494.415725955605, 3447.620761716209, 3475.461303497962, 3487.442009278503, 3501.9299614007577, 3537.345591065661, 1039.896010398954, 1050.485262221506, 1051.6319288249204, 1056.5140035583718, 1060.4273692206277, 994.4679596415883, 1059.3537941855461, 1233.7532493501335, 1422.7439060968918, 1520.9239538023055, 7562.281583249583, 7631.847363052708, 7661.808454788675, 7662.578558179353, 7672.961635191788, 683.4873844616537, 684.750066225824, 691.3294104718415, 696.993030069703, 830.9127541608165, 6077.6353418795015, 6116.0, 6170.10533472644, 6191.19514463117, 6192.442680158807, 9106.453612783254, 9173.0, 9409.90590094104, 9413.811723765486, 9550.856737148948, 9187.356885018118, 9302.767430814283, 9303.813923721487, 9355.06449355059, 9399.483028433502, 7098.893516597255, 7169.211386747454, 7187.065681461272, 7205.279472052753, 7264.636768161571, 7229.349358557755, 7246.456515761444, 7273.0181425509, 7287.052683151156, 7316.707331706672, 8142.267195952392, 8299.700916161848, 8377.916220837957, 8383.203595658646, 8497.532635705096, 8566.571671416528, 8567.357448191535, 8674.739757807276, 8692.174243446863, 8785.516796575994, 6747.325267473213, 6847.486438517031, 6887.5178737487895, 6890.827729306607, 6899.068625735462, 7730.994970654004, 7731.922680773345, 7773.572453515111, 7785.0, 7794.1816109309975, 7116.608586527791, 7191.892121618284, 7334.193238743627, 7370.6314684266645, 7414.703411863465, 7379.446541509516, 7459.776206713807, 7527.059117610299, 7640.044994375703, 7667.156612772702, 7487.925120748941, 7521.811954701177, 7556.546607203585, 7559.1684914660445, 7574.659140338808, 6503.447206987459, 6797.218319893078, 7000.579965202104, 7024.016637670832, 7064.540804847874, 6910.447164226749, 6948.861022779617, 6972.546784458994, 6976.5465244758925, 6980.301969802979], "unit": "ms", "name": "mootools.html", "value": 4584.879768128276}, {"lowerIsBetter": false, "replicates": [364.7884227148254, 374.3766628563441, 375.494959279769, 375.8909916124324, 380.528145100076, 6445.3554644535525, 6475.449586785123, 6495.740170393178, 6522.771702990402, 6679.697458995498, 6423.582467139633, 6446.065320528521, 6448.097266382711, 6476.708548115334, 6479.74081036758, 4853.247746599282, 4865.440474345442, 4870.488598697121, 4878.975605121987, 4897.90204195915, 4880.731559764212, 4885.242787367946, 4887.706737595738, 4905.779239934212, 4907.6073914086965, 4717.1037502874515, 4731.313959475874, 4791.233402655575, 4792.496787837262, 4865.6107511399005, 4746.145693775119, 4751.406074240737, 4759.619230461555, 4761.547652972962, 4767.475577686451, 4150.3566947123245, 4171.874843754692, 4183.5398106208295, 4186.058136919169, 4192.266353388145, 6101.145839582462, 6104.267487901436, 6106.603070800384, 6114.327423983358, 6115.143879856823, 5542.612017158801, 5601.663900166003, 5603.8879222415735, 5623.156526521014, 5639.887202255932, 6789.524733268673, 6793.388595026471, 6802.081718967926, 6802.14973128359, 6804.829879253059, 4613.83851565197, 4642.117997580449, 4642.930356044662, 4645.9303110453375, 4656.976715116437, 6802.65986700663, 6964.607078584303, 7025.543339682904, 7034.3669069783455, 7053.541519801248, 4901.215805471179, 4971.403431588233, 4993.076280888047, 4995.9508503214, 5014.749262536859, 5080.212567052113, 5084.49155084496, 5088.033273677989, 5089.211172268304, 5091.9236211456855, 5781.5952883298605, 5787.710614469344, 5791.247137872049, 5794.913076303858, 5806.042003069446, 6715.46276297895, 6768.187817461936, 6811.318868113149, 6813.420859226922, 6867.07294515244, 1779.599590092219, 1805.2237537858846, 1806.864485163618, 1809.384809164864, 1812.8368446839847, 1196.126827415991, 1233.1429656388723, 1235.5119727707686, 1239.1573729863599, 1239.4050855589367, 6698.129243198353, 6704.363085506869, 6717.496187785936, 6724.0, 6726.428253598499, 7098.432125429953, 7140.393066589398, 7141.821454463576, 7159.0, 7159.677814498256, 6538.574992625464, 6656.603622695826, 6691.933080669229, 6774.72901083961, 6775.424088952395, 3826.8277927492773, 3873.903152421212, 3880.941785873214, 3884.1649045455365, 3884.320243957296, 7324.08448943882, 7347.971284020241, 7354.227806080392, 7355.2277010913085, 7357.0, 7234.710611575478, 7349.412047036224, 7375.741849035258, 7386.039814824038, 7392.371648409945, 7306.378957788541, 7331.156916954512, 7331.230220826843, 7359.7056117755765, 7374.262573742582, 7097.680604372712, 7172.820679483055, 7223.061002069698, 7223.602701851449, 7229.168645605612, 7053.188883278283, 7072.9646351767915, 7090.574565526085, 7108.893366599608, 7120.1099862517185, 7201.891971620535, 7273.0, 7300.817479563053, 7348.448866334939, 7350.779476615497, 4739.786709598007, 4803.807847686054, 4825.30033145199, 4836.105320515716, 4857.854264372075, 7169.103862017248, 7183.640817959185, 7202.207757146814, 7212.062431884031, 7212.170600381023, 6992.405645520188, 6992.650367481708, 6999.440044796303, 7003.719851205895, 7012.403945664676, 6842.521023528504, 6904.896426553706, 6979.965100174467, 6982.546134501241, 6997.370236678723, 6807.9319206807295, 6854.417374523022, 6863.245043045161, 6865.313468653095, 6866.450683945172, 6976.825579360557, 6978.965105174441, 7018.789436316919, 7033.648317583998, 7042.718291268292, 6628.337166283333, 6825.146856642919, 6833.58998460094, 6838.213605435439, 6902.8619427612175], "unit": "ms", "name": "prototype.html", "value": 5200.157531816141}, {"lowerIsBetter": false, "replicates": [784.3529088501987, 787.2127872127869, 805.4804651000109, 938.9999650372353, 950.2445555783154, 14580.56258312251, 14629.268536573181, 14663.633409164762, 14698.779518307221, 14714.264286785672, 13766.862331376684, 13851.238181900017, 13857.584272471817, 13877.0, 13885.722285554308, 751.6730222353267, 770.410635863562, 897.8653202019684, 919.3013309884469, 926.8609708543705, 920.5213289089669, 921.0421161991554, 925.5742358515057, 927.0451435021938, 928.2434815625244, 969.2633598465181, 971.1502435369052, 975.8828940527111, 977.6480467031863, 978.0561757903622, 957.530809903146, 958.8993155718618, 960.4861399151421, 961.0, 963.373807025432, 720.8918662200659, 721.2282857342645, 723.023917711091, 725.6952080126307, 727.2182403915812, 14116.435342586285, 14264.072835265675, 14273.857261427356, 14298.928505357511, 14354.354054067488, 12670.873291267062, 12691.238525688488, 13009.34953252343, 13211.471541138342, 13375.531856385078, 10800.405977671226, 10914.617988370448, 10916.617918372818, 10996.0, 11987.820182697267, 3901.960980390188, 3956.1296514766705, 3977.8209980550946, 3994.7802870842384, 4062.7968601569805, 49347.50652493465, 49664.0, 49817.75091124521, 49910.75044624753, 51472.74263628695, 11026.558937642565, 11088.55645774176, 11168.497417616065, 11232.269902456314, 11471.139664525193, 18752.249910003447, 18882.339118131073, 19160.80839191618, 19189.32837350686, 19193.32823351176, 8115.431919765678, 8300.750977470685, 8321.459105158145, 8332.5000499969, 8469.957650211709, 4838.7338696371335, 4889.584385327287, 4949.727764972889, 5000.199968005102, 5045.369328833895, 3205.7114859662743, 3230.80615163091, 3235.8705651774135, 3246.6753324667343, 3247.3342964692656, 567.0558520064129, 568.9203511508392, 575.4245754245754, 576.4811669497486, 587.0, 590.9793157239476, 707.7947395255318, 733.9926600734032, 735.1472292141091, 751.2825251884437, 9008.954955225314, 9076.455412675261, 9182.816343673223, 9209.21721653667, 9540.093691099335, 624.6782906803, 714.989275160873, 735.8565079809492, 776.65050727173, 791.4697152907565, 4102.630763231324, 4154.252234597741, 4276.679249056333, 4342.761148136883, 4445.177642136216, 58013.70993145092, 58681.0, 58929.41070589325, 59082.70458647679, 59108.0, 52592.73703631534, 52839.471605283456, 53456.46543534593, 53886.19170712364, 54040.729796350766, 47171.29243061357, 47884.5211547887, 48286.0, 48567.0, 48875.511244887806, 8322.958385208036, 8557.700480483154, 8705.173008564176, 9091.181793638605, 9871.605135794774, 35454.0, 35569.28861422809, 36368.0, 36456.27087458183, 36548.08629784277, 47622.76188619035, 48190.27714584354, 48560.757196213795, 48582.0, 48695.0, 12572.434240459384, 12736.554220602235, 12772.425240863997, 12823.294718790556, 12962.740745184854, 12118.909298163207, 12150.331731754839, 12532.310722910328, 12799.360031998176, 12819.102662813886, 12212.816807747713, 12422.937885310515, 12492.750144997231, 12546.686332841751, 13009.02432317561, 12047.759044818878, 12116.0, 12169.878301216875, 12193.451294691937, 12344.321062341658, 10914.035473614826, 11296.774064518828, 11498.0, 12022.33877136731, 12466.0, 10128.848067279145, 10498.486798622574, 10611.363318200623, 10618.787624247627, 10876.564937402416, 10623.628173013907, 10738.463076846283, 10814.188935830001, 10946.17903657213, 10991.230613856953], "unit": "ms", "name": "yui.html", "value": 6803.557563946754}], "name": "dromaeo_css", "value": 7429.459150757205}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 103.0, 111.0, 110.0, 110.0, 123.0, 111.0, 111.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 152.0, 155.0, 127.0, 154.0, 154.0, 125.0, 159.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 162.0, 161.0, 160.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [79.0, 70.0, 72.0, 161.0, 72.0, 73.0, 73.0, 73.0, 163.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 90.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 92.0, 93.0, 93.0, 133.0, 91.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 150.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 62.0, 63.0, 60.0, 60.0, 61.0, 60.0, 60.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 83.0, 90.0, 83.0, 82.0, 81.0, 82.0, 82.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [126.0, 116.0, 123.0, 114.0, 121.0, 115.0, 121.0, 119.0, 136.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 152.0, 147.0, 155.0, 140.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 76.0, 68.0, 65.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1507.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.77785190126752], "unit": "score", "name": "Richards", "value": 211.67079199999998}, {"lowerIsBetter": false, "replicates": [173.55085039916696], "unit": "score", "name": "DeltaBlue", "value": 380.9719160000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [545.5537370430987], "unit": "score", "name": "Earley", "value": 1221.626679}, {"lowerIsBetter": false, "replicates": [11065.934065934065], "unit": "score", "name": "Boyer", "value": 60.22654716981128}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [520.0208008320333], "unit": "score", "name": "Splay", "value": 156.70719299999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23075.38651510593}]} 11:59:36 INFO - RETURN: dromaeo_css: 7429.46 11:59:36 INFO - RETURN: kraken: 1507.90 11:59:36 INFO - RETURN: v8_7: 23075.39 11:59:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23075.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1507.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7429.46"}}} 11:59:36 INFO - Return code: 0 11:59:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:59:36 INFO - # TBPL SUCCESS # 11:59:36 INFO - Running post-action listener: _resource_record_post_action 11:59:36 INFO - Running post-run listener: _resource_record_post_run 11:59:37 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 0; Write bytes: 510971904; Read time: 0; Write time: 387304 11:59:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244449280; Read time: 0; Write time: 224068 11:59:37 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 0; Write bytes: 266235904; Read time: 0; Write time: 163220 11:59:37 INFO - Running post-run listener: _upload_blobber_files 11:59:37 INFO - Blob upload gear active. 11:59:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:59:37 INFO - Copying logs to upload dir... 11:59:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.038471 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-01-21 11:59:37.557260) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:59:37.561114) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009573 build_url: 'https://queue.taskcluster.net/v1/task/sA2vxXH1T_e53rMV3RZ3Uw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 11:59:37.611684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:59:37.612516) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1453403966.624212-1379962513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 11:59:37.662465) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:59:37.662806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 11:59:37.663102) ========= ========= Total master_lag: 0.72 =========