builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1453485366.62 results: success (0) buildid: 20160122073132 builduid: a98ce736a1b546b88dd3ebf3f7df36d3 revision: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.621883) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.622263) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.622552) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006352 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.645423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.645712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.659790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.660094) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.708822) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.709104) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.709452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.709720) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 09:56:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-01-22 09:56:06 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.880905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.881182) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.931111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:06.931500) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a --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 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a --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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 09:56:07,008 truncating revision to first 12 chars 2016-01-22 09:56:07,008 Setting DEBUG logging. 2016-01-22 09:56:07,008 attempt 1/10 2016-01-22 09:56:07,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0cd0ae95d865?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 09:56:07,268 unpacking tar archive at: mozilla-aurora-0cd0ae95d865/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562357 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:07.507297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:07.507628) ========= echo 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a'] 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a program finished with exit code 0 elapsedTime=0.004636 script_repo_revision: '0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:07.559099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:07.559470) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 09:56:07.569741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-22 09:56:07.570034) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:07 INFO - MultiFileLogger online at 20160122 09:56:07 in /builds/slave/test-pgo 09:56:07 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 09:56:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:56:07 INFO - {'append_to_log': False, 09:56:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:56:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:56:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:56:07 INFO - 'branch': 'Mozilla-Aurora', 09:56:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:07 INFO - 'config_files': ('talos/linux_config.py',), 09:56:07 INFO - 'default_actions': ('clobber', 09:56:07 INFO - 'read-buildbot-config', 09:56:07 INFO - 'download-and-extract', 09:56:07 INFO - 'populate-webroot', 09:56:07 INFO - 'create-virtualenv', 09:56:07 INFO - 'install', 09:56:07 INFO - 'run-tests'), 09:56:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:07 INFO - 'download_minidump_stackwalk': True, 09:56:07 INFO - 'download_symbols': 'ondemand', 09:56:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:07 INFO - 'installer_path': 'installer.exe', 09:56:07 INFO - 'log_level': 'info', 09:56:07 INFO - 'log_name': 'talos', 09:56:07 INFO - 'log_to_console': True, 09:56:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:07 INFO - 'opt_config_files': (), 09:56:07 INFO - 'pip_index': False, 09:56:07 INFO - 'sps_profile': False, 09:56:07 INFO - 'sps_profile_interval': 0, 09:56:07 INFO - 'suite': 'dromaeojs-e10s', 09:56:07 INFO - 'system_bits': '32', 09:56:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:07 INFO - 'title': 'talos-linux64-ix-033', 09:56:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:07 INFO - 'use_talos_json': True, 09:56:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:56:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:07 INFO - 'work_dir': 'build'} 09:56:07 INFO - ##### 09:56:07 INFO - ##### Running clobber step. 09:56:07 INFO - ##### 09:56:07 INFO - Running pre-action listener: _resource_record_pre_action 09:56:07 INFO - Running main action method: clobber 09:56:07 INFO - rmtree: /builds/slave/test-pgo/build 09:56:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:56:08 INFO - Running post-action listener: _resource_record_post_action 09:56:08 INFO - ##### 09:56:08 INFO - ##### Running read-buildbot-config step. 09:56:08 INFO - ##### 09:56:08 INFO - Running pre-action listener: _resource_record_pre_action 09:56:08 INFO - Running main action method: read_buildbot_config 09:56:08 INFO - Using buildbot properties: 09:56:08 INFO - { 09:56:08 INFO - "properties": { 09:56:08 INFO - "buildnumber": 72, 09:56:08 INFO - "product": "firefox", 09:56:08 INFO - "script_repo_revision": "production", 09:56:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:56:08 INFO - "repository": "", 09:56:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:56:08 INFO - "buildid": "20160122073132", 09:56:08 INFO - "slavename": "talos-linux64-ix-033", 09:56:08 INFO - "pgo_build": "True", 09:56:08 INFO - "basedir": "/builds/slave/test-pgo", 09:56:08 INFO - "project": "", 09:56:08 INFO - "platform": "ubuntu64_hw", 09:56:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:56:08 INFO - "slavebuilddir": "test", 09:56:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:56:08 INFO - "branch": "mozilla-aurora", 09:56:08 INFO - "repo_path": "releases/mozilla-aurora", 09:56:08 INFO - "stage_platform": "linux64-pgo", 09:56:08 INFO - "builduid": "a98ce736a1b546b88dd3ebf3f7df36d3", 09:56:08 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:08 INFO - }, 09:56:08 INFO - "sourcestamp": { 09:56:08 INFO - "repository": "", 09:56:08 INFO - "hasPatch": false, 09:56:08 INFO - "project": "", 09:56:08 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:56:08 INFO - "changes": [ 09:56:08 INFO - { 09:56:08 INFO - "category": null, 09:56:08 INFO - "files": [ 09:56:08 INFO - { 09:56:08 INFO - "url": null, 09:56:08 INFO - "name": "https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:56:08 INFO - } 09:56:08 INFO - ], 09:56:08 INFO - "repository": "", 09:56:08 INFO - "rev": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a", 09:56:08 INFO - "who": "cbook@mozilla.com", 09:56:08 INFO - "when": 1453485357, 09:56:08 INFO - "number": 7501772, 09:56:08 INFO - "comments": "Bug 1240868 - Use a mock addon provider to feed broken data in Telemetry. r=gfritzsche, a=sylvestre", 09:56:08 INFO - "project": "", 09:56:08 INFO - "at": "Fri 22 Jan 2016 09:55:57", 09:56:08 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:56:08 INFO - "revlink": "", 09:56:08 INFO - "properties": [ 09:56:08 INFO - [ 09:56:08 INFO - "buildid", 09:56:08 INFO - "20160122073132", 09:56:08 INFO - "Change" 09:56:08 INFO - ], 09:56:08 INFO - [ 09:56:08 INFO - "builduid", 09:56:08 INFO - "a98ce736a1b546b88dd3ebf3f7df36d3", 09:56:08 INFO - "Change" 09:56:08 INFO - ], 09:56:08 INFO - [ 09:56:08 INFO - "pgo_build", 09:56:08 INFO - "True", 09:56:08 INFO - "Change" 09:56:08 INFO - ] 09:56:08 INFO - ], 09:56:08 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:08 INFO - } 09:56:08 INFO - ], 09:56:08 INFO - "revision": "0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a" 09:56:08 INFO - } 09:56:08 INFO - } 09:56:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:56:08 INFO - Running post-action listener: _resource_record_post_action 09:56:08 INFO - ##### 09:56:08 INFO - ##### Running download-and-extract step. 09:56:08 INFO - ##### 09:56:08 INFO - Running pre-action listener: _resource_record_pre_action 09:56:08 INFO - Running main action method: download_and_extract 09:56:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:56: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')]} 09:56:08 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:56:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json 09:56:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json 09:56:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:56:09 INFO - Downloaded 1302 bytes. 09:56:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:56:09 INFO - Using the following test package requirements: 09:56:09 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:09 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:09 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'jsshell-linux-x86_64.zip'], 09:56:09 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:09 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:09 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:56:09 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:56:09 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:09 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:56:09 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:56:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:09 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:12 INFO - Downloaded 23159720 bytes. 09:56:12 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 09:56:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:12 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 09:56:13 INFO - Return code: 0 09:56:13 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 09:56:13 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')]} 09:56:13 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:19 INFO - Downloaded 23159720 bytes. 09:56:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:56:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:56:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:56:20 INFO - Return code: 0 09:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:20 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:56:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:21 INFO - Downloaded 11132038 bytes. 09:56:21 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 09:56:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:56:21 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 09:56:21 INFO - Return code: 0 09:56:21 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')]} 09:56:21 INFO - https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GjhlnvYhT9KITJtzu5kAzA/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 09:56:23 INFO - Downloaded 58017146 bytes. 09:56:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:23 INFO - mkdir: /builds/slave/test-pgo/properties 09:56:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:56:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:56:23 INFO - Contents: 09:56:23 INFO - build_url:https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:56:23 INFO - Running post-action listener: _resource_record_post_action 09:56:23 INFO - Running post-action listener: set_extra_try_arguments 09:56:23 INFO - ##### 09:56:23 INFO - ##### Running populate-webroot step. 09:56:23 INFO - ##### 09:56:23 INFO - Running pre-action listener: _resource_record_pre_action 09:56:23 INFO - Running main action method: populate_webroot 09:56:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:23 INFO - '--tppagecycles', 09:56:23 INFO - '7'], 09:56:23 INFO - 'tests': ['tsvgm']}}, 09:56:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:56:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:56:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'tests': ['damp', 'tps']}, 09:56:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['damp', 'tps']}, 09:56:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:56:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:23 INFO - 'other': {'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'other_l64': {'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'other_nol64': {'tests': ['a11yr', 09:56:23 INFO - 'ts_paint', 09:56:23 INFO - 'tpaint', 09:56:23 INFO - 'sessionrestore', 09:56:23 INFO - 'sessionrestore_no_auto_restore']}, 09:56:23 INFO - 'svgr': {'tests': ['tsvgx', 09:56:23 INFO - 'tsvgr_opacity', 09:56:23 INFO - 'tart', 09:56:23 INFO - 'tscrollx', 09:56:23 INFO - 'cart']}, 09:56:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['tsvgx', 09:56:23 INFO - 'tsvgr_opacity', 09:56:23 INFO - 'tart', 09:56:23 INFO - 'tscrollx', 09:56:23 INFO - 'cart']}, 09:56:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'tests': ['tp5o']}, 09:56:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'talos_options': ['--e10s'], 09:56:23 INFO - 'tests': ['tp5o']}, 09:56:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'talos_options': ['--xperf_path', 09:56:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:23 INFO - 'tests': ['tp5n']}, 09:56:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:23 INFO - 'talos_options': ['--e10s', 09:56:23 INFO - '--xperf_path', 09:56:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:23 INFO - 'tests': ['tp5n']}}, 09:56:23 INFO - 'talos.zip': {'path': '', 09:56:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:23 INFO - Running post-action listener: _resource_record_post_action 09:56:23 INFO - ##### 09:56:23 INFO - ##### Running create-virtualenv step. 09:56:23 INFO - ##### 09:56:23 INFO - Running pre-action listener: _resource_record_pre_action 09:56:23 INFO - Running main action method: create_virtualenv 09:56:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:56:23 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 09:56:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:56:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:23 INFO - Using real prefix '/usr' 09:56:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:56:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:26 INFO - Installing pip.................done. 09:56:26 INFO - Return code: 0 09:56:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:26 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:26 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 09:56:26 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 09:56:26 INFO - Using env: {'DISPLAY': ':0', 09:56:26 INFO - 'HOME': '/home/cltbld', 09:56:26 INFO - 'LANG': 'en_US.UTF-8', 09:56:26 INFO - 'LANGUAGE': 'en_US:en', 09:56:26 INFO - 'LOGNAME': 'cltbld', 09:56:26 INFO - 'MAIL': '/var/mail/cltbld', 09:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:26 INFO - 'MOZ_NO_REMOTE': '1', 09:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:26 INFO - 'NO_EM_RESTART': '1', 09:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:26 INFO - 'SHELL': '/bin/bash', 09:56:26 INFO - 'SHLVL': '1', 09:56:26 INFO - 'TERM': 'linux', 09:56:26 INFO - 'TMOUT': '86400', 09:56:26 INFO - 'USER': 'cltbld', 09:56:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:26 INFO - '_': '/tools/buildbot/bin/python'} 09:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:26 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 09:56:26 INFO - Cleaning up... 09:56:26 INFO - Return code: 0 09:56:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:26 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:26 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 09:56:26 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 09:56:26 INFO - Using env: {'DISPLAY': ':0', 09:56:26 INFO - 'HOME': '/home/cltbld', 09:56:26 INFO - 'LANG': 'en_US.UTF-8', 09:56:26 INFO - 'LANGUAGE': 'en_US:en', 09:56:26 INFO - 'LOGNAME': 'cltbld', 09:56:26 INFO - 'MAIL': '/var/mail/cltbld', 09:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:26 INFO - 'MOZ_NO_REMOTE': '1', 09:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:26 INFO - 'NO_EM_RESTART': '1', 09:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:26 INFO - 'SHELL': '/bin/bash', 09:56:26 INFO - 'SHLVL': '1', 09:56:26 INFO - 'TERM': 'linux', 09:56:26 INFO - 'TMOUT': '86400', 09:56:26 INFO - 'USER': 'cltbld', 09:56:26 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:26 INFO - '_': '/tools/buildbot/bin/python'} 09:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:26 INFO - Downloading/unpacking psutil>=0.7.1 09:56:26 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 09:56:26 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 09:56:26 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 09:56:26 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 09:56:26 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 09:56:26 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 09:56:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:28 INFO - Installing collected packages: psutil 09:56:28 INFO - Running setup.py install for psutil 09:56:28 INFO - building 'psutil._psutil_linux' extension 09:56:28 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 09:56:28 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 09:56:28 INFO - building 'psutil._psutil_posix' extension 09:56:28 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 09:56:28 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 09:56:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:28 INFO - Successfully installed psutil 09:56:28 INFO - Cleaning up... 09:56:28 INFO - Return code: 0 09:56:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:28 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 09:56:28 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 09:56:29 INFO - Using env: {'DISPLAY': ':0', 09:56:29 INFO - 'HOME': '/home/cltbld', 09:56:29 INFO - 'LANG': 'en_US.UTF-8', 09:56:29 INFO - 'LANGUAGE': 'en_US:en', 09:56:29 INFO - 'LOGNAME': 'cltbld', 09:56:29 INFO - 'MAIL': '/var/mail/cltbld', 09:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:29 INFO - 'MOZ_NO_REMOTE': '1', 09:56:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:29 INFO - 'NO_EM_RESTART': '1', 09:56:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:29 INFO - 'SHELL': '/bin/bash', 09:56:29 INFO - 'SHLVL': '1', 09:56:29 INFO - 'TERM': 'linux', 09:56:29 INFO - 'TMOUT': '86400', 09:56:29 INFO - 'USER': 'cltbld', 09:56:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:29 INFO - '_': '/tools/buildbot/bin/python'} 09:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:56:29 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 09:56:29 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 09:56:29 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 09:56:29 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 09:56:29 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 09:56:29 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 09:56:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:56:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:56:31 INFO - Installing collected packages: mozsystemmonitor 09:56:31 INFO - Running setup.py install for mozsystemmonitor 09:56:31 INFO - Successfully installed mozsystemmonitor 09:56:31 INFO - Cleaning up... 09:56:31 INFO - Return code: 0 09:56:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:31 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:31 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 09:56:31 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 09:56:31 INFO - Using env: {'DISPLAY': ':0', 09:56:31 INFO - 'HOME': '/home/cltbld', 09:56:31 INFO - 'LANG': 'en_US.UTF-8', 09:56:31 INFO - 'LANGUAGE': 'en_US:en', 09:56:31 INFO - 'LOGNAME': 'cltbld', 09:56:31 INFO - 'MAIL': '/var/mail/cltbld', 09:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:31 INFO - 'MOZ_NO_REMOTE': '1', 09:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:31 INFO - 'NO_EM_RESTART': '1', 09:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:31 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:31 INFO - 'SHELL': '/bin/bash', 09:56:31 INFO - 'SHLVL': '1', 09:56:31 INFO - 'TERM': 'linux', 09:56:31 INFO - 'TMOUT': '86400', 09:56:31 INFO - 'USER': 'cltbld', 09:56:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:31 INFO - '_': '/tools/buildbot/bin/python'} 09:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:31 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 09:56:31 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 09:56:31 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 09:56:31 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 09:56:31 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 09:56:31 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 09:56:33 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:56:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:33 INFO - Downloading docopt-0.6.1.tar.gz 09:56:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:33 INFO - Running setup.py install for blobuploader 09:56:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:56:33 INFO - Running setup.py install for requests 09:56:34 INFO - Running setup.py install for docopt 09:56:34 INFO - Successfully installed blobuploader requests docopt 09:56:34 INFO - Cleaning up... 09:56:34 INFO - Return code: 0 09:56:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:34 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:34 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 09:56:34 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 09:56:34 INFO - Using env: {'DISPLAY': ':0', 09:56:34 INFO - 'HOME': '/home/cltbld', 09:56:34 INFO - 'LANG': 'en_US.UTF-8', 09:56:34 INFO - 'LANGUAGE': 'en_US:en', 09:56:34 INFO - 'LOGNAME': 'cltbld', 09:56:34 INFO - 'MAIL': '/var/mail/cltbld', 09:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:34 INFO - 'MOZ_NO_REMOTE': '1', 09:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:34 INFO - 'NO_EM_RESTART': '1', 09:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:34 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:34 INFO - 'SHELL': '/bin/bash', 09:56:34 INFO - 'SHLVL': '1', 09:56:34 INFO - 'TERM': 'linux', 09:56:34 INFO - 'TMOUT': '86400', 09:56:34 INFO - 'USER': 'cltbld', 09:56:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:34 INFO - '_': '/tools/buildbot/bin/python'} 09:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:34 INFO - Running setup.py (path:/tmp/pip-BhC865-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:34 INFO - Running setup.py (path:/tmp/pip-Pk2SK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:34 INFO - Running setup.py (path:/tmp/pip-RWhssN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:34 INFO - Running setup.py (path:/tmp/pip-ArpRPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:34 INFO - Running setup.py (path:/tmp/pip-Xx2xeJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:35 INFO - Running setup.py (path:/tmp/pip-_XRlfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:35 INFO - Running setup.py (path:/tmp/pip-8MIszb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:35 INFO - Running setup.py (path:/tmp/pip-_8ZudV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:35 INFO - Running setup.py (path:/tmp/pip-tZ62to-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:35 INFO - Running setup.py (path:/tmp/pip-OC_p5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:35 INFO - Running setup.py (path:/tmp/pip-Y9lDtd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:35 INFO - Running setup.py (path:/tmp/pip-ZqanA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:35 INFO - Running setup.py (path:/tmp/pip-_LxIcX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:35 INFO - Running setup.py (path:/tmp/pip-Z25Zq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:35 INFO - Running setup.py (path:/tmp/pip-HvDYe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:35 INFO - Running setup.py (path:/tmp/pip-cXorMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:35 INFO - Running setup.py (path:/tmp/pip-kKcZbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:35 INFO - Running setup.py install for manifestparser 09:56:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:56:35 INFO - Running setup.py install for mozcrash 09:56:36 INFO - Running setup.py install for mozdebug 09:56:36 INFO - Running setup.py install for mozdevice 09:56:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Running setup.py install for mozfile 09:56:36 INFO - Running setup.py install for mozhttpd 09:56:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Running setup.py install for mozinfo 09:56:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Running setup.py install for mozInstall 09:56:36 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Running setup.py install for mozleak 09:56:36 INFO - Running setup.py install for mozlog 09:56:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:56:36 INFO - Running setup.py install for moznetwork 09:56:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Running setup.py install for mozprocess 09:56:37 INFO - Running setup.py install for mozprofile 09:56:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Running setup.py install for mozrunner 09:56:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Running setup.py install for mozscreenshot 09:56:37 INFO - Running setup.py install for moztest 09:56:37 INFO - Running setup.py install for mozversion 09:56:37 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:56:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:37 INFO - Cleaning up... 09:56:37 INFO - Return code: 0 09:56:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:37 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:37 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 09:56:37 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 09:56:37 INFO - Using env: {'DISPLAY': ':0', 09:56:37 INFO - 'HOME': '/home/cltbld', 09:56:37 INFO - 'LANG': 'en_US.UTF-8', 09:56:37 INFO - 'LANGUAGE': 'en_US:en', 09:56:37 INFO - 'LOGNAME': 'cltbld', 09:56:37 INFO - 'MAIL': '/var/mail/cltbld', 09:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:37 INFO - 'MOZ_NO_REMOTE': '1', 09:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:37 INFO - 'NO_EM_RESTART': '1', 09:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:37 INFO - 'SHELL': '/bin/bash', 09:56:37 INFO - 'SHLVL': '1', 09:56:37 INFO - 'TERM': 'linux', 09:56:37 INFO - 'TMOUT': '86400', 09:56:37 INFO - 'USER': 'cltbld', 09:56:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:37 INFO - '_': '/tools/buildbot/bin/python'} 09:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:37 INFO - Running setup.py (path:/tmp/pip-SJl1rk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:56:37 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)) 09:56:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:37 INFO - Running setup.py (path:/tmp/pip-uAPS8D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:38 INFO - Running setup.py (path:/tmp/pip-mkZR3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:38 INFO - Running setup.py (path:/tmp/pip-BK4MID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:38 INFO - Running setup.py (path:/tmp/pip-oOnAtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:38 INFO - Running setup.py (path:/tmp/pip-zeyB5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:38 INFO - Running setup.py (path:/tmp/pip-d2dyX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:38 INFO - Running setup.py (path:/tmp/pip-lTWDzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:38 INFO - Running setup.py (path:/tmp/pip-KSlWzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:38 INFO - Running setup.py (path:/tmp/pip-BtG4Bt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:38 INFO - Running setup.py (path:/tmp/pip-CKKjaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:38 INFO - Running setup.py (path:/tmp/pip-zK5DRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:38 INFO - Running setup.py (path:/tmp/pip-taB6Sz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:38 INFO - Running setup.py (path:/tmp/pip-w0Xabz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:38 INFO - Running setup.py (path:/tmp/pip-vG1ohG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:56:38 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)) 09:56:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:38 INFO - Running setup.py (path:/tmp/pip-AGgpED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:56:39 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)) 09:56:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:39 INFO - Running setup.py (path:/tmp/pip-Ajp3Ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:56:39 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)) 09:56:39 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)) 09:56:39 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)) 09:56:39 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)) 09:56:39 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)) 09:56:39 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)) 09:56:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:40 INFO - Downloading blessings-1.6.tar.gz 09:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:40 INFO - Installing collected packages: blessings 09:56:40 INFO - Running setup.py install for blessings 09:56:41 INFO - Successfully installed blessings 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:56:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:41 INFO - Reading from file tmpfile_stdout 09:56:41 INFO - Current package versions: 09:56:41 INFO - argparse == 1.2.1 09:56:41 INFO - blessings == 1.6 09:56:41 INFO - blobuploader == 1.2.4 09:56:41 INFO - docopt == 0.6.1 09:56:41 INFO - manifestparser == 1.1 09:56:41 INFO - mozInstall == 1.12 09:56:41 INFO - mozcrash == 0.16 09:56:41 INFO - mozdebug == 0.1 09:56:41 INFO - mozdevice == 0.47 09:56:41 INFO - mozfile == 1.2 09:56:41 INFO - mozhttpd == 0.7 09:56:41 INFO - mozinfo == 0.9 09:56:41 INFO - mozleak == 0.1 09:56:41 INFO - mozlog == 3.1 09:56:41 INFO - moznetwork == 0.27 09:56:41 INFO - mozprocess == 0.22 09:56:41 INFO - mozprofile == 0.27 09:56:41 INFO - mozrunner == 6.11 09:56:41 INFO - mozscreenshot == 0.1 09:56:41 INFO - mozsystemmonitor == 0.0 09:56:41 INFO - moztest == 0.7 09:56:41 INFO - mozversion == 1.4 09:56:41 INFO - psutil == 3.1.1 09:56:41 INFO - requests == 1.2.3 09:56:41 INFO - wsgiref == 0.1.2 09:56:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:56:41 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')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 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')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:41 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 09:56:41 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 09:56:41 INFO - Using env: {'DISPLAY': ':0', 09:56:41 INFO - 'HOME': '/home/cltbld', 09:56:41 INFO - 'LANG': 'en_US.UTF-8', 09:56:41 INFO - 'LANGUAGE': 'en_US:en', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MAIL': '/var/mail/cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SHLVL': '1', 09:56:41 INFO - 'TERM': 'linux', 09:56:41 INFO - 'TMOUT': '86400', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - '_': '/tools/buildbot/bin/python'} 09:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 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)) 09:56:41 INFO - Cleaning up... 09:56:41 INFO - Return code: 0 09:56:41 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:56:41 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')]} 09:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 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')]} 09:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:41 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 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:41 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 09:56:41 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 09:56:41 INFO - Using env: {'DISPLAY': ':0', 09:56:41 INFO - 'HOME': '/home/cltbld', 09:56:41 INFO - 'LANG': 'en_US.UTF-8', 09:56:41 INFO - 'LANGUAGE': 'en_US:en', 09:56:41 INFO - 'LOGNAME': 'cltbld', 09:56:41 INFO - 'MAIL': '/var/mail/cltbld', 09:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:41 INFO - 'MOZ_NO_REMOTE': '1', 09:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:41 INFO - 'NO_EM_RESTART': '1', 09:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:41 INFO - 'SHELL': '/bin/bash', 09:56:41 INFO - 'SHLVL': '1', 09:56:41 INFO - 'TERM': 'linux', 09:56:41 INFO - 'TMOUT': '86400', 09:56:41 INFO - 'USER': 'cltbld', 09:56:41 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:41 INFO - '_': '/tools/buildbot/bin/python'} 09:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:41 INFO - Downloading/unpacking jsonschema 09:56:41 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 09:56:41 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 09:56:41 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 09:56:41 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 09:56:41 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 09:56:41 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 09:56:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:43 INFO - Downloading/unpacking functools32 (from jsonschema) 09:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:43 INFO - warning: no files found matching '*.txt' 09:56:43 INFO - no previously-included directories found matching 'build' 09:56:43 INFO - no previously-included directories found matching 'dist' 09:56:43 INFO - no previously-included directories found matching '.git*' 09:56:43 INFO - Installing collected packages: jsonschema, functools32 09:56:43 INFO - Running setup.py install for functools32 09:56:43 INFO - warning: no files found matching '*.txt' 09:56:43 INFO - no previously-included directories found matching 'build' 09:56:43 INFO - no previously-included directories found matching 'dist' 09:56:43 INFO - no previously-included directories found matching '.git*' 09:56:43 INFO - Successfully installed jsonschema functools32 09:56:43 INFO - Cleaning up... 09:56:43 INFO - Return code: 0 09:56:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe4f9c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', '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 09:56:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:56:43 INFO - Using env: {'DISPLAY': ':0', 09:56:43 INFO - 'HOME': '/home/cltbld', 09:56:43 INFO - 'LANG': 'en_US.UTF-8', 09:56:43 INFO - 'LANGUAGE': 'en_US:en', 09:56:43 INFO - 'LOGNAME': 'cltbld', 09:56:43 INFO - 'MAIL': '/var/mail/cltbld', 09:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:43 INFO - 'MOZ_NO_REMOTE': '1', 09:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:43 INFO - 'NO_EM_RESTART': '1', 09:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:56:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:56:43 INFO - 'SHELL': '/bin/bash', 09:56:43 INFO - 'SHLVL': '1', 09:56:43 INFO - 'TERM': 'linux', 09:56:43 INFO - 'TMOUT': '86400', 09:56:43 INFO - 'USER': 'cltbld', 09:56:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:43 INFO - '_': '/tools/buildbot/bin/python'} 09:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:44 INFO - Downloading/unpacking flake8 09:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:46 INFO - no previously-included directories found matching 'docs/_build' 09:56:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:46 INFO - Running setup.py install for pep8 09:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:46 INFO - no previously-included directories found matching 'docs/_build' 09:56:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:56:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:46 INFO - Cleaning up... 09:56:46 INFO - Return code: 0 09:56:46 INFO - Running post-action listener: _resource_record_post_action 09:56:46 INFO - Running post-action listener: _start_resource_monitoring 09:56:46 INFO - Starting resource monitoring. 09:56:46 INFO - ##### 09:56:46 INFO - ##### Running install step. 09:56:46 INFO - ##### 09:56:46 INFO - Running pre-action listener: _resource_record_pre_action 09:56:46 INFO - Running main action method: install 09:56:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:56:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:56:47 INFO - Reading from file tmpfile_stdout 09:56:47 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:56:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:56:47 INFO - Reading from file tmpfile_stdout 09:56:47 INFO - Output received: 09:56:47 INFO - Usage: mozinstall [options] installer 09:56:47 INFO - Options: 09:56:47 INFO - -h, --help show this help message and exit 09:56:47 INFO - -d DEST, --destination=DEST 09:56:47 INFO - Directory to install application into. [default: 09:56:47 INFO - "/builds/slave/test-pgo"] 09:56:47 INFO - --app=APP Application being installed. [default: firefox] 09:56:47 INFO - mkdir: /builds/slave/test-pgo/build/application 09:56:47 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'] 09:56:47 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 09:57:01 INFO - Reading from file tmpfile_stdout 09:57:01 INFO - Output received: 09:57:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:57:01 INFO - Running post-action listener: _resource_record_post_action 09:57:01 INFO - ##### 09:57:01 INFO - ##### Running run-tests step. 09:57:01 INFO - ##### 09:57:01 INFO - Running pre-action listener: _resource_record_pre_action 09:57:01 INFO - Running main action method: run_tests 09:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:57:01 INFO - Python 2.7.3 09:57:01 INFO - Return code: 0 09:57:01 INFO - grabbing minidump binary from tooltool 09:57: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')]} 09:57:01 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 0x2208a50>, '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 0x2174550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21749e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:57:01 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 09:57:01 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 09:57:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:01 INFO - Return code: 0 09:57:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:57:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:57:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:57:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:57:02 INFO - Return code: 0 09:57:02 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/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:57:02 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/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 09:57:02 INFO - Using env: {'DISPLAY': ':0', 09:57:02 INFO - 'HOME': '/home/cltbld', 09:57:02 INFO - 'LANG': 'en_US.UTF-8', 09:57:02 INFO - 'LANGUAGE': 'en_US:en', 09:57:02 INFO - 'LOGNAME': 'cltbld', 09:57:02 INFO - 'MAIL': '/var/mail/cltbld', 09:57:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:02 INFO - 'MOZ_NO_REMOTE': '1', 09:57:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:02 INFO - 'NO_EM_RESTART': '1', 09:57:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:57:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:57:02 INFO - 'SHELL': '/bin/bash', 09:57:02 INFO - 'SHLVL': '1', 09:57:02 INFO - 'TERM': 'linux', 09:57:02 INFO - 'TMOUT': '86400', 09:57:02 INFO - 'USER': 'cltbld', 09:57:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953', 09:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:02 INFO - '_': '/tools/buildbot/bin/python'} 09:57:02 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/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 09:57:03 INFO - mozversion INFO | application_buildid: 20160122073132 09:57:03 INFO - mozversion INFO | application_changeset: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a 09:57:03 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:57:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:03 INFO - mozversion INFO | application_name: Firefox 09:57:03 INFO - mozversion INFO | application_remotingname: firefox-dev 09:57:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:03 INFO - mozversion INFO | application_vendor: Mozilla 09:57:03 INFO - mozversion INFO | application_version: 45.0a2 09:57:03 INFO - mozversion INFO | platform_buildid: 20160122073132 09:57:03 INFO - mozversion INFO | platform_changeset: 0cd0ae95d865bb1a3f8b49c3e6fff165070d3b7a 09:57:03 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:57:03 INFO - mozversion INFO | platform_version: 45.0a2 09:57:03 INFO - 2016-01-22 09:57:03,169 DEBUG : using testdate: 1453485423 09:57:03 INFO - 2016-01-22 09:57:03,169 DEBUG : actual date: 1453485423 09:57:03 INFO - 2016-01-22 09:57:03,178 INFO : starting webserver on 'localhost:37485' 09:57:03 INFO - 2016-01-22 09:57:03,179 INFO : Starting test suite talos-linux64-ix-033.e 09:57:03 INFO - 2016-01-22 09:57:03,179 INFO : Starting test dromaeo_css 09:57:03 INFO - 2016-01-22 09:57:03,179 DEBUG : operating with platform_type : linux_ 09:57:03 INFO - 2016-01-22 09:57:03,180 INFO : Initialising browser for dromaeo_css test... 09:57:03 INFO - 2016-01-22 09:57:03,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_U0Aes/profile http://localhost:37485/getInfo.html 09:57:07 INFO - 2016-01-22 09:57:07,542 DEBUG : BROWSER_OUTPUT: 09:57:07 INFO - 2016-01-22 09:57:07,542 DEBUG : BROWSER_OUTPUT: (process:21856): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:57:08 INFO - 2016-01-22 09:57:08,628 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:57:08 INFO - 2016-01-22 09:57:08,628 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:57:08 INFO - 2016-01-22 09:57:08,628 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:57:08 INFO - 2016-01-22 09:57:08,628 DEBUG : BROWSER_OUTPUT: __metrics 09:57:09 INFO - 2016-01-22 09:57:09,713 INFO : Browser initialized. 09:57:09 INFO - 2016-01-22 09:57:09,714 INFO : Running cycle 1/1 for dromaeo_css test... 09:57:09 INFO - 2016-01-22 09:57:09,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_U0Aes/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:57:11 INFO - 2016-01-22 09:57:11,046 DEBUG : BROWSER_OUTPUT: 09:57:11 INFO - 2016-01-22 09:57:11,046 DEBUG : BROWSER_OUTPUT: (process:21970): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:57:21 INFO - 2016-01-22 09:57:21,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 136429568 09:57:21 INFO - 2016-01-22 09:57:21,549 DEBUG : BROWSER_OUTPUT: 09:58:11 INFO - 2016-01-22 09:58:11,181 DEBUG : BROWSER_OUTPUT: 1453485491177 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] 10:00:19 INFO - 2016-01-22 10:00:19,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37485/tests/dromaeo/cssquery-ext.html) 10:00:20 INFO - 2016-01-22 10:00:20,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 141225984 10:00:20 INFO - 2016-01-22 10:00:20,469 DEBUG : BROWSER_OUTPUT: 10:03:22 INFO - 2016-01-22 10:03:22,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-ext.html (next: http://localhost:37485/tests/dromaeo/cssquery-jquery.html) 10:03:22 INFO - 2016-01-22 10:03:22,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 10:03:22 INFO - 2016-01-22 10:03:22,863 DEBUG : BROWSER_OUTPUT: 10:06:24 INFO - 2016-01-22 10:06:24,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37485/tests/dromaeo/cssquery-mootools.html) 10:06:25 INFO - 2016-01-22 10:06:25,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 139259904 10:06:25 INFO - 2016-01-22 10:06:25,039 DEBUG : BROWSER_OUTPUT: 10:09:26 INFO - 2016-01-22 10:09:26,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37485/tests/dromaeo/cssquery-prototype.html) 10:09:27 INFO - 2016-01-22 10:09:27,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 10:09:27 INFO - 2016-01-22 10:09:27,209 DEBUG : BROWSER_OUTPUT: 10:12:29 INFO - 2016-01-22 10:12:29,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37485/tests/dromaeo/cssquery-yui.html) 10:12:30 INFO - 2016-01-22 10:12:30,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 140943360 10:12:30 INFO - 2016-01-22 10:12:30,044 DEBUG : BROWSER_OUTPUT: 10:15:31 INFO - 2016-01-22 10:15:31,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/dromaeo/cssquery-yui.html (next: http://localhost:37485/tests/dromaeo/cssquery-dojo.html) 10:15:32 INFO - 2016-01-22 10:15:32,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 142143488 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:15:32 INFO - 2016-01-22 10:15:32,171 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3372.5109859070435;3427.931441371171;3428.1258279138815;3444.655534446555;3449.655034496551;5549.001179787637;5554.944450555493;5558.277423934888;5575.609707320489;5613.522850557697;5597.132444471104;5674.2623458950275;5678.119891416826;5685.8578535536635;5730.79942202023;5094.414142373628;5176.611754118438;5217.295665085203;5225.216217567377;5236;5040.092783299005;5060.165072762989;5156.974215128937;5167.9483205168035;5238.580913526927;5156.123459011958;5236.476352364771;5242.082635538784;5251.081060814342;5256.290400795881;5246.1868410396255;5297.5232229099565;5314.83073723784;5315.3621565412395;5331.893362132736;5010.498950104997;5038.823641172541;5087.56755675768;5161.4322424533275;5187.3775146982225;5448.891022179534;5496.395396506381;5516.475934786189;5552.86117847053;5563.610547261694;6144.446999769997;6165.784197553064;6193;6214.285357183937;6231.345708700566;5965.940340596625;6021.096835474714;6110.358412366682;6138.633639632459;6243;5792.362840087545;5799.043157878987;5818.272715910512;5831.475167234927;5832.737526811304;6259.374062593704;6277.686115694289;6280.811575652738;6284.937150628527;6288.339724328971;5751.079827227623;5846.8538286542325;5923.733431995571;5963.79126730571;6007.759689612367;6047.637141771508;6130.724117414727;6139.6009259398;6145.631262124287;6157.415045570664;5797.652140871477;6023.728932197974;6091.329953705089;6126.479249263773;6128.877422451526;6015.30823955242;6020.57855950088;6133.212252453595;6143.447089761943;6147.385261473817;4662.580367766917;4670.276107203389;4681.157391669464;4701.553352431513;4706.105839890478;4081.2653722330265;4180.080382315886;4190.455240818674;4200.537940826506;4238.809253583596;5594.384617692051;5626.099824028136;5642.125470552071;5666.660000399989;5685.573581981368;6071.9696401518595;6139.785107521216;6167.352427994996;6174.753009879644;6176.969115154486;5718.971405143031;5725.227094342211;5750.108733146369;5805.187273781674;5878.764849405976;5182.274481572583;5206.167013277857;5266.052110620125;5268.078086334876;5384.246205531229;6263.498920086382;6266.717997690115;6284.277308109535;6289.811305660837;6300.495960323163;5981.1327357532045;6075.453209211192;6089.817305480843;6118.510519158456;6166.044263139221;6148.938510615016;6287.497000240061;6359.109724638647;6367.044943258548;6403.6798160090875;6083.726232319645;6116.602420842631;6120.724567394389;6166.876662466636;6170;5847.502962248086;5972.432618901197;6025.126356678345;6212.47193988516;6228.719707613259;6021.969890150521;6067.4539291462215;6077.756889724362;6087.068956942918;6121.081837724377;5725.942740572707;5933.851653708692;6038.184845045863;6056.5154787616;6074.119252708421;5813.534917206529;5824.184614154106;5863.736131874161;5885.735141918538;5960.105984102419;5961.195238642727;5961.463468287875;5985.461308482258;6017.819465416044;6036.577439579188;5686.545076393962;5833.883322333614;5898.469137777621;5904.9704751475965;5906.881862362815 10:15:32 INFO - 2016-01-22 10:15:32,172 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.3193791016151;619.3899009475666;626.2078470734521;649.7920665387072;652.7715299645122;41627;42446.57553424465;42483.575164248345;42502.14995700084;42722;46070;46160.538394616044;46690.533094669125;46843.76578117113;46986.76506617462;9052.094790520945;9278.675246366378;9289.535523223813;9290.907090929106;9327.347085704003;7545.924540754604;7547.094348678166;7560.810979725524;7583.469157158974;7660;9130.863037054416;9185.586648600796;9246.953765231197;9253;9254.167124958753;9129;9132.223760980325;9142.72571822843;9152.084791520861;9215.124563166488;9069.410488318239;9138.360314777969;9187.448753074837;9194.35639505235;9224.907750922472;43270.35094473585;43719;43842.56157438448;44010;44018.559814401764;3560.7151427885965;3587.964120358789;3594.730395220343;3600.8919732407808;3604.8017359045243;32163;32232;32608.836955815306;32816.835915820266;33181;3797.3354662933875;3851.826667799956;3872.8644497442456;3911.7066220033325;3935.626115519021;269506;270374;270953;271249;271292;45442;45711.62865114052;45806.31290530645;45862.54137458649;45934.540654593024;43090.35364469535;43139;43167.78416107899;43417.56582434135;43429.34855977163;15000.474983375529;15141.848581514265;15163.09021458716;15187.696246075016;15219.315130819139;12664.74670506603;12829;12877.034222433167;12947.287899165449;12953.158044727063;15366.385344586091;15406.383744650313;15603.063816171067;15635.140067296408;15671.220277815148;6068.423499767515;6197.659128747962;6232.158658581034;6253.155823963707;6355.841103972438;959.3524371049514;977.9119879210905;1000.8140353680911;1098.5441041967654;1105.1214284643727;29571.408571828444;29571.85214073959;29689.554656680168;30103.397932041236;30225.848870755504;1024.8411496218098;1063.2982231727178;1085.6742977106837;1145.7135716070982;1163.7730642524627;15634.609134771494;15816.76274855878;16012.67974640524;16088.597785055466;16098.597535061717;514378;517983;545226;547666;548272;59611.70194149001;60377.39622603806;60398.69800650969;60448.093278600856;60572;1486.51688201335;1506.713724392384;1510.2750679673818;1514.3336931749996;1528.2511569330948;31467.527987079753;32132.67867321297;32489;33179.33641327208;35034.64965350314;54332.45667543432;54422.45577544332;55009.1748623779;55233.72383138059;55261.17108243299;311362;312884;314052.71894562437;314203;314347;45217.32174017327;46164.53835461602;46348.53651463577;46689.06621867612;47066;47954;48807;49112.50887491222;49472.75263623659;49483;41084.58915410927;41232.58767412287;41307.38038929478;41322.58677413187;42330;40193;40398.79800600978;40523.1895362097;40630.79684601558;40647.59352406438;40198.59801401949;40637.59362406456;40670.186596268504;40726.79636601798;40958.18083638251;36332.81833590815;36413.635863642085;36475.81762091172;37206;37349.43975840419;28291.71708282891;28479.28801779889;28741.56887646729;28762.856185718938;28984.565231521123 10:15:32 INFO - 2016-01-22 10:15:32,173 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.2910644414277;385.3027414240269;390.36955317162784;391.11802884495467;391.3171515705095;16167.353305867751;17328.653426931454;17733;18527;18577;12145.514179432834;12493;12614.369281535932;16422.75365869513;17082.572935676613;5169.948300516994;5315.6013299002725;5379.67721936685;5403.405625381205;5826.242588463515;5439.700816455093;5581.49766521013;5582.7766889324375;5607.102863541834;5739.856503587423;5490.396056433789;5516.282883225175;5682.289713785777;6208.192934918454;6278.434940855322;6184.536159788034;6202.534809889254;6230.968845155768;6235.6258624482225;6256.499480041586;5491.780328786844;5581.6930068846195;5639.605227634026;5661.60368774186;5734.053881109612;13816.585502434944;13901.652458688513;13954.790678139836;14448.422063117463;14558.92720536401;2162.2648299578063;2172.663237198237;2237.272886311955;2285.725712914444;2327.8836058197194;10491.685249442453;10493.580256789719;10520.894791052144;10813.567457301699;12214.083943704258;1993.9900300498405;2003.6894281386408;2037.8879161646103;2040.9387718368473;2048.98975505123;63157.68421157911;64746.02880956789;65358.673206634136;65373;66124.3387566123;10980.670579882457;11261.268017578832;11303.491342889589;11332.43337833105;11371.488283027284;14902.254887255594;14916;14933.029353092232;14959.700805983819;14976.70046599062;8165.79585510367;8190.959045204855;8250.504969701837;8264.380171487042;8276.917230827736;7797.142314345418;7800;7897.763067107996;7919.920800791919;7974.880376794353;4711.81152753886;4727.621790256771;4781.187198176319;4805.063012712558;4891.828785992473;1921.3563456242036;1944.562473443464;1947.3087054095874;1978.4757039384574;1981;453.5872356155882;459.2789320766432;460.8340997240991;847.8007668197969;942.9533218127873;10759.683415277686;11666.300021998708;11833.822492662617;11909.642710718692;11945.104117191246;480.9422869255642;499.9125153098266;503.2174967924912;506.8428787076018;531.7102179312284;6278.811635650938;6335.936640633627;6344.397282258178;6390.265119511223;6462.030695395634;617762;631739;633327;633959;637481;83513.58243208866;83723.5813820927;84638.15361846426;87003;87800;568.1421054208175;572.4075581772845;575.536692962161;575.7984705353093;576.0897781505212;10792.622258220925;10967.396793176453;11003.119750420108;11035.503402347074;11058.060064894575;33902.66097338995;34324;35209.82395088008;35318.82340588281;35759;49310.75344623254;49512;49814.50185498244;49902.75048624879;53410;10209.183265338903;10256.28206025601;10328.431936243578;10387.013233742782;10487.52806123711;13666;14417.495387661382;16228.107454090139;17063.658726825146;17842.91078544599;15230.847691523386;15413.922930385277;15416.845831541541;15526.844731552992;15581.454649087227;15009.624759381102;15066.849331506983;15180.696386072437;15686;15749.370025198863;12614.873851261369;16121.435749748702;16352.591185220464;16488.25802838899;16608.086555239577;9822.116009559173;9834.311598188344;9850.408975461209;9861.457619830691;9988.800223995624;12941.352932353157;15502.224888755292;15617.531474055797;15737.134457604941;16077.115758633387 10:15:32 INFO - 2016-01-22 10:15:32,174 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1583.0897234090394;1596.0742769193869;1813.9183736731848;1832.1846778183713;1861.6649003179427;7709.537427754339;8102.878456823152;8127.4717143385715;8301.83396332073;8387.370947178963;7968.721094761684;8055.31529819966;8094.231048050426;8128.4310098293145;8158.1433949435195;2427.126234555563;2461.0155937624913;2464.2114523352534;2466.0135945621714;2473.925782226527;2435.6833611630464;2439;2439.121916110199;2467.7408872068445;2473.678421805163;2061.288855344911;2104.6842973553935;2397.280815755275;2398.0647547456506;2414.3239892829947;2367.6093444581625;2382.749811269809;2383.261189031397;2396.6165413533927;2400.147947478646;2381.7380088190284;2418.238254949685;2429.1983645396976;2436.610142377229;2443.5723748343967;7838.137804841463;7938.6427610757655;7946.562939038351;7950.363970882316;7963.044434667819;4883.340748998875;4977.800887964477;4979.875503112415;4992.326035985132;4996.975015124937;3137.043201823443;3211.823349715765;3218.806871587712;3227.644959054502;3248.1717162123746;1065.6802959112235;1071.9892801071967;1082.5615625671617;1083.2038451737967;1087.190043417651;11025.117990560735;11157.888421115847;11185.105191584653;11194.888051119548;11240.100791936708;4558.384618076583;4570.588647021784;4573.314002899525;4636.79134438951;4641.094986477605;9653.420794752197;9671.661491847752;9728.270379721549;9742;9779.755506112262;5066.392032955995;5105.463926287761;5122.487751224848;5128.564072053842;5149.536541711189;4616.099860527165;4628.282616194495;4655.720656760605;4660.813567457264;4661.324108004321;3854.325493038707;3912.4522566840665;3929.351656976624;3951.7431366961055;3963.4847469828737;1264.6648638110908;1280.1167194635857;1294.6051454306528;1299.857015728269;1303.5633062923837;1107.595727559435;1127.2841745491507;1136.8863113688565;1250.774860525096;1253.7053792358788;7662.080550333995;7729.729459468892;7747.883781743279;7749.4575379724;7792.766217013385;1151.9654410367534;1156.843826083468;1173.3487914207697;1173.923694959842;1177.0642339340245;6174.104754810617;6180.598261113013;6199.008158694587;6224.06639004153;6228.906566401417;9453.858192127123;9847.359921605073;9896.505174741234;9911.900880991241;9990.150837178775;9686.70939871805;9708.223342132613;9779.706608801747;9821.459819709842;9829.115379615869;7490.85018299631;7589.544627322378;7631.465797394129;7638.809029774189;7645.503042302233;7663.195364486872;7758.92241077582;7775.533467991939;7818.960905195438;7827.25641064098;8637.309015278888;8709;8805.823883522422;8841.115888411108;8857.512836794038;8788.604512797066;8909.1536304051;8944.642214311354;8971.878515185601;9192.724218273463;7240.348368646847;7316.158641756053;7321.450891183076;7329.706811727685;7335.119785625546;7921.722739704082;7981.561014144278;7984;7996.280334769898;8020.83958320842;7512.849743005218;7549.358304544176;7575.469717119749;7605.277498637621;7696.422768292288;7289.380402665833;7393.704251829867;7436.256374362521;7475.0656167979005;7479.626018698935;7398.371138453292;7412.666430010555;7434.553926764195;7441.367483763941;7459.664315105725;6892.138482689664;6914.204866440424;6932.549384290005;6991.510594258353;6995.125609298838;6977.302269773185;7024.789256322319;7081.504294699322;7083.468739844635;7090.4327653788605 10:15:32 INFO - 2016-01-22 10:15:32,175 DEBUG : BROWSER_OUTPUT: |4;prototype.html;358.0850925884365;362.3351150638578;365.6818567845973;365.9176685245819;366.3113346907813;6271.742172817782;6359.936400635992;6376.298607153215;6382.010788327811;6387.690523442695;6135.631862088278;6335.271443783966;6343.175387199658;6357.110004599348;6358.872822543546;4864.7324397158145;4903.53416425439;4905;4911.631627627924;4916.237983112624;4902.411710594716;4905.533974272438;4919.11455937931;4922;4923.753812309388;4669.766511674419;4787.1622466068475;4791.257355109946;4817.542333478314;4828.299896515004;4802.97598512007;4806.375171227735;4808;4808.3027960945465;4823.517648235166;4184.142250838601;4184.4141820145205;4191.811368488426;4195.832166713328;4215.093754842724;5951.464368206882;6013.977623803964;6023.638581685069;6025.9096113558335;6028.0957856321465;5575.832725018216;5614.831555053314;5618.101103823409;5618.38197798246;5632.098864181752;6638.601683898982;6677.565958212701;6713.328667133296;6713.395794378481;6724.260331363546;4670.626349892001;4675.228587283094;4685.4143232095985;4702.3181638662545;4702.5297470253045;6881.65591720412;6939.6877140528795;6965.89551156728;6990.056342393763;6990.720371185146;4747.098051370229;4765.8570242892765;4770.451398089194;4771.976140119277;4784.330193772875;4800.423949126127;4847.854564363004;4849.539293767087;4855.660103792771;4863.829765958175;5496.065668836308;5615.438456154434;5617.045102332613;5619.353774316006;5625.578081643811;6724;6741.831454213684;6765.9661701691175;6774.119364482684;6775.390214880685;1583.208395802099;1609.8390160984043;1714.665640200149;1731.9307227711001;1732.5322163015915;1186.454231053725;1190.8987736042534;1204.3315959642307;1206.811290878484;1207.1368971185468;6433.581817181868;6473.190851143607;6482.416582507597;6483.643399613066;6494.350564943468;6855.108835851307;6890.827729306707;6918.377346038881;6922.376986071277;6926.896096558556;6374.330695276929;6416.903746443807;6447.967760161169;6452.225732911987;6490.415862572391;3727.7763334200035;3731.253749250161;3757.9436308455397;3761.5674197467642;3777.697784177259;7077.893831592531;7110.288971102848;7115.53749006313;7122.60825654594;7126.180489243699;6971.3028697129885;7078.787636370917;7080.539764915264;7092.4680648951535;7099.290070992859;7057.682404291819;7079.115110611174;7090.113735783028;7118.71525138999;7137.857242855114;6892.207396149507;6903.378695917391;6922.653867306513;6930;6932.549384290005;6743;6815.2162501311;6837.965810170917;6929.237783843672;6962.268961758942;7214.675339609626;7251.782446526613;7280.927190728236;7292.234315396807;7296.598687072262;4644.164050470813;4665.650076244363;4666.300054991642;4679.532046795293;4693.460252070919;6811.318868113149;6905.620190889549;7056.682449289897;7059.764541205166;7062.329078737512;6798.422134118655;6798.93201067983;6840.179178498612;6853.211880633791;6886.655667216519;6851.691673874788;6855.451563874778;6876.106106206161;6881.827954301182;6886.24251332363;6633.270340262471;6677.565958212701;6761.087253220949;6769.796906092825;6774.153230846145;6821.420179284816;6883.242843287134;6891.655417229018;6898.2756810536175;6916.170059592881;6694.230163531256;6711.429528489938;6731.932680673131;6747.460203183636;6752.493562982698 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: |5;yui.html;762.4205603741156;767.5356409372333;789.2738680414019;807.5558442856432;898.4070513461116;13842.723145537097;14075.436982520687;14107.576772696822;14110.153390796559;14137.57587272381;11731.941340293286;11859.940700296487;11900;12007.939960300208;12051.517939282418;907.0566610724871;915.6337465013982;927.4388994658202;931.0503286647615;933.7992331648694;938.6855403439856;941.1341565759484;944.0512285153411;946.7869729310919;951.6526467839258;949.2500924269818;954.7517645412173;957.4351132831628;957.6313119449028;961.9086186812276;951.1249650321686;952.2715122930963;954.0316578672653;954.7040417470606;956.2588993530001;706.5725236232057;707.9292070792931;708.8936659501064;709.4678990756933;711.6157275071507;13124.475020999149;13148.408321625455;13164.341782910911;13240.470381184741;13257.535986240435;11736.53053877844;12299.815502767466;12446.377681115908;12610.873891261153;12647.0514711397;10116.494175291205;10284.228682848816;10297.124744396735;10361.89638103617;10656.786864262749;3196.488561830119;3263.96736032639;3269.4605390110605;3293.6541663125267;3358.647342029101;47788;47969.99999999965;48597;48829.755851220514;49056.50943490591;9943.403395796275;10014.298999069995;10156.542955567018;10236.436995965294;10347.327423717434;18236.361727339743;18290.908545457187;18317.450476485727;18331.358402456117;18334.633307333777;6623.933760662428;6768.2216545097945;6901.585904845725;6911.6544172791155;7065.43476521877;4143.02638879863;4174.08170202555;4176.248275310412;4224.704270701021;4282.186384586918;3152.6689697581883;3194.2653189766484;3195.6804319568323;3201.183698157002;3204.599425071866;578.2482772395869;582.496140838172;592.5437413191818;596.2814808156162;603.3333166850567;563.844942640777;601.7863658401292;623.233422889848;629.1475051305507;629.4995478594528;8015.519068855887;8245.546494942835;8265.586720663943;8365.8326833463;8381.139216677124;631.4159402552621;650.3596836571099;655.6361219523116;656.7537173559915;672.1866541484858;3785.337565925952;3872.3223435898603;4054.614811592894;4057.229126465962;4295.82816687329;55398.44601554013;56240.43759562434;56623.150652740245;56941.43058569444;57004;49943;49947.75339602914;50395;53364.46635533595;53841.73079134658;46439.30341044887;47841.5215847844;47994.28008579874;48253.51746482561;48313.75843120762;8159.26566609008;8340.749777506684;8376.078631350425;8521.02008269057;8569.914300856912;34479.65520344764;34596.82701586476;35417.64582354143;35543;36525.08687282839;44763.55236447594;45733.54266457293;45757.54242457533;46063.078738424374;46697.53302466932;9940.155086817702;10044.799104018024;10054.64808731691;10113.089821916063;10397.844032339672;11248.325100493996;11448.94275528617;11483.770324593628;11497.54009839597;11657.650270491898;10549.367037977747;10551.103156231806;10631.787364252827;10704.197185211297;10760.139188865029;10713.89286107129;10726.946365268435;10769.892301077203;10899.673009809718;11400.973912347928;10106.343087699275;10374.325668831501;10384.93201945865;10684.786304274026;10836.67489975302;9615.9038409615;9754.122129008423;9763.60945562198;9784.266180036668;9793.069658382443;9297.907020929704;9510.191633710936;9602.95198524003;9628.855567166638;9672.129508344282 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486532167__endTimestamp 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,177 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5665.67 Median:5847.50 stddev:633.25 (10.8%) stddev-sans-first:609.10 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: Values: 3372.5 3427.9 3428.1 3444.7 3449.7 5549.0 5554.9 5558.3 5575.6 5613.5 5597.1 5674.3 5678.1 5685.9 5730.8 5094.4 5176.6 5217.3 5225.2 5236.0 5040.1 5060.2 5157.0 5167.9 5238.6 5156.1 5236.5 5242.1 5251.1 5256.3 5246.2 5297.5 5314.8 5315.4 5331.9 5010.5 5038.8 5087.6 5161.4 5187.4 5448.9 5496.4 5516.5 5552.9 5563.6 6144.4 6165.8 6193.0 6214.3 6231.3 5965.9 6021.1 6110.4 6138.6 6243.0 5792.4 5799.0 5818.3 5831.5 5832.7 6259.4 6277.7 6280.8 6284.9 6288.3 5751.1 5846.9 5923.7 5963.8 6007.8 6047.6 6130.7 6139.6 6145.6 6157.4 5797.7 6023.7 6091.3 6126.5 6128.9 6015.3 6020.6 6133.2 6143.4 6147.4 4662.6 4670.3 4681.2 4701.6 4706.1 4081.3 4180.1 4190.5 4200.5 4238.8 5594.4 5626.1 5642.1 5666.7 5685.6 6072.0 6139.8 6167.4 6174.8 6177.0 5719.0 5725.2 5750.1 5805.2 5878.8 5182.3 5206.2 5266.1 5268.1 5384.2 6263.5 6266.7 6284.3 6289.8 6300.5 5981.1 6075.5 6089.8 6118.5 6166.0 6148.9 6287.5 6359.1 6367.0 6403.7 6083.7 6116.6 6120.7 6166.9 6170.0 5847.5 5972.4 6025.1 6212.5 6228.7 6022.0 6067.5 6077.8 6087.1 6121.1 5725.9 5933.9 6038.2 6056.5 6074.1 5813.5 5824.2 5863.7 5885.7 5960.1 5961.2 5961.5 5985.5 6017.8 6036.6 5686.5 5833.9 5898.5 5905.0 5906.9 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,178 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54329.70 Median:41314.98 stddev:103560.07 (250.7%) stddev-sans-first:103772.01 10:15:32 INFO - 2016-01-22 10:15:32,179 DEBUG : BROWSER_OUTPUT: Values: 602.3 619.4 626.2 649.8 652.8 41627.0 42446.6 42483.6 42502.1 42722.0 46070.0 46160.5 46690.5 46843.8 46986.8 9052.1 9278.7 9289.5 9290.9 9327.3 7545.9 7547.1 7560.8 7583.5 7660.0 9130.9 9185.6 9247.0 9253.0 9254.2 9129.0 9132.2 9142.7 9152.1 9215.1 9069.4 9138.4 9187.4 9194.4 9224.9 43270.4 43719.0 43842.6 44010.0 44018.6 3560.7 3588.0 3594.7 3600.9 3604.8 32163.0 32232.0 32608.8 32816.8 33181.0 3797.3 3851.8 3872.9 3911.7 3935.6 269506.0 270374.0 270953.0 271249.0 271292.0 45442.0 45711.6 45806.3 45862.5 45934.5 43090.4 43139.0 43167.8 43417.6 43429.3 15000.5 15141.8 15163.1 15187.7 15219.3 12664.7 12829.0 12877.0 12947.3 12953.2 15366.4 15406.4 15603.1 15635.1 15671.2 6068.4 6197.7 6232.2 6253.2 6355.8 959.4 977.9 1000.8 1098.5 1105.1 29571.4 29571.9 29689.6 30103.4 30225.8 1024.8 1063.3 1085.7 1145.7 1163.8 15634.6 15816.8 16012.7 16088.6 16098.6 514378.0 517983.0 545226.0 547666.0 548272.0 59611.7 60377.4 60398.7 60448.1 60572.0 1486.5 1506.7 1510.3 1514.3 1528.3 31467.5 32132.7 32489.0 33179.3 35034.6 54332.5 54422.5 55009.2 55233.7 55261.2 311362.0 312884.0 314052.7 314203.0 314347.0 45217.3 46164.5 46348.5 46689.1 47066.0 47954.0 48807.0 49112.5 49472.8 49483.0 41084.6 41232.6 41307.4 41322.6 42330.0 40193.0 40398.8 40523.2 40630.8 40647.6 40198.6 40637.6 40670.2 40726.8 40958.2 36332.8 36413.6 36475.8 37206.0 37349.4 28291.7 28479.3 28741.6 28762.9 28984.6 10:15:32 INFO - 2016-01-22 10:15:32,180 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,180 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31499.12 Median:385.30 stddev:103134.31 (26767.5%) stddev-sans-first:103397.17 10:15:32 INFO - 2016-01-22 10:15:32,180 DEBUG : BROWSER_OUTPUT: Values: 385.3 385.3 390.4 391.1 391.3 16167.4 17328.7 17733.0 18527.0 18577.0 12145.5 12493.0 12614.4 16422.8 17082.6 5169.9 5315.6 5379.7 5403.4 5826.2 5439.7 5581.5 5582.8 5607.1 5739.9 5490.4 5516.3 5682.3 6208.2 6278.4 6184.5 6202.5 6231.0 6235.6 6256.5 5491.8 5581.7 5639.6 5661.6 5734.1 13816.6 13901.7 13954.8 14448.4 14558.9 2162.3 2172.7 2237.3 2285.7 2327.9 10491.7 10493.6 10520.9 10813.6 12214.1 1994.0 2003.7 2037.9 2040.9 2049.0 63157.7 64746.0 65358.7 65373.0 66124.3 10980.7 11261.3 11303.5 11332.4 11371.5 14902.3 14916.0 14933.0 14959.7 14976.7 8165.8 8191.0 8250.5 8264.4 8276.9 7797.1 7800.0 7897.8 7919.9 7974.9 4711.8 4727.6 4781.2 4805.1 4891.8 1921.4 1944.6 1947.3 1978.5 1981.0 453.6 459.3 460.8 847.8 943.0 10759.7 11666.3 11833.8 11909.6 11945.1 480.9 499.9 503.2 506.8 531.7 6278.8 6335.9 6344.4 6390.3 6462.0 617762.0 631739.0 633327.0 633959.0 637481.0 83513.6 83723.6 84638.2 87003.0 87800.0 568.1 572.4 575.5 575.8 576.1 10792.6 10967.4 11003.1 11035.5 11058.1 33902.7 34324.0 35209.8 35318.8 35759.0 49310.8 49512.0 49814.5 49902.8 53410.0 10209.2 10256.3 10328.4 10387.0 10487.5 13666.0 14417.5 16228.1 17063.7 17842.9 15230.8 15413.9 15416.8 15526.8 15581.5 15009.6 15066.8 15180.7 15686.0 15749.4 12614.9 16121.4 16352.6 16488.3 16608.1 9822.1 9834.3 9850.4 9861.5 9988.8 12941.4 15502.2 15617.5 15737.1 16077.1 10:15:32 INFO - 2016-01-22 10:15:32,180 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,180 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5784.46 Median:6903.17 stddev:2959.53 (42.9%) stddev-sans-first:2950.98 10:15:32 INFO - 2016-01-22 10:15:32,181 DEBUG : BROWSER_OUTPUT: Values: 1583.1 1596.1 1813.9 1832.2 1861.7 7709.5 8102.9 8127.5 8301.8 8387.4 7968.7 8055.3 8094.2 8128.4 8158.1 2427.1 2461.0 2464.2 2466.0 2473.9 2435.7 2439.0 2439.1 2467.7 2473.7 2061.3 2104.7 2397.3 2398.1 2414.3 2367.6 2382.7 2383.3 2396.6 2400.1 2381.7 2418.2 2429.2 2436.6 2443.6 7838.1 7938.6 7946.6 7950.4 7963.0 4883.3 4977.8 4979.9 4992.3 4997.0 3137.0 3211.8 3218.8 3227.6 3248.2 1065.7 1072.0 1082.6 1083.2 1087.2 11025.1 11157.9 11185.1 11194.9 11240.1 4558.4 4570.6 4573.3 4636.8 4641.1 9653.4 9671.7 9728.3 9742.0 9779.8 5066.4 5105.5 5122.5 5128.6 5149.5 4616.1 4628.3 4655.7 4660.8 4661.3 3854.3 3912.5 3929.4 3951.7 3963.5 1264.7 1280.1 1294.6 1299.9 1303.6 1107.6 1127.3 1136.9 1250.8 1253.7 7662.1 7729.7 7747.9 7749.5 7792.8 1152.0 1156.8 1173.3 1173.9 1177.1 6174.1 6180.6 6199.0 6224.1 6228.9 9453.9 9847.4 9896.5 9911.9 9990.2 9686.7 9708.2 9779.7 9821.5 9829.1 7490.9 7589.5 7631.5 7638.8 7645.5 7663.2 7758.9 7775.5 7819.0 7827.3 8637.3 8709.0 8805.8 8841.1 8857.5 8788.6 8909.2 8944.6 8971.9 9192.7 7240.3 7316.2 7321.5 7329.7 7335.1 7921.7 7981.6 7984.0 7996.3 8020.8 7512.8 7549.4 7575.5 7605.3 7696.4 7289.4 7393.7 7436.3 7475.1 7479.6 7398.4 7412.7 7434.6 7441.4 7459.7 6892.1 6914.2 6932.5 6991.5 6995.1 6977.3 7024.8 7081.5 7083.5 7090.4 10:15:32 INFO - 2016-01-22 10:15:32,182 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,182 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5638.26 Median:6402.30 stddev:1700.76 (26.6%) stddev-sans-first:1658.71 10:15:32 INFO - 2016-01-22 10:15:32,182 DEBUG : BROWSER_OUTPUT: Values: 358.1 362.3 365.7 365.9 366.3 6271.7 6359.9 6376.3 6382.0 6387.7 6135.6 6335.3 6343.2 6357.1 6358.9 4864.7 4903.5 4905.0 4911.6 4916.2 4902.4 4905.5 4919.1 4922.0 4923.8 4669.8 4787.2 4791.3 4817.5 4828.3 4803.0 4806.4 4808.0 4808.3 4823.5 4184.1 4184.4 4191.8 4195.8 4215.1 5951.5 6014.0 6023.6 6025.9 6028.1 5575.8 5614.8 5618.1 5618.4 5632.1 6638.6 6677.6 6713.3 6713.4 6724.3 4670.6 4675.2 4685.4 4702.3 4702.5 6881.7 6939.7 6965.9 6990.1 6990.7 4747.1 4765.9 4770.5 4772.0 4784.3 4800.4 4847.9 4849.5 4855.7 4863.8 5496.1 5615.4 5617.0 5619.4 5625.6 6724.0 6741.8 6766.0 6774.1 6775.4 1583.2 1609.8 1714.7 1731.9 1732.5 1186.5 1190.9 1204.3 1206.8 1207.1 6433.6 6473.2 6482.4 6483.6 6494.4 6855.1 6890.8 6918.4 6922.4 6926.9 6374.3 6416.9 6448.0 6452.2 6490.4 3727.8 3731.3 3757.9 3761.6 3777.7 7077.9 7110.3 7115.5 7122.6 7126.2 6971.3 7078.8 7080.5 7092.5 7099.3 7057.7 7079.1 7090.1 7118.7 7137.9 6892.2 6903.4 6922.7 6930.0 6932.5 6743.0 6815.2 6838.0 6929.2 6962.3 7214.7 7251.8 7280.9 7292.2 7296.6 4644.2 4665.7 4666.3 4679.5 4693.5 6811.3 6905.6 7056.7 7059.8 7062.3 6798.4 6798.9 6840.2 6853.2 6886.7 6851.7 6855.5 6876.1 6881.8 6886.2 6633.3 6677.6 6761.1 6769.8 6774.2 6821.4 6883.2 6891.7 6898.3 6916.2 6694.2 6711.4 6731.9 6747.5 6752.5 10:15:32 INFO - 2016-01-22 10:15:32,182 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,182 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13715.68 Median:47905.76 stddev:16085.47 (33.6%) stddev-sans-first:16101.19 10:15:32 INFO - 2016-01-22 10:15:32,183 DEBUG : BROWSER_OUTPUT: Values: 762.4 767.5 789.3 807.6 898.4 13842.7 14075.4 14107.6 14110.2 14137.6 11731.9 11859.9 11900.0 12007.9 12051.5 907.1 915.6 927.4 931.1 933.8 938.7 941.1 944.1 946.8 951.7 949.3 954.8 957.4 957.6 961.9 951.1 952.3 954.0 954.7 956.3 706.6 707.9 708.9 709.5 711.6 13124.5 13148.4 13164.3 13240.5 13257.5 11736.5 12299.8 12446.4 12610.9 12647.1 10116.5 10284.2 10297.1 10361.9 10656.8 3196.5 3264.0 3269.5 3293.7 3358.6 47788.0 47970.0 48597.0 48829.8 49056.5 9943.4 10014.3 10156.5 10236.4 10347.3 18236.4 18290.9 18317.5 18331.4 18334.6 6623.9 6768.2 6901.6 6911.7 7065.4 4143.0 4174.1 4176.2 4224.7 4282.2 3152.7 3194.3 3195.7 3201.2 3204.6 578.2 582.5 592.5 596.3 603.3 563.8 601.8 623.2 629.1 629.5 8015.5 8245.5 8265.6 8365.8 8381.1 631.4 650.4 655.6 656.8 672.2 3785.3 3872.3 4054.6 4057.2 4295.8 55398.4 56240.4 56623.2 56941.4 57004.0 49943.0 49947.8 50395.0 53364.5 53841.7 46439.3 47841.5 47994.3 48253.5 48313.8 8159.3 8340.7 8376.1 8521.0 8569.9 34479.7 34596.8 35417.6 35543.0 36525.1 44763.6 45733.5 45757.5 46063.1 46697.5 9940.2 10044.8 10054.6 10113.1 10397.8 11248.3 11448.9 11483.8 11497.5 11657.7 10549.4 10551.1 10631.8 10704.2 10760.1 10713.9 10726.9 10769.9 10899.7 11401.0 10106.3 10374.3 10384.9 10684.8 10836.7 9615.9 9754.1 9763.6 9784.3 9793.1 9297.9 9510.2 9603.0 9628.9 9672.1 10:15:32 INFO - 2016-01-22 10:15:32,183 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:15:32 INFO - 2016-01-22 10:15:32,184 DEBUG : BROWSER_OUTPUT: 10:15:32 INFO - 2016-01-22 10:15:32,922 INFO : Browser exited with error code: 0 10:15:32 INFO - 2016-01-22 10:15:32,945 INFO : Completed test dromaeo_css (00:18:29) 10:15:32 INFO - 2016-01-22 10:15:32,945 INFO : Starting test kraken 10:15:32 INFO - 2016-01-22 10:15:32,945 DEBUG : operating with platform_type : linux_ 10:15:32 INFO - 2016-01-22 10:15:32,946 INFO : Initialising browser for kraken test... 10:15:32 INFO - 2016-01-22 10:15:32,952 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPSishg/profile http://localhost:37485/getInfo.html 10:15:37 INFO - 2016-01-22 10:15:37,074 DEBUG : BROWSER_OUTPUT: 10:15:37 INFO - 2016-01-22 10:15:37,074 DEBUG : BROWSER_OUTPUT: (process:22240): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:15:38 INFO - 2016-01-22 10:15:38,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:15:38 INFO - 2016-01-22 10:15:38,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:15:38 INFO - 2016-01-22 10:15:38,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:15:38 INFO - 2016-01-22 10:15:38,060 DEBUG : BROWSER_OUTPUT: __metrics 10:15:39 INFO - 2016-01-22 10:15:39,185 INFO : Browser initialized. 10:15:39 INFO - 2016-01-22 10:15:39,186 INFO : Running cycle 1/1 for kraken test... 10:15:39 INFO - 2016-01-22 10:15:39,186 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPSishg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:15:40 INFO - 2016-01-22 10:15:40,484 DEBUG : BROWSER_OUTPUT: 10:15:40 INFO - 2016-01-22 10:15:40,484 DEBUG : BROWSER_OUTPUT: (process:22354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:15:50 INFO - 2016-01-22 10:15:50,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 135999488 10:15:50 INFO - 2016-01-22 10:15:50,993 DEBUG : BROWSER_OUTPUT: 10:15:53 INFO - 2016-01-22 10:15:53,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37485/tests/kraken/driver.html?testName=audio-beat-detection) 10:15:54 INFO - 2016-01-22 10:15:54,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 10:15:54 INFO - 2016-01-22 10:15:54,070 DEBUG : BROWSER_OUTPUT: 10:15:56 INFO - 2016-01-22 10:15:56,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37485/tests/kraken/driver.html?testName=audio-dft) 10:15:57 INFO - 2016-01-22 10:15:57,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920 10:15:57 INFO - 2016-01-22 10:15:57,254 DEBUG : BROWSER_OUTPUT: 10:16:00 INFO - 2016-01-22 10:16:00,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37485/tests/kraken/driver.html?testName=audio-fft) 10:16:00 INFO - 2016-01-22 10:16:00,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 138756096 10:16:00 INFO - 2016-01-22 10:16:00,620 DEBUG : BROWSER_OUTPUT: 10:16:02 INFO - 2016-01-22 10:16:02,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37485/tests/kraken/driver.html?testName=audio-oscillator) 10:16:03 INFO - 2016-01-22 10:16:03,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 10:16:03 INFO - 2016-01-22 10:16:03,225 DEBUG : BROWSER_OUTPUT: 10:16:05 INFO - 2016-01-22 10:16:05,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:05 INFO - 2016-01-22 10:16:05,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 138457088 10:16:05 INFO - 2016-01-22 10:16:05,994 DEBUG : BROWSER_OUTPUT: 10:16:08 INFO - 2016-01-22 10:16:08,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37485/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:09 INFO - 2016-01-22 10:16:09,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 139624448 10:16:09 INFO - 2016-01-22 10:16:09,520 DEBUG : BROWSER_OUTPUT: 10:16:12 INFO - 2016-01-22 10:16:12,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37485/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:13 INFO - 2016-01-22 10:16:13,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 10:16:13 INFO - 2016-01-22 10:16:13,408 DEBUG : BROWSER_OUTPUT: 10:16:16 INFO - 2016-01-22 10:16:16,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37485/tests/kraken/driver.html?testName=json-parse-financial) 10:16:16 INFO - 2016-01-22 10:16:16,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 138117120 10:16:16 INFO - 2016-01-22 10:16:16,814 DEBUG : BROWSER_OUTPUT: 10:16:18 INFO - 2016-01-22 10:16:18,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:18 INFO - 2016-01-22 10:16:18,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 139182080 10:16:18 INFO - 2016-01-22 10:16:18,974 DEBUG : BROWSER_OUTPUT: 10:16:20 INFO - 2016-01-22 10:16:20,729 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:21 INFO - 2016-01-22 10:16:21,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 138641408 10:16:21 INFO - 2016-01-22 10:16:21,352 DEBUG : BROWSER_OUTPUT: 10:16:23 INFO - 2016-01-22 10:16:23,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:23 INFO - 2016-01-22 10:16:23,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 137936896 10:16:23 INFO - 2016-01-22 10:16:23,971 DEBUG : BROWSER_OUTPUT: 10:16:26 INFO - 2016-01-22 10:16:26,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:27 INFO - 2016-01-22 10:16:27,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 138280960 10:16:27 INFO - 2016-01-22 10:16:27,000 DEBUG : BROWSER_OUTPUT: 10:16:29 INFO - 2016-01-22 10:16:29,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:30 INFO - 2016-01-22 10:16:30,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 138489856 10:16:30 INFO - 2016-01-22 10:16:30,115 DEBUG : BROWSER_OUTPUT: 10:16:31 INFO - 2016-01-22 10:16:31,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37485/tests/kraken/driver.html?testName=ai-astar) 10:16:32 INFO - 2016-01-22 10:16:32,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 139808768 10:16:32 INFO - 2016-01-22 10:16:32,021 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:16:32 INFO - 2016-01-22 10:16:32,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:16:32 INFO - 2016-01-22 10:16:32,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:16:32 INFO - 2016-01-22 10:16:32,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:16:32 INFO - 2016-01-22 10:16:32,023 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;109;109;111;122;113;110;109;111 10:16:32 INFO - 2016-01-22 10:16:32,023 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;127;151;160;128;150;151;135;161;121 10:16:32 INFO - 2016-01-22 10:16:32,023 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;159;163;162;161;160;162;162;162 10:16:32 INFO - 2016-01-22 10:16:32,023 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;71;157;77;72;71;72;157;74 10:16:32 INFO - 2016-01-22 10:16:32,024 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;138;93;94;93;142;92;94;135 10:16:32 INFO - 2016-01-22 10:16:32,024 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;110;109;110;110 10:16:32 INFO - 2016-01-22 10:16:32,024 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;152;146;147;148;147;146;147;147;146;147 10:16:32 INFO - 2016-01-22 10:16:32,024 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;95;96;96;95;96;100 10:16:32 INFO - 2016-01-22 10:16:32,025 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;60;60;61;61;62;69;58;59 10:16:32 INFO - 2016-01-22 10:16:32,025 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;66;64;65;64;63;63;64;64 10:16:32 INFO - 2016-01-22 10:16:32,025 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;81;94;82;82;81;81;82;80 10:16:32 INFO - 2016-01-22 10:16:32,026 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;122;110;118;114;119;121;114;120;127 10:16:32 INFO - 2016-01-22 10:16:32,026 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;144;150;148;144;153;138;142;145;145 10:16:32 INFO - 2016-01-22 10:16:32,026 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;67;68;66;66;65;67;64 10:16:32 INFO - 2016-01-22 10:16:32,026 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:16:32 INFO - 2016-01-22 10:16:32,027 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:16:32 INFO - 2016-01-22 10:16:32,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,699 10:16:32 INFO - 2016-01-22 10:16:32,027 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486592020__endTimestamp 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:4.26 (3.8%) stddev-sans-first:4.51 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 109.0 109.0 111.0 122.0 113.0 110.0 109.0 111.0 10:16:32 INFO - 2016-01-22 10:16:32,029 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:151.00 stddev:14.52 (9.6%) stddev-sans-first:15.07 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: Values: 152.0 127.0 151.0 160.0 128.0 150.0 151.0 135.0 161.0 121.0 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 159.0 163.0 162.0 161.0 160.0 162.0 162.0 162.0 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.50 Median:72.00 stddev:35.62 (49.5%) stddev-sans-first:37.21 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 71.0 157.0 77.0 72.0 71.0 72.0 157.0 74.0 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.83 (23.5%) stddev-sans-first:22.58 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 138.0 93.0 94.0 93.0 142.0 92.0 94.0 135.0 10:16:32 INFO - 2016-01-22 10:16:32,030 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,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.50 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.77 (1.2%) stddev-sans-first:0.67 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: Values: 152.0 146.0 147.0 148.0 147.0 146.0 147.0 147.0 146.0 147.0 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.50 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 95.0 96.0 96.0 95.0 96.0 100.0 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.50 stddev:3.07 (5.1%) stddev-sans-first:3.18 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 60.0 60.0 61.0 61.0 62.0 69.0 58.0 59.0 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,031 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 66.0 64.0 65.0 64.0 63.0 63.0 64.0 64.0 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.50 stddev:4.09 (5.0%) stddev-sans-first:4.30 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 81.0 94.0 82.0 82.0 81.0 81.0 82.0 80.0 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.50 stddev:5.85 (4.9%) stddev-sans-first:5.07 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: Values: 129.0 122.0 110.0 118.0 114.0 119.0 121.0 114.0 120.0 127.0 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:146.00 stddev:4.20 (2.9%) stddev-sans-first:4.42 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 150.0 148.0 144.0 153.0 138.0 142.0 145.0 145.0 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 10:16:32 INFO - 2016-01-22 10:16:32,032 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 67.0 68.0 66.0 66.0 65.0 67.0 64.0 10:16:32 INFO - 2016-01-22 10:16:32,033 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:16:32 INFO - 2016-01-22 10:16:32,033 DEBUG : BROWSER_OUTPUT: 10:16:32 INFO - 2016-01-22 10:16:32,926 INFO : Browser exited with error code: 0 10:16:32 INFO - 2016-01-22 10:16:32,979 INFO : Completed test kraken (00:01:00) 10:16:32 INFO - 2016-01-22 10:16:32,979 INFO : Starting test v8_7 10:16:32 INFO - 2016-01-22 10:16:32,979 DEBUG : operating with platform_type : linux_ 10:16:32 INFO - 2016-01-22 10:16:32,979 INFO : Initialising browser for v8_7 test... 10:16:32 INFO - 2016-01-22 10:16:32,985 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr123TQ/profile http://localhost:37485/getInfo.html 10:16:37 INFO - 2016-01-22 10:16:37,224 DEBUG : BROWSER_OUTPUT: 10:16:37 INFO - 2016-01-22 10:16:37,224 DEBUG : BROWSER_OUTPUT: (process:22662): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:16:38 INFO - 2016-01-22 10:16:38,392 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:38 INFO - 2016-01-22 10:16:38,392 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:38 INFO - 2016-01-22 10:16:38,392 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:38 INFO - 2016-01-22 10:16:38,392 DEBUG : BROWSER_OUTPUT: __metrics 10:16:39 INFO - 2016-01-22 10:16:39,567 INFO : Browser initialized. 10:16:39 INFO - 2016-01-22 10:16:39,568 INFO : Running cycle 1/1 for v8_7 test... 10:16:39 INFO - 2016-01-22 10:16:39,568 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr123TQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:40 INFO - 2016-01-22 10:16:40,923 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2016-01-22 10:16:40,923 DEBUG : BROWSER_OUTPUT: (process:22777): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:16:51 INFO - 2016-01-22 10:16:51,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 135852032 10:16:51 INFO - 2016-01-22 10:16:51,424 DEBUG : BROWSER_OUTPUT: 10:17:12 INFO - 2016-01-22 10:17:12,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37485/tests/v8_7/run.html (next: http://localhost:37485/tests/v8_7/run.html) 10:17:13 INFO - 2016-01-22 10:17:13,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 135987200 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: |0;Richards;168.03898504453034 10:17:13 INFO - 2016-01-22 10:17:13,022 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;169.4053870913095 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |5;Earley;545.8515283842795 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |6;Boyer;11032.967032967033 10:17:13 INFO - 2016-01-22 10:17:13,023 DEBUG : BROWSER_OUTPUT: |7;RegExp;23857.14285714286 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: |8;Splay;527.1481286241434 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1453486633020__endTimestamp 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: Values: 168.0 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,025 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:169.41 Median:169.41 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,026 DEBUG : BROWSER_OUTPUT: Values: 169.4 10:17:13 INFO - 2016-01-22 10:17:13,027 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,027 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,027 DEBUG : BROWSER_OUTPUT: Values: 278.6 10:17:13 INFO - 2016-01-22 10:17:13,027 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: Values: 5175.3 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: Values: 948.8 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,028 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:545.85 Median:545.85 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: Values: 545.9 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11032.97 Median:11032.97 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: Values: 11033.0 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23857.14 Median:23857.14 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,029 DEBUG : BROWSER_OUTPUT: Values: 23857.1 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.15 Median:527.15 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: Values: 527.1 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:17:13 INFO - 2016-01-22 10:17:13,030 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:13 INFO - 2016-01-22 10:17:13,031 DEBUG : BROWSER_OUTPUT: 10:17:13 INFO - 2016-01-22 10:17:13,974 INFO : Browser exited with error code: 0 10:17:13 INFO - 2016-01-22 10:17:13,986 INFO : Completed test v8_7 (00:00:41) 10:17:14 INFO - 2016-01-22 10:17:14,093 INFO : Completed test suite (00:20:10) 10:17:14 INFO - 2016-01-22 10:17:14,093 DEBUG : Working with test: dromaeo_css 10:17:14 INFO - 2016-01-22 10:17:14,093 DEBUG : Generating results file: dromaeo_css 10:17:14 INFO - 2016-01-22 10:17:14,094 DEBUG : Working with test: kraken 10:17:14 INFO - 2016-01-22 10:17:14,095 DEBUG : Generating results file: kraken 10:17:14 INFO - 2016-01-22 10:17:14,095 INFO : javascript benchmark 10:17:14 INFO - 2016-01-22 10:17:14,095 DEBUG : Working with test: v8_7 10:17:14 INFO - 2016-01-22 10:17:14,095 DEBUG : Generating results file: v8_7 10:17:14 INFO - 2016-01-22 10:17:14,095 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:14 INFO - 2016-01-22 10:17:14,152 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 10:17:14 INFO - 2016-01-22 10:17:14,152 DEBUG : process_Request line: dromaeo_css 7243.45 graph.html#tests=[[72,52,43]] 10:17:14 INFO - 2016-01-22 10:17:14,152 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:14 INFO - 2016-01-22 10:17:14,183 DEBUG : process_Request line: kraken 1504.50 graph.html#tests=[[232,52,43]] 10:17:14 INFO - 2016-01-22 10:17:14,183 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:17:14 INFO - 2016-01-22 10:17:14,217 DEBUG : process_Request line: v8_7 23122.53 graph.html#tests=[[230,52,43]] 10:17:14 INFO - 2016-01-22 10:17:14,218 INFO : javascript benchmark 10:17:14 INFO - 2016-01-22 10:17:14,221 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3372.5109859070435, 3427.931441371171, 3428.1258279138815, 3444.655534446555, 3449.655034496551, 5549.001179787637, 5554.944450555493, 5558.277423934888, 5575.609707320489, 5613.522850557697, 5597.132444471104, 5674.2623458950275, 5678.119891416826, 5685.8578535536635, 5730.79942202023, 5094.414142373628, 5176.611754118438, 5217.295665085203, 5225.216217567377, 5236.0, 5040.092783299005, 5060.165072762989, 5156.974215128937, 5167.9483205168035, 5238.580913526927, 5156.123459011958, 5236.476352364771, 5242.082635538784, 5251.081060814342, 5256.290400795881, 5246.1868410396255, 5297.5232229099565, 5314.83073723784, 5315.3621565412395, 5331.893362132736, 5010.498950104997, 5038.823641172541, 5087.56755675768, 5161.4322424533275, 5187.3775146982225, 5448.891022179534, 5496.395396506381, 5516.475934786189, 5552.86117847053, 5563.610547261694, 6144.446999769997, 6165.784197553064, 6193.0, 6214.285357183937, 6231.345708700566, 5965.940340596625, 6021.096835474714, 6110.358412366682, 6138.633639632459, 6243.0, 5792.362840087545, 5799.043157878987, 5818.272715910512, 5831.475167234927, 5832.737526811304, 6259.374062593704, 6277.686115694289, 6280.811575652738, 6284.937150628527, 6288.339724328971, 5751.079827227623, 5846.8538286542325, 5923.733431995571, 5963.79126730571, 6007.759689612367, 6047.637141771508, 6130.724117414727, 6139.6009259398, 6145.631262124287, 6157.415045570664, 5797.652140871477, 6023.728932197974, 6091.329953705089, 6126.479249263773, 6128.877422451526, 6015.30823955242, 6020.57855950088, 6133.212252453595, 6143.447089761943, 6147.385261473817, 4662.580367766917, 4670.276107203389, 4681.157391669464, 4701.553352431513, 4706.105839890478, 4081.2653722330265, 4180.080382315886, 4190.455240818674, 4200.537940826506, 4238.809253583596, 5594.384617692051, 5626.099824028136, 5642.125470552071, 5666.660000399989, 5685.573581981368, 6071.9696401518595, 6139.785107521216, 6167.352427994996, 6174.753009879644, 6176.969115154486, 5718.971405143031, 5725.227094342211, 5750.108733146369, 5805.187273781674, 5878.764849405976, 5182.274481572583, 5206.167013277857, 5266.052110620125, 5268.078086334876, 5384.246205531229, 6263.498920086382, 6266.717997690115, 6284.277308109535, 6289.811305660837, 6300.495960323163, 5981.1327357532045, 6075.453209211192, 6089.817305480843, 6118.510519158456, 6166.044263139221, 6148.938510615016, 6287.497000240061, 6359.109724638647, 6367.044943258548, 6403.6798160090875, 6083.726232319645, 6116.602420842631, 6120.724567394389, 6166.876662466636, 6170.0, 5847.502962248086, 5972.432618901197, 6025.126356678345, 6212.47193988516, 6228.719707613259, 6021.969890150521, 6067.4539291462215, 6077.756889724362, 6087.068956942918, 6121.081837724377, 5725.942740572707, 5933.851653708692, 6038.184845045863, 6056.5154787616, 6074.119252708421, 5813.534917206529, 5824.184614154106, 5863.736131874161, 5885.735141918538, 5960.105984102419, 5961.195238642727, 5961.463468287875, 5985.461308482258, 6017.819465416044, 6036.577439579188, 5686.545076393962, 5833.883322333614, 5898.469137777621, 5904.9704751475965, 5906.881862362815], "unit": "ms", "name": "dojo.html", "value": 5624.566635034815}, {"lowerIsBetter": false, "replicates": [602.3193791016151, 619.3899009475666, 626.2078470734521, 649.7920665387072, 652.7715299645122, 41627.0, 42446.57553424465, 42483.575164248345, 42502.14995700084, 42722.0, 46070.0, 46160.538394616044, 46690.533094669125, 46843.76578117113, 46986.76506617462, 9052.094790520945, 9278.675246366378, 9289.535523223813, 9290.907090929106, 9327.347085704003, 7545.924540754604, 7547.094348678166, 7560.810979725524, 7583.469157158974, 7660.0, 9130.863037054416, 9185.586648600796, 9246.953765231197, 9253.0, 9254.167124958753, 9129.0, 9132.223760980325, 9142.72571822843, 9152.084791520861, 9215.124563166488, 9069.410488318239, 9138.360314777969, 9187.448753074837, 9194.35639505235, 9224.907750922472, 43270.35094473585, 43719.0, 43842.56157438448, 44010.0, 44018.559814401764, 3560.7151427885965, 3587.964120358789, 3594.730395220343, 3600.8919732407808, 3604.8017359045243, 32163.0, 32232.0, 32608.836955815306, 32816.835915820266, 33181.0, 3797.3354662933875, 3851.826667799956, 3872.8644497442456, 3911.7066220033325, 3935.626115519021, 269506.0, 270374.0, 270953.0, 271249.0, 271292.0, 45442.0, 45711.62865114052, 45806.31290530645, 45862.54137458649, 45934.540654593024, 43090.35364469535, 43139.0, 43167.78416107899, 43417.56582434135, 43429.34855977163, 15000.474983375529, 15141.848581514265, 15163.09021458716, 15187.696246075016, 15219.315130819139, 12664.74670506603, 12829.0, 12877.034222433167, 12947.287899165449, 12953.158044727063, 15366.385344586091, 15406.383744650313, 15603.063816171067, 15635.140067296408, 15671.220277815148, 6068.423499767515, 6197.659128747962, 6232.158658581034, 6253.155823963707, 6355.841103972438, 959.3524371049514, 977.9119879210905, 1000.8140353680911, 1098.5441041967654, 1105.1214284643727, 29571.408571828444, 29571.85214073959, 29689.554656680168, 30103.397932041236, 30225.848870755504, 1024.8411496218098, 1063.2982231727178, 1085.6742977106837, 1145.7135716070982, 1163.7730642524627, 15634.609134771494, 15816.76274855878, 16012.67974640524, 16088.597785055466, 16098.597535061717, 514378.0, 517983.0, 545226.0, 547666.0, 548272.0, 59611.70194149001, 60377.39622603806, 60398.69800650969, 60448.093278600856, 60572.0, 1486.51688201335, 1506.713724392384, 1510.2750679673818, 1514.3336931749996, 1528.2511569330948, 31467.527987079753, 32132.67867321297, 32489.0, 33179.33641327208, 35034.64965350314, 54332.45667543432, 54422.45577544332, 55009.1748623779, 55233.72383138059, 55261.17108243299, 311362.0, 312884.0, 314052.71894562437, 314203.0, 314347.0, 45217.32174017327, 46164.53835461602, 46348.53651463577, 46689.06621867612, 47066.0, 47954.0, 48807.0, 49112.50887491222, 49472.75263623659, 49483.0, 41084.58915410927, 41232.58767412287, 41307.38038929478, 41322.58677413187, 42330.0, 40193.0, 40398.79800600978, 40523.1895362097, 40630.79684601558, 40647.59352406438, 40198.59801401949, 40637.59362406456, 40670.186596268504, 40726.79636601798, 40958.18083638251, 36332.81833590815, 36413.635863642085, 36475.81762091172, 37206.0, 37349.43975840419, 28291.71708282891, 28479.28801779889, 28741.56887646729, 28762.856185718938, 28984.565231521123], "unit": "ms", "name": "ext.html", "value": 19586.684484781494}, {"lowerIsBetter": false, "replicates": [385.2910644414277, 385.3027414240269, 390.36955317162784, 391.11802884495467, 391.3171515705095, 16167.353305867751, 17328.653426931454, 17733.0, 18527.0, 18577.0, 12145.514179432834, 12493.0, 12614.369281535932, 16422.75365869513, 17082.572935676613, 5169.948300516994, 5315.6013299002725, 5379.67721936685, 5403.405625381205, 5826.242588463515, 5439.700816455093, 5581.49766521013, 5582.7766889324375, 5607.102863541834, 5739.856503587423, 5490.396056433789, 5516.282883225175, 5682.289713785777, 6208.192934918454, 6278.434940855322, 6184.536159788034, 6202.534809889254, 6230.968845155768, 6235.6258624482225, 6256.499480041586, 5491.780328786844, 5581.6930068846195, 5639.605227634026, 5661.60368774186, 5734.053881109612, 13816.585502434944, 13901.652458688513, 13954.790678139836, 14448.422063117463, 14558.92720536401, 2162.2648299578063, 2172.663237198237, 2237.272886311955, 2285.725712914444, 2327.8836058197194, 10491.685249442453, 10493.580256789719, 10520.894791052144, 10813.567457301699, 12214.083943704258, 1993.9900300498405, 2003.6894281386408, 2037.8879161646103, 2040.9387718368473, 2048.98975505123, 63157.68421157911, 64746.02880956789, 65358.673206634136, 65373.0, 66124.3387566123, 10980.670579882457, 11261.268017578832, 11303.491342889589, 11332.43337833105, 11371.488283027284, 14902.254887255594, 14916.0, 14933.029353092232, 14959.700805983819, 14976.70046599062, 8165.79585510367, 8190.959045204855, 8250.504969701837, 8264.380171487042, 8276.917230827736, 7797.142314345418, 7800.0, 7897.763067107996, 7919.920800791919, 7974.880376794353, 4711.81152753886, 4727.621790256771, 4781.187198176319, 4805.063012712558, 4891.828785992473, 1921.3563456242036, 1944.562473443464, 1947.3087054095874, 1978.4757039384574, 1981.0, 453.5872356155882, 459.2789320766432, 460.8340997240991, 847.8007668197969, 942.9533218127873, 10759.683415277686, 11666.300021998708, 11833.822492662617, 11909.642710718692, 11945.104117191246, 480.9422869255642, 499.9125153098266, 503.2174967924912, 506.8428787076018, 531.7102179312284, 6278.811635650938, 6335.936640633627, 6344.397282258178, 6390.265119511223, 6462.030695395634, 617762.0, 631739.0, 633327.0, 633959.0, 637481.0, 83513.58243208866, 83723.5813820927, 84638.15361846426, 87003.0, 87800.0, 568.1421054208175, 572.4075581772845, 575.536692962161, 575.7984705353093, 576.0897781505212, 10792.622258220925, 10967.396793176453, 11003.119750420108, 11035.503402347074, 11058.060064894575, 33902.66097338995, 34324.0, 35209.82395088008, 35318.82340588281, 35759.0, 49310.75344623254, 49512.0, 49814.50185498244, 49902.75048624879, 53410.0, 10209.183265338903, 10256.28206025601, 10328.431936243578, 10387.013233742782, 10487.52806123711, 13666.0, 14417.495387661382, 16228.107454090139, 17063.658726825146, 17842.91078544599, 15230.847691523386, 15413.922930385277, 15416.845831541541, 15526.844731552992, 15581.454649087227, 15009.624759381102, 15066.849331506983, 15180.696386072437, 15686.0, 15749.370025198863, 12614.873851261369, 16121.435749748702, 16352.591185220464, 16488.25802838899, 16608.086555239577, 9822.116009559173, 9834.311598188344, 9850.408975461209, 9861.457619830691, 9988.800223995624, 12941.352932353157, 15502.224888755292, 15617.531474055797, 15737.134457604941, 16077.115758633387], "unit": "ms", "name": "jquery.html", "value": 8551.33788636431}, {"lowerIsBetter": false, "replicates": [1583.0897234090394, 1596.0742769193869, 1813.9183736731848, 1832.1846778183713, 1861.6649003179427, 7709.537427754339, 8102.878456823152, 8127.4717143385715, 8301.83396332073, 8387.370947178963, 7968.721094761684, 8055.31529819966, 8094.231048050426, 8128.4310098293145, 8158.1433949435195, 2427.126234555563, 2461.0155937624913, 2464.2114523352534, 2466.0135945621714, 2473.925782226527, 2435.6833611630464, 2439.0, 2439.121916110199, 2467.7408872068445, 2473.678421805163, 2061.288855344911, 2104.6842973553935, 2397.280815755275, 2398.0647547456506, 2414.3239892829947, 2367.6093444581625, 2382.749811269809, 2383.261189031397, 2396.6165413533927, 2400.147947478646, 2381.7380088190284, 2418.238254949685, 2429.1983645396976, 2436.610142377229, 2443.5723748343967, 7838.137804841463, 7938.6427610757655, 7946.562939038351, 7950.363970882316, 7963.044434667819, 4883.340748998875, 4977.800887964477, 4979.875503112415, 4992.326035985132, 4996.975015124937, 3137.043201823443, 3211.823349715765, 3218.806871587712, 3227.644959054502, 3248.1717162123746, 1065.6802959112235, 1071.9892801071967, 1082.5615625671617, 1083.2038451737967, 1087.190043417651, 11025.117990560735, 11157.888421115847, 11185.105191584653, 11194.888051119548, 11240.100791936708, 4558.384618076583, 4570.588647021784, 4573.314002899525, 4636.79134438951, 4641.094986477605, 9653.420794752197, 9671.661491847752, 9728.270379721549, 9742.0, 9779.755506112262, 5066.392032955995, 5105.463926287761, 5122.487751224848, 5128.564072053842, 5149.536541711189, 4616.099860527165, 4628.282616194495, 4655.720656760605, 4660.813567457264, 4661.324108004321, 3854.325493038707, 3912.4522566840665, 3929.351656976624, 3951.7431366961055, 3963.4847469828737, 1264.6648638110908, 1280.1167194635857, 1294.6051454306528, 1299.857015728269, 1303.5633062923837, 1107.595727559435, 1127.2841745491507, 1136.8863113688565, 1250.774860525096, 1253.7053792358788, 7662.080550333995, 7729.729459468892, 7747.883781743279, 7749.4575379724, 7792.766217013385, 1151.9654410367534, 1156.843826083468, 1173.3487914207697, 1173.923694959842, 1177.0642339340245, 6174.104754810617, 6180.598261113013, 6199.008158694587, 6224.06639004153, 6228.906566401417, 9453.858192127123, 9847.359921605073, 9896.505174741234, 9911.900880991241, 9990.150837178775, 9686.70939871805, 9708.223342132613, 9779.706608801747, 9821.459819709842, 9829.115379615869, 7490.85018299631, 7589.544627322378, 7631.465797394129, 7638.809029774189, 7645.503042302233, 7663.195364486872, 7758.92241077582, 7775.533467991939, 7818.960905195438, 7827.25641064098, 8637.309015278888, 8709.0, 8805.823883522422, 8841.115888411108, 8857.512836794038, 8788.604512797066, 8909.1536304051, 8944.642214311354, 8971.878515185601, 9192.724218273463, 7240.348368646847, 7316.158641756053, 7321.450891183076, 7329.706811727685, 7335.119785625546, 7921.722739704082, 7981.561014144278, 7984.0, 7996.280334769898, 8020.83958320842, 7512.849743005218, 7549.358304544176, 7575.469717119749, 7605.277498637621, 7696.422768292288, 7289.380402665833, 7393.704251829867, 7436.256374362521, 7475.0656167979005, 7479.626018698935, 7398.371138453292, 7412.666430010555, 7434.553926764195, 7441.367483763941, 7459.664315105725, 6892.138482689664, 6914.204866440424, 6932.549384290005, 6991.510594258353, 6995.125609298838, 6977.302269773185, 7024.789256322319, 7081.504294699322, 7083.468739844635, 7090.4327653788605], "unit": "ms", "name": "mootools.html", "value": 4765.391473222855}, {"lowerIsBetter": false, "replicates": [358.0850925884365, 362.3351150638578, 365.6818567845973, 365.9176685245819, 366.3113346907813, 6271.742172817782, 6359.936400635992, 6376.298607153215, 6382.010788327811, 6387.690523442695, 6135.631862088278, 6335.271443783966, 6343.175387199658, 6357.110004599348, 6358.872822543546, 4864.7324397158145, 4903.53416425439, 4905.0, 4911.631627627924, 4916.237983112624, 4902.411710594716, 4905.533974272438, 4919.11455937931, 4922.0, 4923.753812309388, 4669.766511674419, 4787.1622466068475, 4791.257355109946, 4817.542333478314, 4828.299896515004, 4802.97598512007, 4806.375171227735, 4808.0, 4808.3027960945465, 4823.517648235166, 4184.142250838601, 4184.4141820145205, 4191.811368488426, 4195.832166713328, 4215.093754842724, 5951.464368206882, 6013.977623803964, 6023.638581685069, 6025.9096113558335, 6028.0957856321465, 5575.832725018216, 5614.831555053314, 5618.101103823409, 5618.38197798246, 5632.098864181752, 6638.601683898982, 6677.565958212701, 6713.328667133296, 6713.395794378481, 6724.260331363546, 4670.626349892001, 4675.228587283094, 4685.4143232095985, 4702.3181638662545, 4702.5297470253045, 6881.65591720412, 6939.6877140528795, 6965.89551156728, 6990.056342393763, 6990.720371185146, 4747.098051370229, 4765.8570242892765, 4770.451398089194, 4771.976140119277, 4784.330193772875, 4800.423949126127, 4847.854564363004, 4849.539293767087, 4855.660103792771, 4863.829765958175, 5496.065668836308, 5615.438456154434, 5617.045102332613, 5619.353774316006, 5625.578081643811, 6724.0, 6741.831454213684, 6765.9661701691175, 6774.119364482684, 6775.390214880685, 1583.208395802099, 1609.8390160984043, 1714.665640200149, 1731.9307227711001, 1732.5322163015915, 1186.454231053725, 1190.8987736042534, 1204.3315959642307, 1206.811290878484, 1207.1368971185468, 6433.581817181868, 6473.190851143607, 6482.416582507597, 6483.643399613066, 6494.350564943468, 6855.108835851307, 6890.827729306707, 6918.377346038881, 6922.376986071277, 6926.896096558556, 6374.330695276929, 6416.903746443807, 6447.967760161169, 6452.225732911987, 6490.415862572391, 3727.7763334200035, 3731.253749250161, 3757.9436308455397, 3761.5674197467642, 3777.697784177259, 7077.893831592531, 7110.288971102848, 7115.53749006313, 7122.60825654594, 7126.180489243699, 6971.3028697129885, 7078.787636370917, 7080.539764915264, 7092.4680648951535, 7099.290070992859, 7057.682404291819, 7079.115110611174, 7090.113735783028, 7118.71525138999, 7137.857242855114, 6892.207396149507, 6903.378695917391, 6922.653867306513, 6930.0, 6932.549384290005, 6743.0, 6815.2162501311, 6837.965810170917, 6929.237783843672, 6962.268961758942, 7214.675339609626, 7251.782446526613, 7280.927190728236, 7292.234315396807, 7296.598687072262, 4644.164050470813, 4665.650076244363, 4666.300054991642, 4679.532046795293, 4693.460252070919, 6811.318868113149, 6905.620190889549, 7056.682449289897, 7059.764541205166, 7062.329078737512, 6798.422134118655, 6798.93201067983, 6840.179178498612, 6853.211880633791, 6886.655667216519, 6851.691673874788, 6855.451563874778, 6876.106106206161, 6881.827954301182, 6886.24251332363, 6633.270340262471, 6677.565958212701, 6761.087253220949, 6769.796906092825, 6774.153230846145, 6821.420179284816, 6883.242843287134, 6891.655417229018, 6898.2756810536175, 6916.170059592881, 6694.230163531256, 6711.429528489938, 6731.932680673131, 6747.460203183636, 6752.493562982698], "unit": "ms", "name": "prototype.html", "value": 5089.8480000386035}, {"lowerIsBetter": false, "replicates": [762.4205603741156, 767.5356409372333, 789.2738680414019, 807.5558442856432, 898.4070513461116, 13842.723145537097, 14075.436982520687, 14107.576772696822, 14110.153390796559, 14137.57587272381, 11731.941340293286, 11859.940700296487, 11900.0, 12007.939960300208, 12051.517939282418, 907.0566610724871, 915.6337465013982, 927.4388994658202, 931.0503286647615, 933.7992331648694, 938.6855403439856, 941.1341565759484, 944.0512285153411, 946.7869729310919, 951.6526467839258, 949.2500924269818, 954.7517645412173, 957.4351132831628, 957.6313119449028, 961.9086186812276, 951.1249650321686, 952.2715122930963, 954.0316578672653, 954.7040417470606, 956.2588993530001, 706.5725236232057, 707.9292070792931, 708.8936659501064, 709.4678990756933, 711.6157275071507, 13124.475020999149, 13148.408321625455, 13164.341782910911, 13240.470381184741, 13257.535986240435, 11736.53053877844, 12299.815502767466, 12446.377681115908, 12610.873891261153, 12647.0514711397, 10116.494175291205, 10284.228682848816, 10297.124744396735, 10361.89638103617, 10656.786864262749, 3196.488561830119, 3263.96736032639, 3269.4605390110605, 3293.6541663125267, 3358.647342029101, 47788.0, 47969.99999999965, 48597.0, 48829.755851220514, 49056.50943490591, 9943.403395796275, 10014.298999069995, 10156.542955567018, 10236.436995965294, 10347.327423717434, 18236.361727339743, 18290.908545457187, 18317.450476485727, 18331.358402456117, 18334.633307333777, 6623.933760662428, 6768.2216545097945, 6901.585904845725, 6911.6544172791155, 7065.43476521877, 4143.02638879863, 4174.08170202555, 4176.248275310412, 4224.704270701021, 4282.186384586918, 3152.6689697581883, 3194.2653189766484, 3195.6804319568323, 3201.183698157002, 3204.599425071866, 578.2482772395869, 582.496140838172, 592.5437413191818, 596.2814808156162, 603.3333166850567, 563.844942640777, 601.7863658401292, 623.233422889848, 629.1475051305507, 629.4995478594528, 8015.519068855887, 8245.546494942835, 8265.586720663943, 8365.8326833463, 8381.139216677124, 631.4159402552621, 650.3596836571099, 655.6361219523116, 656.7537173559915, 672.1866541484858, 3785.337565925952, 3872.3223435898603, 4054.614811592894, 4057.229126465962, 4295.82816687329, 55398.44601554013, 56240.43759562434, 56623.150652740245, 56941.43058569444, 57004.0, 49943.0, 49947.75339602914, 50395.0, 53364.46635533595, 53841.73079134658, 46439.30341044887, 47841.5215847844, 47994.28008579874, 48253.51746482561, 48313.75843120762, 8159.26566609008, 8340.749777506684, 8376.078631350425, 8521.02008269057, 8569.914300856912, 34479.65520344764, 34596.82701586476, 35417.64582354143, 35543.0, 36525.08687282839, 44763.55236447594, 45733.54266457293, 45757.54242457533, 46063.078738424374, 46697.53302466932, 9940.155086817702, 10044.799104018024, 10054.64808731691, 10113.089821916063, 10397.844032339672, 11248.325100493996, 11448.94275528617, 11483.770324593628, 11497.54009839597, 11657.650270491898, 10549.367037977747, 10551.103156231806, 10631.787364252827, 10704.197185211297, 10760.139188865029, 10713.89286107129, 10726.946365268435, 10769.892301077203, 10899.673009809718, 11400.973912347928, 10106.343087699275, 10374.325668831501, 10384.93201945865, 10684.786304274026, 10836.67489975302, 9615.9038409615, 9754.122129008423, 9763.60945562198, 9784.266180036668, 9793.069658382443, 9297.907020929704, 9510.191633710936, 9602.95198524003, 9628.855567166638, 9672.129508344282], "unit": "ms", "name": "yui.html", "value": 6320.457450721391}], "name": "dromaeo_css", "value": 7243.4465695297185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 109.0, 109.0, 111.0, 122.0, 113.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 151.0, 160.0, 128.0, 150.0, 151.0, 135.0, 161.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 163.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 71.0, 157.0, 77.0, 72.0, 71.0, 72.0, 157.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 138.0, 93.0, 94.0, 93.0, 142.0, 92.0, 94.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.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": [152.0, 146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 100.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 61.0, 62.0, 69.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 66.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 94.0, 82.0, 82.0, 81.0, 81.0, 82.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 110.0, 118.0, 114.0, 119.0, 121.0, 114.0, 120.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 150.0, 148.0, 144.0, 153.0, 138.0, 142.0, 145.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 66.0, 65.0, 67.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1504.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [169.4053870913095], "unit": "score", "name": "DeltaBlue", "value": 390.29455399999983}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [545.8515283842795], "unit": "score", "name": "Earley", "value": 1220.9602159999997}, {"lowerIsBetter": false, "replicates": [11032.967032967033], "unit": "score", "name": "Boyer", "value": 60.40650697211158}, {"lowerIsBetter": false, "replicates": [23857.14285714286], "unit": "score", "name": "RegExp", "value": 38.185}, {"lowerIsBetter": false, "replicates": [527.1481286241434], "unit": "score", "name": "Splay", "value": 154.588427}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23122.531936045234}]} 10:17:14 INFO - RETURN: dromaeo_css: 7243.45 10:17:14 INFO - RETURN: kraken: 1504.50 10:17:14 INFO - RETURN: v8_7: 23122.53 10:17:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23122.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7243.45"}}} 10:17:14 INFO - Return code: 0 10:17:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:17:14 INFO - # TBPL SUCCESS # 10:17:14 INFO - Running post-action listener: _resource_record_post_action 10:17:14 INFO - Running post-run listener: _resource_record_post_run 10:17:15 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 511053824; Read time: 0; Write time: 941288 10:17:15 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 237666304; Read time: 0; Write time: 604452 10:17:15 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 273207296; Read time: 0; Write time: 336788 10:17:15 INFO - Running post-run listener: _upload_blobber_files 10:17:15 INFO - Blob upload gear active. 10:17:15 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:17:15 INFO - Copying logs to upload dir... 10:17:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.878153 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-22 10:17:15.473195) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:15.476697) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010074 build_url: 'https://queue.taskcluster.net/v1/task/GjhlnvYhT9KITJtzu5kAzA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:15.528804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:15.529230) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1453485157.837093-2089751953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:17:15.579320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:17:15.579657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 10:17:15.579962) ========= ========= Total master_lag: 0.28 =========