builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1448637637.68 results: success (0) buildid: 20151127043001 builduid: 42cb06e419a540158df4afcb2d65495f revision: 47b49b0d32360fab04b11ff9120970979c426911 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.681805) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.682304) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.682613) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006341 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.707845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.708174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.741922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.742291) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.806750) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.807052) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.807411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.807827) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 07:20:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 43.3M=0s 2015-11-27 07:20:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145093 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.980092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:37.980411) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014498 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.032640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.033051) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47b49b0d32360fab04b11ff9120970979c426911 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 47b49b0d32360fab04b11ff9120970979c426911 --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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 07:20:38,336 truncating revision to first 12 chars 2015-11-27 07:20:38,336 Setting DEBUG logging. 2015-11-27 07:20:38,337 attempt 1/10 2015-11-27 07:20:38,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47b49b0d3236?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 07:20:38,607 unpacking tar archive at: mozilla-central-47b49b0d3236/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562355 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.607820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.608132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.619568) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.619875) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 07:20:38.620602) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-27 07:20:38.620907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:39 INFO - MultiFileLogger online at 20151127 07:20:39 in /builds/slave/test-pgo 07:20:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:20:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:20:39 INFO - {'append_to_log': False, 07:20:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:20:39 INFO - 'blob_upload_branch': 'Firefox', 07:20:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:20:39 INFO - 'branch': 'Firefox', 07:20:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:39 INFO - 'config_files': ('talos/linux_config.py',), 07:20:39 INFO - 'default_actions': ('clobber', 07:20:39 INFO - 'read-buildbot-config', 07:20:39 INFO - 'download-and-extract', 07:20:39 INFO - 'populate-webroot', 07:20:39 INFO - 'create-virtualenv', 07:20:39 INFO - 'install', 07:20:39 INFO - 'run-tests'), 07:20:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:39 INFO - 'download_minidump_stackwalk': True, 07:20:39 INFO - 'download_symbols': 'ondemand', 07:20:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:39 INFO - 'installer_path': 'installer.exe', 07:20:39 INFO - 'log_level': 'info', 07:20:39 INFO - 'log_name': 'talos', 07:20:39 INFO - 'log_to_console': True, 07:20:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:39 INFO - 'opt_config_files': (), 07:20:39 INFO - 'pip_index': False, 07:20:39 INFO - 'sps_profile': False, 07:20:39 INFO - 'sps_profile_interval': 0, 07:20:39 INFO - 'suite': 'dromaeojs-e10s', 07:20:39 INFO - 'system_bits': '64', 07:20:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:39 INFO - 'title': 'talos-linux64-ix-029', 07:20:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:39 INFO - 'use_talos_json': True, 07:20:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:20:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:39 INFO - 'work_dir': 'build'} 07:20:39 INFO - ##### 07:20:39 INFO - ##### Running clobber step. 07:20:39 INFO - ##### 07:20:39 INFO - Running pre-action listener: _resource_record_pre_action 07:20:39 INFO - Running main action method: clobber 07:20:39 INFO - rmtree: /builds/slave/test-pgo/build 07:20:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:20:39 INFO - Running post-action listener: _resource_record_post_action 07:20:39 INFO - ##### 07:20:39 INFO - ##### Running read-buildbot-config step. 07:20:39 INFO - ##### 07:20:39 INFO - Running pre-action listener: _resource_record_pre_action 07:20:39 INFO - Running main action method: read_buildbot_config 07:20:39 INFO - Using buildbot properties: 07:20:39 INFO - { 07:20:39 INFO - "properties": { 07:20:39 INFO - "buildnumber": 566, 07:20:39 INFO - "product": "firefox", 07:20:39 INFO - "script_repo_revision": "production", 07:20:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:20:39 INFO - "repository": "", 07:20:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:20:39 INFO - "buildid": "20151127043001", 07:20:39 INFO - "slavename": "talos-linux64-ix-029", 07:20:39 INFO - "pgo_build": "True", 07:20:39 INFO - "basedir": "/builds/slave/test-pgo", 07:20:39 INFO - "project": "", 07:20:39 INFO - "platform": "ubuntu64_hw", 07:20:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:20:39 INFO - "slavebuilddir": "test", 07:20:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:20:39 INFO - "branch": "mozilla-central", 07:20:39 INFO - "repo_path": "mozilla-central", 07:20:39 INFO - "stage_platform": "linux64-pgo", 07:20:39 INFO - "builduid": "42cb06e419a540158df4afcb2d65495f", 07:20:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 07:20:39 INFO - }, 07:20:39 INFO - "sourcestamp": { 07:20:39 INFO - "repository": "", 07:20:39 INFO - "hasPatch": false, 07:20:39 INFO - "project": "", 07:20:39 INFO - "branch": "mozilla-central-linux64-pgo-talos", 07:20:39 INFO - "changes": [ 07:20:39 INFO - { 07:20:39 INFO - "category": null, 07:20:39 INFO - "files": [ 07:20:39 INFO - { 07:20:39 INFO - "url": null, 07:20:39 INFO - "name": "https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:20:39 INFO - } 07:20:39 INFO - ], 07:20:39 INFO - "repository": "", 07:20:39 INFO - "rev": "47b49b0d32360fab04b11ff9120970979c426911", 07:20:39 INFO - "who": "sendchange", 07:20:39 INFO - "when": 1448637616, 07:20:39 INFO - "number": 6715101, 07:20:39 INFO - "comments": "", 07:20:39 INFO - "project": "", 07:20:39 INFO - "at": "Fri 27 Nov 2015 07:20:16", 07:20:39 INFO - "branch": "mozilla-central-linux64-pgo-talos", 07:20:39 INFO - "revlink": "", 07:20:39 INFO - "properties": [ 07:20:39 INFO - [ 07:20:39 INFO - "buildid", 07:20:39 INFO - "20151127043001", 07:20:39 INFO - "Change" 07:20:39 INFO - ], 07:20:39 INFO - [ 07:20:39 INFO - "builduid", 07:20:39 INFO - "42cb06e419a540158df4afcb2d65495f", 07:20:39 INFO - "Change" 07:20:39 INFO - ], 07:20:39 INFO - [ 07:20:39 INFO - "pgo_build", 07:20:39 INFO - "True", 07:20:39 INFO - "Change" 07:20:39 INFO - ] 07:20:39 INFO - ], 07:20:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 07:20:39 INFO - } 07:20:39 INFO - ], 07:20:39 INFO - "revision": "47b49b0d32360fab04b11ff9120970979c426911" 07:20:39 INFO - } 07:20:39 INFO - } 07:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:20:39 INFO - Running post-action listener: _resource_record_post_action 07:20:39 INFO - ##### 07:20:39 INFO - ##### Running download-and-extract step. 07:20:39 INFO - ##### 07:20:39 INFO - Running pre-action listener: _resource_record_pre_action 07:20:39 INFO - Running main action method: download_and_extract 07:20:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:20:39 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')]} 07:20:39 INFO - https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/test_packages.json 07:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/test_packages.json 07:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:20:40 INFO - Downloaded 1302 bytes. 07:20:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:20:40 INFO - Using the following test package requirements: 07:20:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:20:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'jsshell-linux-x86_64.zip'], 07:20:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:20:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:20:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:20:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:20:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:20:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:40 INFO - https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:20:42 INFO - Downloaded 22762427 bytes. 07:20:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:20:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:20:43 INFO - Return code: 0 07:20:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:20: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')]} 07:20:43 INFO - https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:20:47 INFO - Downloaded 22762427 bytes. 07:20:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:20:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:20:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:20:49 INFO - Return code: 0 07:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:49 INFO - https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:20:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:20:50 INFO - Downloaded 11131728 bytes. 07:20:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:20:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:20:50 INFO - Return code: 0 07:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:50 INFO - https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:20:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:20:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:20:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:20:52 INFO - Downloaded 58410466 bytes. 07:20:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:20:52 INFO - mkdir: /builds/slave/test-pgo/properties 07:20:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:20:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:20:52 INFO - Contents: 07:20:52 INFO - build_url:https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - Running post-action listener: set_extra_try_arguments 07:20:52 INFO - ##### 07:20:52 INFO - ##### Running populate-webroot step. 07:20:52 INFO - ##### 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: populate_webroot 07:20:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:20:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:20:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:20:52 INFO - '../fennec_ids.txt'], 07:20:52 INFO - 'tests': ['tcheck2']}, 07:20:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:20:52 INFO - '--tppagecycles', 07:20:52 INFO - '7'], 07:20:52 INFO - 'tests': ['tsvgm']}}, 07:20:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:20:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:20:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:20:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:20:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'tests': ['damp', 'tps']}, 07:20:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['damp', 'tps']}, 07:20:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:20:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:20:52 INFO - 'other': {'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'other_l64': {'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'other_nol64': {'tests': ['a11yr', 07:20:52 INFO - 'ts_paint', 07:20:52 INFO - 'tpaint', 07:20:52 INFO - 'sessionrestore', 07:20:52 INFO - 'sessionrestore_no_auto_restore']}, 07:20:52 INFO - 'svgr': {'tests': ['tsvgx', 07:20:52 INFO - 'tsvgr_opacity', 07:20:52 INFO - 'tart', 07:20:52 INFO - 'tscrollx', 07:20:52 INFO - 'cart']}, 07:20:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['tsvgx', 07:20:52 INFO - 'tsvgr_opacity', 07:20:52 INFO - 'tart', 07:20:52 INFO - 'tscrollx', 07:20:52 INFO - 'cart']}, 07:20:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'tests': ['tp5o']}, 07:20:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'talos_options': ['--e10s'], 07:20:52 INFO - 'tests': ['tp5o']}, 07:20:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'talos_options': ['--xperf_path', 07:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:52 INFO - 'tests': ['tp5n']}, 07:20:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:52 INFO - 'talos_options': ['--e10s', 07:20:52 INFO - '--xperf_path', 07:20:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:52 INFO - 'tests': ['tp5n']}}, 07:20:52 INFO - 'talos.zip': {'path': '', 07:20:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - ##### 07:20:52 INFO - ##### Running create-virtualenv step. 07:20:52 INFO - ##### 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: create_virtualenv 07:20:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:20:52 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 07:20:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:20:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:20:52 INFO - Using real prefix '/usr' 07:20:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:20:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:20:54 INFO - Installing pip.................done. 07:20:54 INFO - Return code: 0 07:20:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:20:54 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')]} 07:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:54 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')]} 07:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:20:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:20:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:20:54 INFO - Using env: {'DISPLAY': ':0', 07:20:54 INFO - 'HOME': '/home/cltbld', 07:20:54 INFO - 'LANG': 'en_US.UTF-8', 07:20:54 INFO - 'LANGUAGE': 'en_US:en', 07:20:54 INFO - 'LOGNAME': 'cltbld', 07:20:54 INFO - 'MAIL': '/var/mail/cltbld', 07:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:54 INFO - 'MOZ_NO_REMOTE': '1', 07:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:54 INFO - 'NO_EM_RESTART': '1', 07:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:20:54 INFO - 'PWD': '/builds/slave/test-pgo', 07:20:54 INFO - 'SHELL': '/bin/bash', 07:20:54 INFO - 'SHLVL': '1', 07:20:54 INFO - 'TERM': 'linux', 07:20:54 INFO - 'TMOUT': '86400', 07:20:54 INFO - 'USER': 'cltbld', 07:20:54 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:54 INFO - '_': '/tools/buildbot/bin/python'} 07:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:55 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 07:20:55 INFO - Cleaning up... 07:20:55 INFO - Return code: 0 07:20:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:20:55 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')]} 07:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:55 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')]} 07:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:20:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:20:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:20:55 INFO - Using env: {'DISPLAY': ':0', 07:20:55 INFO - 'HOME': '/home/cltbld', 07:20:55 INFO - 'LANG': 'en_US.UTF-8', 07:20:55 INFO - 'LANGUAGE': 'en_US:en', 07:20:55 INFO - 'LOGNAME': 'cltbld', 07:20:55 INFO - 'MAIL': '/var/mail/cltbld', 07:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:55 INFO - 'MOZ_NO_REMOTE': '1', 07:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:55 INFO - 'NO_EM_RESTART': '1', 07:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:20:55 INFO - 'PWD': '/builds/slave/test-pgo', 07:20:55 INFO - 'SHELL': '/bin/bash', 07:20:55 INFO - 'SHLVL': '1', 07:20:55 INFO - 'TERM': 'linux', 07:20:55 INFO - 'TMOUT': '86400', 07:20:55 INFO - 'USER': 'cltbld', 07:20:55 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:55 INFO - '_': '/tools/buildbot/bin/python'} 07:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:55 INFO - Downloading/unpacking psutil>=0.7.1 07:20:55 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 07:20:55 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 07:20:55 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 07:20:55 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 07:20:55 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 07:20:55 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 07:20:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:20:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:20:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:57 INFO - Installing collected packages: psutil 07:20:57 INFO - Running setup.py install for psutil 07:20:57 INFO - building 'psutil._psutil_linux' extension 07:20:57 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 07:20:57 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 07:20:57 INFO - building 'psutil._psutil_posix' extension 07:20:57 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 07:20:57 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 07:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:20:57 INFO - Successfully installed psutil 07:20:57 INFO - Cleaning up... 07:20:57 INFO - Return code: 0 07:20:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:20:57 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')]} 07:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:57 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')]} 07:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:20:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:20:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:20:57 INFO - Using env: {'DISPLAY': ':0', 07:20:57 INFO - 'HOME': '/home/cltbld', 07:20:57 INFO - 'LANG': 'en_US.UTF-8', 07:20:57 INFO - 'LANGUAGE': 'en_US:en', 07:20:57 INFO - 'LOGNAME': 'cltbld', 07:20:57 INFO - 'MAIL': '/var/mail/cltbld', 07:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:57 INFO - 'MOZ_NO_REMOTE': '1', 07:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:57 INFO - 'NO_EM_RESTART': '1', 07:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:20:57 INFO - 'PWD': '/builds/slave/test-pgo', 07:20:57 INFO - 'SHELL': '/bin/bash', 07:20:57 INFO - 'SHLVL': '1', 07:20:57 INFO - 'TERM': 'linux', 07:20:57 INFO - 'TMOUT': '86400', 07:20:57 INFO - 'USER': 'cltbld', 07:20:57 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:57 INFO - '_': '/tools/buildbot/bin/python'} 07:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:20:57 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 07:20:57 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 07:20:57 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 07:20:57 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 07:20:57 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 07:20:57 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 07:20:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:20:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:20:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:20:59 INFO - Installing collected packages: mozsystemmonitor 07:20:59 INFO - Running setup.py install for mozsystemmonitor 07:20:59 INFO - Successfully installed mozsystemmonitor 07:20:59 INFO - Cleaning up... 07:20:59 INFO - Return code: 0 07:20:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:20:59 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')]} 07:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:59 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')]} 07:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:20:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:20:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:20:59 INFO - Using env: {'DISPLAY': ':0', 07:20:59 INFO - 'HOME': '/home/cltbld', 07:20:59 INFO - 'LANG': 'en_US.UTF-8', 07:20:59 INFO - 'LANGUAGE': 'en_US:en', 07:20:59 INFO - 'LOGNAME': 'cltbld', 07:20:59 INFO - 'MAIL': '/var/mail/cltbld', 07:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:59 INFO - 'MOZ_NO_REMOTE': '1', 07:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:59 INFO - 'NO_EM_RESTART': '1', 07:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:20:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:20:59 INFO - 'SHELL': '/bin/bash', 07:20:59 INFO - 'SHLVL': '1', 07:20:59 INFO - 'TERM': 'linux', 07:20:59 INFO - 'TMOUT': '86400', 07:20:59 INFO - 'USER': 'cltbld', 07:20:59 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:59 INFO - '_': '/tools/buildbot/bin/python'} 07:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:20:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:20:59 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 07:20:59 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 07:20:59 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 07:20:59 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 07:20:59 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 07:20:59 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 07:21:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:21:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:21:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:21:01 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 07:21:01 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 07:21:01 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 07:21:01 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 07:21:01 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 07:21:01 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 07:21:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:21:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:21:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:21:02 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 07:21:02 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 07:21:02 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 07:21:02 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 07:21:02 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 07:21:02 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 07:21:02 INFO - Downloading docopt-0.6.1.tar.gz 07:21:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:21:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:21:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:21:02 INFO - Running setup.py install for blobuploader 07:21:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:21:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:21:02 INFO - Running setup.py install for requests 07:21:02 INFO - Running setup.py install for docopt 07:21:02 INFO - Successfully installed blobuploader requests docopt 07:21:02 INFO - Cleaning up... 07:21:02 INFO - Return code: 0 07:21:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:21:02 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')]} 07:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:02 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')]} 07:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:21:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:21:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:21:02 INFO - Using env: {'DISPLAY': ':0', 07:21:02 INFO - 'HOME': '/home/cltbld', 07:21:02 INFO - 'LANG': 'en_US.UTF-8', 07:21:02 INFO - 'LANGUAGE': 'en_US:en', 07:21:02 INFO - 'LOGNAME': 'cltbld', 07:21:02 INFO - 'MAIL': '/var/mail/cltbld', 07:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:02 INFO - 'MOZ_NO_REMOTE': '1', 07:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:02 INFO - 'NO_EM_RESTART': '1', 07:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:02 INFO - 'SHELL': '/bin/bash', 07:21:02 INFO - 'SHLVL': '1', 07:21:02 INFO - 'TERM': 'linux', 07:21:02 INFO - 'TMOUT': '86400', 07:21:02 INFO - 'USER': 'cltbld', 07:21:02 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:02 INFO - '_': '/tools/buildbot/bin/python'} 07:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:21:03 INFO - Running setup.py (path:/tmp/pip-LZ3ebP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:21:03 INFO - Running setup.py (path:/tmp/pip-qlspJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:21:03 INFO - Running setup.py (path:/tmp/pip-O3cGCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:21:03 INFO - Running setup.py (path:/tmp/pip-UBtjL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:21:03 INFO - Running setup.py (path:/tmp/pip-gEobAE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:21:03 INFO - Running setup.py (path:/tmp/pip-Ppqf8x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:21:03 INFO - Running setup.py (path:/tmp/pip-4bDcA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:21:03 INFO - Running setup.py (path:/tmp/pip-sUBsmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:21:03 INFO - Running setup.py (path:/tmp/pip-MoDAyW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:21:03 INFO - Running setup.py (path:/tmp/pip-1nzjRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:21:03 INFO - Running setup.py (path:/tmp/pip-wL9mE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:21:03 INFO - Running setup.py (path:/tmp/pip-W76L1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:21:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:21:03 INFO - Running setup.py (path:/tmp/pip-4FRZks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:21:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:21:04 INFO - Running setup.py (path:/tmp/pip-innLo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:21:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:21:04 INFO - Running setup.py (path:/tmp/pip-jMGBf6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:21:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:21:04 INFO - Running setup.py (path:/tmp/pip-Q9uWoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:21:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:21:04 INFO - Running setup.py (path:/tmp/pip-rqdI4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:21:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:21:04 INFO - Running setup.py install for manifestparser 07:21:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:21:04 INFO - Running setup.py install for mozcrash 07:21:04 INFO - Running setup.py install for mozdebug 07:21:04 INFO - Running setup.py install for mozdevice 07:21:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:21:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:21:04 INFO - Running setup.py install for mozfile 07:21:04 INFO - Running setup.py install for mozhttpd 07:21:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:21:04 INFO - Running setup.py install for mozinfo 07:21:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for mozInstall 07:21:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for mozleak 07:21:05 INFO - Running setup.py install for mozlog 07:21:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for moznetwork 07:21:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for mozprocess 07:21:05 INFO - Running setup.py install for mozprofile 07:21:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for mozrunner 07:21:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:21:05 INFO - Running setup.py install for mozscreenshot 07:21:05 INFO - Running setup.py install for moztest 07:21:05 INFO - Running setup.py install for mozversion 07:21:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:21:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:21:06 INFO - Cleaning up... 07:21:06 INFO - Return code: 0 07:21:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:21:06 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')]} 07:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:06 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')]} 07:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:21:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:21:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:21:06 INFO - Using env: {'DISPLAY': ':0', 07:21:06 INFO - 'HOME': '/home/cltbld', 07:21:06 INFO - 'LANG': 'en_US.UTF-8', 07:21:06 INFO - 'LANGUAGE': 'en_US:en', 07:21:06 INFO - 'LOGNAME': 'cltbld', 07:21:06 INFO - 'MAIL': '/var/mail/cltbld', 07:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:06 INFO - 'MOZ_NO_REMOTE': '1', 07:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:06 INFO - 'NO_EM_RESTART': '1', 07:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:06 INFO - 'SHELL': '/bin/bash', 07:21:06 INFO - 'SHLVL': '1', 07:21:06 INFO - 'TERM': 'linux', 07:21:06 INFO - 'TMOUT': '86400', 07:21:06 INFO - 'USER': 'cltbld', 07:21:06 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:06 INFO - '_': '/tools/buildbot/bin/python'} 07:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:21:06 INFO - Running setup.py (path:/tmp/pip-WsW8iW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:21:06 INFO - Running setup.py (path:/tmp/pip-jlg3um-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:21:06 INFO - Running setup.py (path:/tmp/pip-MoUTGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:21:06 INFO - Running setup.py (path:/tmp/pip-OHviwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:21:06 INFO - Running setup.py (path:/tmp/pip-T8N903-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:21:06 INFO - Running setup.py (path:/tmp/pip-GHuXnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:21:06 INFO - Running setup.py (path:/tmp/pip-v7EtB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:21:06 INFO - Running setup.py (path:/tmp/pip-B1qCLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:21:06 INFO - Running setup.py (path:/tmp/pip-zCDxeV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:21:06 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)) 07:21:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:21:06 INFO - Running setup.py (path:/tmp/pip-Ge0plh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:21:07 INFO - Running setup.py (path:/tmp/pip-_8sl7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:21:07 INFO - Running setup.py (path:/tmp/pip-UARsNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:21:07 INFO - Running setup.py (path:/tmp/pip-8N0Z_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:21:07 INFO - Running setup.py (path:/tmp/pip-2Z223G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:21:07 INFO - Running setup.py (path:/tmp/pip-5rUIyn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:21:07 INFO - Running setup.py (path:/tmp/pip-_u_pbH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:21:07 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)) 07:21:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:21:07 INFO - Running setup.py (path:/tmp/pip-uvVDxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:21:07 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)) 07:21:07 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)) 07:21:07 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)) 07:21:07 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)) 07:21:07 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)) 07:21:07 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)) 07:21:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:09 INFO - Downloading blessings-1.5.1.tar.gz 07:21:09 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:21:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:21:09 INFO - Installing collected packages: blessings 07:21:09 INFO - Running setup.py install for blessings 07:21:09 INFO - Successfully installed blessings 07:21:09 INFO - Cleaning up... 07:21:09 INFO - Return code: 0 07:21:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:21:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:21:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:21:09 INFO - Reading from file tmpfile_stdout 07:21:09 INFO - Current package versions: 07:21:09 INFO - argparse == 1.2.1 07:21:09 INFO - blessings == 1.5.1 07:21:09 INFO - blobuploader == 1.2.4 07:21:09 INFO - docopt == 0.6.1 07:21:09 INFO - manifestparser == 1.1 07:21:09 INFO - mozInstall == 1.12 07:21:09 INFO - mozcrash == 0.16 07:21:09 INFO - mozdebug == 0.1 07:21:09 INFO - mozdevice == 0.47 07:21:09 INFO - mozfile == 1.2 07:21:09 INFO - mozhttpd == 0.7 07:21:09 INFO - mozinfo == 0.9 07:21:09 INFO - mozleak == 0.1 07:21:09 INFO - mozlog == 3.1 07:21:09 INFO - moznetwork == 0.27 07:21:09 INFO - mozprocess == 0.22 07:21:09 INFO - mozprofile == 0.27 07:21:09 INFO - mozrunner == 6.11 07:21:09 INFO - mozscreenshot == 0.1 07:21:09 INFO - mozsystemmonitor == 0.0 07:21:09 INFO - moztest == 0.7 07:21:09 INFO - mozversion == 1.4 07:21:09 INFO - psutil == 3.1.1 07:21:09 INFO - requests == 1.2.3 07:21:09 INFO - wsgiref == 0.1.2 07:21:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:21: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')]} 07:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:21:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:21:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:21:09 INFO - Using env: {'DISPLAY': ':0', 07:21:09 INFO - 'HOME': '/home/cltbld', 07:21:09 INFO - 'LANG': 'en_US.UTF-8', 07:21:09 INFO - 'LANGUAGE': 'en_US:en', 07:21:09 INFO - 'LOGNAME': 'cltbld', 07:21:09 INFO - 'MAIL': '/var/mail/cltbld', 07:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:09 INFO - 'MOZ_NO_REMOTE': '1', 07:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:09 INFO - 'NO_EM_RESTART': '1', 07:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:09 INFO - 'SHELL': '/bin/bash', 07:21:09 INFO - 'SHLVL': '1', 07:21:09 INFO - 'TERM': 'linux', 07:21:09 INFO - 'TMOUT': '86400', 07:21:09 INFO - 'USER': 'cltbld', 07:21:09 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:09 INFO - '_': '/tools/buildbot/bin/python'} 07:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 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)) 07:21:09 INFO - Cleaning up... 07:21:09 INFO - Return code: 0 07:21:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:21: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')]} 07:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:21:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:21:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:21:09 INFO - Using env: {'DISPLAY': ':0', 07:21:09 INFO - 'HOME': '/home/cltbld', 07:21:09 INFO - 'LANG': 'en_US.UTF-8', 07:21:09 INFO - 'LANGUAGE': 'en_US:en', 07:21:09 INFO - 'LOGNAME': 'cltbld', 07:21:09 INFO - 'MAIL': '/var/mail/cltbld', 07:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:09 INFO - 'MOZ_NO_REMOTE': '1', 07:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:09 INFO - 'NO_EM_RESTART': '1', 07:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:09 INFO - 'SHELL': '/bin/bash', 07:21:09 INFO - 'SHLVL': '1', 07:21:09 INFO - 'TERM': 'linux', 07:21:09 INFO - 'TMOUT': '86400', 07:21:09 INFO - 'USER': 'cltbld', 07:21:09 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:09 INFO - '_': '/tools/buildbot/bin/python'} 07:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:10 INFO - Downloading/unpacking jsonschema 07:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:21:11 INFO - Downloading/unpacking functools32 (from jsonschema) 07:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:21:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:21:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:21:12 INFO - warning: no files found matching '*.txt' 07:21:12 INFO - no previously-included directories found matching 'build' 07:21:12 INFO - no previously-included directories found matching 'dist' 07:21:12 INFO - no previously-included directories found matching '.git*' 07:21:12 INFO - Installing collected packages: jsonschema, functools32 07:21:12 INFO - Running setup.py install for functools32 07:21:12 INFO - warning: no files found matching '*.txt' 07:21:12 INFO - no previously-included directories found matching 'build' 07:21:12 INFO - no previously-included directories found matching 'dist' 07:21:12 INFO - no previously-included directories found matching '.git*' 07:21:12 INFO - Successfully installed jsonschema functools32 07:21:12 INFO - Cleaning up... 07:21:12 INFO - Return code: 0 07:21:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f7f69220f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16050e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, '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': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', '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 07:21:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 07:21:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 07:21:12 INFO - Using env: {'DISPLAY': ':0', 07:21:12 INFO - 'HOME': '/home/cltbld', 07:21:12 INFO - 'LANG': 'en_US.UTF-8', 07:21:12 INFO - 'LANGUAGE': 'en_US:en', 07:21:12 INFO - 'LOGNAME': 'cltbld', 07:21:12 INFO - 'MAIL': '/var/mail/cltbld', 07:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:12 INFO - 'MOZ_NO_REMOTE': '1', 07:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:12 INFO - 'NO_EM_RESTART': '1', 07:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:12 INFO - 'SHELL': '/bin/bash', 07:21:12 INFO - 'SHLVL': '1', 07:21:12 INFO - 'TERM': 'linux', 07:21:12 INFO - 'TMOUT': '86400', 07:21:12 INFO - 'USER': 'cltbld', 07:21:12 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:12 INFO - '_': '/tools/buildbot/bin/python'} 07:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:12 INFO - Downloading/unpacking flake8 07:21:12 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 07:21:12 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 07:21:12 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 07:21:12 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 07:21:12 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 07:21:12 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 07:21:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:21:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:21:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:21:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:21:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:21:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 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 07:21:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:21:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:21:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:21:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:21:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:21:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:21:14 INFO - no previously-included directories found matching 'docs/_build' 07:21:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:21:14 INFO - Running setup.py install for pep8 07:21:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:21:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:21:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:21:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:21:14 INFO - no previously-included directories found matching 'docs/_build' 07:21:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:21:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:21:14 INFO - Cleaning up... 07:21:14 INFO - Return code: 0 07:21:14 INFO - Running post-action listener: _resource_record_post_action 07:21:14 INFO - Running post-action listener: _start_resource_monitoring 07:21:15 INFO - Starting resource monitoring. 07:21:15 INFO - ##### 07:21:15 INFO - ##### Running install step. 07:21:15 INFO - ##### 07:21:15 INFO - Running pre-action listener: _resource_record_pre_action 07:21:15 INFO - Running main action method: install 07:21:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:21:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:21:15 INFO - Reading from file tmpfile_stdout 07:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:21:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:21:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:21:15 INFO - Reading from file tmpfile_stdout 07:21:15 INFO - Output received: 07:21:15 INFO - Usage: mozinstall [options] installer 07:21:15 INFO - Options: 07:21:15 INFO - -h, --help show this help message and exit 07:21:15 INFO - -d DEST, --destination=DEST 07:21:15 INFO - Directory to install application into. [default: 07:21:15 INFO - "/builds/slave/test-pgo"] 07:21:15 INFO - --app=APP Application being installed. [default: firefox] 07:21:15 INFO - mkdir: /builds/slave/test-pgo/build/application 07:21:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:21:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:21:29 INFO - Reading from file tmpfile_stdout 07:21:29 INFO - Output received: 07:21:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:21:29 INFO - Running post-action listener: _resource_record_post_action 07:21:29 INFO - ##### 07:21:29 INFO - ##### Running run-tests step. 07:21:29 INFO - ##### 07:21:29 INFO - Running pre-action listener: _resource_record_pre_action 07:21:29 INFO - Running main action method: run_tests 07:21:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:21:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:21:29 INFO - Python 2.7.3 07:21:29 INFO - Return code: 0 07:21:29 INFO - grabbing minidump binary from tooltool 07:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1693e30>, '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 0x1694d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16951c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:21:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:21:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:21:29 INFO - Return code: 0 07:21:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:21:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:21:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:21:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:21:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:21:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:21:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:21:30 INFO - Return code: 0 07:21:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:21:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 07:21:30 INFO - Using env: {'DISPLAY': ':0', 07:21:30 INFO - 'HOME': '/home/cltbld', 07:21:30 INFO - 'LANG': 'en_US.UTF-8', 07:21:30 INFO - 'LANGUAGE': 'en_US:en', 07:21:30 INFO - 'LOGNAME': 'cltbld', 07:21:30 INFO - 'MAIL': '/var/mail/cltbld', 07:21:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:21:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:30 INFO - 'MOZ_NO_REMOTE': '1', 07:21:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:30 INFO - 'NO_EM_RESTART': '1', 07:21:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:21:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:21:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:21:30 INFO - 'SHELL': '/bin/bash', 07:21:30 INFO - 'SHLVL': '1', 07:21:30 INFO - 'TERM': 'linux', 07:21:30 INFO - 'TMOUT': '86400', 07:21:30 INFO - 'USER': 'cltbld', 07:21:30 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367', 07:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:30 INFO - '_': '/tools/buildbot/bin/python'} 07:21:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 07:21:31 INFO - mozversion INFO | application_buildid: 20151127043001 07:21:31 INFO - mozversion INFO | application_changeset: 47b49b0d32360fab04b11ff9120970979c426911 07:21:31 INFO - mozversion INFO | application_display_name: Nightly 07:21:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:21:31 INFO - mozversion INFO | application_name: Firefox 07:21:31 INFO - mozversion INFO | application_remotingname: firefox 07:21:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:21:31 INFO - mozversion INFO | application_vendor: Mozilla 07:21:31 INFO - mozversion INFO | application_version: 45.0a1 07:21:31 INFO - mozversion INFO | platform_buildid: 20151127043001 07:21:31 INFO - mozversion INFO | platform_changeset: 47b49b0d32360fab04b11ff9120970979c426911 07:21:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:21:31 INFO - mozversion INFO | platform_version: 45.0a1 07:21:31 INFO - 2015-11-27 07:21:31,139 DEBUG : using testdate: 1448637691 07:21:31 INFO - 2015-11-27 07:21:31,139 DEBUG : actual date: 1448637691 07:21:31 INFO - 2015-11-27 07:21:31,270 INFO : starting webserver on 'localhost:56529' 07:21:31 INFO - 2015-11-27 07:21:31,271 INFO : Starting test suite talos-linux64-ix-029.e 07:21:31 INFO - 2015-11-27 07:21:31,272 INFO : Starting test dromaeo_css 07:21:31 INFO - 2015-11-27 07:21:31,272 DEBUG : operating with platform_type : linux_ 07:21:31 INFO - 2015-11-27 07:21:31,272 INFO : Initialising browser for dromaeo_css test... 07:21:31 INFO - 2015-11-27 07:21:31,285 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpid5Vg5/profile http://localhost:56529/getInfo.html 07:21:36 INFO - 2015-11-27 07:21:36,119 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:21:36 INFO - 2015-11-27 07:21:36,120 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:21:36 INFO - 2015-11-27 07:21:36,120 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:21:36 INFO - 2015-11-27 07:21:36,120 DEBUG : BROWSER_OUTPUT: __metrics 07:21:37 INFO - 2015-11-27 07:21:37,119 INFO : Browser initialized. 07:21:37 INFO - 2015-11-27 07:21:37,119 INFO : Running cycle 1/1 for dromaeo_css test... 07:21:37 INFO - 2015-11-27 07:21:37,120 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpid5Vg5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:21:48 INFO - 2015-11-27 07:21:48,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 138383360 07:21:48 INFO - 2015-11-27 07:21:48,898 DEBUG : BROWSER_OUTPUT: 07:22:38 INFO - 2015-11-27 07:22:38,516 DEBUG : BROWSER_OUTPUT: 1448637758510 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] 07:24:47 INFO - 2015-11-27 07:24:47,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56529/tests/dromaeo/cssquery-ext.html) 07:24:48 INFO - 2015-11-27 07:24:48,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 148799488 07:24:48 INFO - 2015-11-27 07:24:48,641 DEBUG : BROWSER_OUTPUT: 07:27:50 INFO - 2015-11-27 07:27:50,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-ext.html (next: http://localhost:56529/tests/dromaeo/cssquery-jquery.html) 07:27:51 INFO - 2015-11-27 07:27:51,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 07:27:51 INFO - 2015-11-27 07:27:51,193 DEBUG : BROWSER_OUTPUT: 07:30:52 INFO - 2015-11-27 07:30:52,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56529/tests/dromaeo/cssquery-mootools.html) 07:30:53 INFO - 2015-11-27 07:30:53,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 143892480 07:30:53 INFO - 2015-11-27 07:30:53,449 DEBUG : BROWSER_OUTPUT: 07:33:55 INFO - 2015-11-27 07:33:55,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56529/tests/dromaeo/cssquery-prototype.html) 07:33:55 INFO - 2015-11-27 07:33:55,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 07:33:55 INFO - 2015-11-27 07:33:55,717 DEBUG : BROWSER_OUTPUT: 07:36:57 INFO - 2015-11-27 07:36:57,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56529/tests/dromaeo/cssquery-yui.html) 07:36:58 INFO - 2015-11-27 07:36:58,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 142794752 07:36:58 INFO - 2015-11-27 07:36:58,576 DEBUG : BROWSER_OUTPUT: 07:40:00 INFO - 2015-11-27 07:40:00,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/dromaeo/cssquery-yui.html (next: http://localhost:56529/tests/dromaeo/cssquery-dojo.html) 07:40:01 INFO - 2015-11-27 07:40:01,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 144191488 07:40:01 INFO - 2015-11-27 07:40:01,179 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,181 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:40:01 INFO - 2015-11-27 07:40:01,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:40:01 INFO - 2015-11-27 07:40:01,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:40:01 INFO - 2015-11-27 07:40:01,181 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:40:01 INFO - 2015-11-27 07:40:01,185 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3200.487921932491;3273.4435146025157;3300.290437555925;3321.186309354208;3321.269320749436;5249.685018898868;5485.835424937253;5489.807856725015;5511.889762204753;5516.14499752538;5398.6220964532495;5404.054290499166;5470.5623550116;5561.193626924093;5581.330240371161;5013.2480127980825;5039.974800125994;5050.444451110375;5055.064813009587;5104.285400043997;5125.282460455521;5136.409312929005;5161.741912904358;5175.611829112813;5176.990486855065;4819.542143496362;4928.802847886116;4960;5077.2637967494875;5151.4075881273575;5061.089003979282;5062.645614806965;5065.848024559269;5081.542661160476;5124.385073791132;5040.092783299005;5042.546170844605;5051.318072060299;5063.164577844651;5082.364704411949;5219.269302297681;5237.292965449692;5299.258103865462;5309.893802123975;5327.547158491533;5981.013132833077;6006.819795406145;6012.518998480111;6014.578979471439;6018.759249630009;5814;5988.9401105989255;5994.400559944014;6005.309389420186;6013.75944962201;5486.341639003305;5548.306461692288;5553.361363443175;5564.27664403629;5610.691411972381;6115.357887421846;6118.449339559461;6124.989376752786;6126.417990290915;6129;5753.539716822645;5879.617824841457;5895.145203945404;5908.852278692981;5925.881482370414;5814.244148260699;5894.8821023579285;5906;5910.468057874812;5914.4381283777975;5876.823695289148;5913.733881975236;5922.792702255487;5924.229850119457;5933.970330148321;5791.131330300489;5873.823785286449;5946.316173640001;5954;5955.672438015864;4590;4604.286335617984;4620.3993480847275;4623.075384923029;4627.745473998963;4088.2845502037026;4098.918021639551;4121.793910304473;4129.814158362881;4171.0823618803815;5522.088855338824;5597.412271711493;5610.943890561042;5614.326280846324;5741.909037282986;5955.731992060368;5958.225430693982;5964.135200395918;5996.5202783777195;6033.909491357633;5712.11462223356;5722.484976352148;5725.8568535786935;5731.627444216113;5734.942650573441;4998.350214472095;5101.005303965691;5118.948810511847;5119.180931051014;5126.307948426989;6179;6209.720562574695;6219.689015549205;6246.281677607133;6258.968705156445;6034.969825150846;6044.123602077762;6049.909251361321;6052.273727152769;6064.4541991221;5942.435468630473;6038.5169186465855;6123.958926982335;6158.507319414526;6233.314335423009;5859.326177489644;5866.853328666817;5879.882402352015;5887.264091988502;5923.5853490256995;5964.403559644001;6000.069989151689;6000.519958403404;6006.609570377911;6027.758889644365;5546.112621980464;5694.829155125353;5803.47768700819;5887.735051922759;5941.1385349125;5792.768289268382;5800.332961709458;5820.796272130455;5825.883482330414;5833.795817146549;5520.66875987442;5710.2291190690385;5734.168545560787;5735.311762588516;5738.68437235956;5661.0659241226385;5751.654900705971;5762.596618236851;5788.334341550607;5932;5743.3395159557185;5757.740901659352;5758.3090029196765;5759.712014399347;5766.682832444256 07:40:01 INFO - 2015-11-27 07:40:01,185 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.6683989606237;571.9199312096309;600.8918394688956;601.6931365003848;602.7588964414234;38754.61245387545;39436.40845387321;39620;39793;39951.200975980464;42242.78878605603;43138;43265.35101973473;43290;43293.78353108238;8621.698240561582;8728.607212675413;8786.341024423162;8811.515366654832;8816;8585.270252028586;8687.609057592423;8688.391812573122;8739.825203495959;8753.255973242281;8694.304455643565;8735.21383075523;8765.211130998208;8769.56152192391;8775.297976161892;8642.524661143634;8728.345374096936;8744.825103497895;8824.470531768082;8840.8673869892;8531.829363412759;8660.090690477535;8695.478271303742;8695.652173913037;8696.565171741451;38859.41710874339;39097.60902390968;39121.21757564833;39331;39346.40980385296;3440.9311813763834;3453.0849324928663;3536.734744894143;3538.663826936437;4011.5988401159943;29289.316552683922;30000.54999175014;30010.549841752392;30054.54918176229;30389.69610303913;3747.906302342436;3839.520059992501;3867.323218436762;3934.311495488278;3940.093778430948;269628;270043;270063;270168.64915675495;270806;50523.74738126286;51854.74072629613;56051.71974140103;56435;56500.71749641225;66984;68217;68281;68506.65746671334;68606.65696671484;15252.23738813077;15390.692186156215;15394.461193858162;15395.307211175525;15615.657651352389;12149.696257593454;12260.203086799329;12301.876981230253;12405.503779848885;12428.62714118578;18976.43070707881;19148;19270.132844022053;19343.4196974091;19470.415887523395;7837.294643482114;8073.878891816627;8149.877751833608;8172.75481735537;8186.631601577943;939.8026414452904;1020.5917632946732;1035.1873779083535;1049.5434485998614;1080.773037662084;28869;29287.414251714847;29301.26746831346;29335.413291734472;29672.703272966995;1033.850091736709;1052.484282701486;1089.2756317049073;1165.6269993602136;1165.6561314412268;15208.163551004802;15208.771868421982;15334;15541.922290388477;15546.76679849803;331033;334598;336818;336918;338272;50531;50663;50732.98534029299;51259.23111153336;51272.48727512677;1341.7115320206203;1346.1557665997645;1363.277462944641;1368.1654190943516;1373.9763875912508;27687.723122768515;28743.281417964718;28910.277243069093;29033;29115;48818.26772598485;49506.50493495163;50080.749596251786;50140;50174.247386289964;219831;221028;221146;222531;222561;29475.263118422212;31876.681233188297;32158.839205803823;32375;32453.837730811196;39223.80388098041;42301.36547951845;42883.7855810719;43543.564564353954;43789.56210437855;35275.82362088173;35429.29141417209;35592.82203588966;35941;36080.819595901856;35098.29803403969;36125.638743612224;36132.63867361293;36153.0961725959;36346.273074537836;32821.343573128885;33410.832945835115;33695.15762105967;33817.49273760847;33893.83053084719;31155.53266700956;32575.185620358734;33004.66995330016;33771.3245735079;33812.830935845166;24273.878630606734;25376.74623253744;25404;25555.849986751015;25864.870675647253 07:40:01 INFO - 2015-11-27 07:40:01,188 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.6496850602158;356.47064109796963;357.2444280347067;358.28700885238374;360.2416912399398;16410.097444640556;16747.24637391319;17453.38913138042;17586.912065439654;18267.90866045668;11033.503492342843;11085;11232.438378081084;11263.718407039807;11308.264962777434;4869.659123861331;4895.388076490439;5003.799848006075;5018.924716129242;5054.039732450822;4949.307097006422;4964.702117872921;5002.624803139761;5002.974985125069;5019.447860735316;3747.9625203747887;3850.826712797917;5046.318746969149;5051.090803655341;5379.300690910196;5448.782048718046;5500.1749737539285;5518.530924871371;5519.9448005519835;5527.778888844441;5174.922376164361;5284.471552844723;5322.654027488201;5334.386545547273;5339.546138578186;20132.49668758278;20435.284765033302;20776.792232077787;20999.055042523123;21053.47366315839;2123.6071326804436;2154.138344662132;2245.584566855137;2275.8748268845206;2311.9537609247723;9704.175145112675;9722.562484688206;9830.557624906896;10123.595056197742;13534.932325338408;1836.9540761481069;1855.1651756709534;1865.8880467172014;1882.4352694191825;1910.2263583248669;59940.70029649824;60100.56755949443;61539.07691384633;61717.691411542655;62591.99999999954;10078.193744500422;10145.391276523433;10213.744656383502;10231;10232.283740138268;13398.531051413154;13436.395362208725;13457.25985070811;13466.93266533661;13475.595732128051;7745.728899488491;7760.417968652374;7865.370770338359;7908.446408751447;7911.367090632735;7320.633968301564;7462.104547454232;7652.73215437457;7687.769366919001;7769.72805951789;4445.599896009375;4461.107778444324;4489.169503641837;4492.3710680504755;4519.05099929012;1879.5676994291389;1906.36136894142;1920.8847469151895;1927.759030121235;1942.893140877237;422.17675532711337;425.7488082031616;427.89516568440933;891.2023738753779;1011.6004178349658;10717;11248.26886252391;11320.150988675883;16395.836041639668;17103.48689539291;944.6127087893931;978.5449765858909;990.7275499237767;1003.1623594298842;1062.3944351719447;9648.890377606525;10040.748981275381;10056.74858128538;10068;10089.142422893989;414979;416689;420987;424983;546792;73028;76579.7772544004;82645.58677206696;85513;85948.57025714831;1119.7032786311634;1144.250515912079;1148.4143087025677;1149.9195056346143;1156.0866915137115;15672.686546269239;15684.76472852931;15932.283047262668;15949.534130443495;16335.754963675792;34711.4793278096;35599.28801424009;35646.28707425785;35696.64303356933;36983.815080924425;45786;46267.76866115648;46280;47683.52316476929;47746.28380574225;9342.205912497513;9429.198518125762;9594.808103838024;9655.806883862424;9711.66009189675;11651.88348116508;11830.58592949277;11832.70418239551;11837.64487065355;12523;14669.779953300922;14676.04605700626;14819.481318153812;14869.851301486846;14878.553643390716;14169.149851008973;14192.858071419154;14375.640608984859;14467.710645787236;14828.40686372533;14289.785653215418;14369;14719.337629806898;15078.773818392952;15165;9388.718338449584;9460.905390946278;9576.329656923948;9585.712428627152;9624.470654114091;10202.948985255027;13216.207027578375;13962.930185349009;14278.500252491112;14952.850471495582 07:40:01 INFO - 2015-11-27 07:40:01,188 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1518.8633023027926;1681.688887555802;1752.1064257228809;1778.4397914656881;1784.9464516064515;7644.694212231504;7707.92292077079;7931.6034198290145;7964.800879978004;7984.640691168889;7931.960340198291;7938.880916786238;7946.562939038351;7954.403419743513;8040.517568945853;2244.9775502244975;2268;2281.0533628544135;2283.931482055541;2289.8053665438456;2313.826463015272;2328.1269523928527;2377.286813955815;2379.690640216778;2384.1893756122913;2277.6925115109498;2305.700258966332;2309.7343805462333;2326.5463234669246;2334.9766502335015;2294.621387471065;2313.178821518362;2356.4108972756812;2368.7394386617457;2369.3247424484025;2338.497223097025;2365.042157926043;2368.881555922197;2370.099362242354;2370.6207006878817;7812.179721129313;7859.764207073797;7886.329661978739;7914;7948.125706172316;4773.3078703588135;4832.081904438145;4875.317455556225;4884.267359896008;4898.044881248158;3040.8783648654025;3086.753059755214;3177.3009937813645;3177.8728850845937;3228.9354212915846;1049.8530205771199;1054.7679510507676;1065.2223876570147;1074.6346242277584;1084.2193620593239;10614.257002009863;10739.355638661706;10744.033037026706;10763.19276054299;10794.136469082454;4267.317229243368;4290.656747460196;4335.674824388184;4374.5625437456;4382.276924307517;8639.6976105836;8641.654333826576;8664.91335086641;8671.046184919654;8688.739337819876;4816.686915350491;4822.842517795703;4827.782749776268;4832.347633069561;4880.731559764247;4432.601065904019;4475.552444755564;4475.888102797391;4480.887977800581;4482.932756008662;3513.5432393789156;3564.8574057037945;3566.589842168132;3586.372384832644;3590.3537363274863;1116.3580940958818;1117.1509652664033;1134.2740645986576;1159.8492196014465;1198.5385626533673;1107.6289443036674;1111.360967443723;1147.1625713229223;1300.206873806977;1381.5855243426931;7116.893246601305;7144.607046612382;7165.032720582759;7517.511361761468;7652.196519365498;1149.8332741752567;1156.1848896527927;1178.192937837584;1197.3773637708516;1207.945642446092;5817.796377126865;5876.265466816648;5887.8233652990475;5888.793892213752;5942.049272116527;9188.49463279526;9381.390209636353;9400.717978460658;9477.383970041925;9499.38254013487;9244.352895297265;9271.582778774971;9281.72154835356;9341.579628916716;9393.718188454357;7196.352328290479;7309.232530584212;7311.597862117528;7323.450741194431;7371;7238.782836514913;7270.272972702687;7301.926980730337;7302.415806735555;7320.267973202637;8158.714444994397;8245.505269683597;8249.628766705633;8306.920100387153;8353.373496987871;8349.332053435832;8417.326613870753;8427.536485493356;8453.78865528342;8551.315894728532;6938.618375989369;6973.093497845451;7010.68451919675;7028.50800443964;7063.576185428685;7487.887681684888;7557.470977031555;7567.508111972704;7595.5442673439775;7620.8475830484185;6287.937120628735;7200.351968322876;7224.13310402755;7253.927460725326;7256.310650488195;6161.465677457315;6717.529772915849;7047.260037695968;7164.856702866018;7188.245234250328;6904.171499420102;6947.826304342432;7148.678309475982;7187.892181617175;7188.820279493055;6667.133272674521;6673.666316684049;6697.09589205451;6700.6984685688285;6715.026321183499;6675.4325882300545;6700.564463309869;6720.428763554957;6733.966330168318;6755.831104222434 07:40:01 INFO - 2015-11-27 07:40:01,189 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.82996097088056;328.3613371991476;336.9022983334833;347.39379782279923;348.9214926641506;6107.328193898678;6178.536609754269;6191.442770150686;6269.78055768047;6288.371162883715;5996.700164991744;6120.602160859541;6170.784022559212;6198.256209254884;6204.720787564559;4774.641901857374;4784.880377990543;4791.329213910055;4804.5916097131785;4808.687435316702;4787.114383839001;4788.736619485944;4792.376990991166;4795.448523419799;4800.639952003597;4627.07458508298;4682;4694.647901407391;4699.177643912319;4769.618430525549;4760.880977975544;4761.023990082025;4761.833335833247;4767.809287628491;4777.0684716479955;4171.520275168364;4192.790360481994;4194.056337324108;4196.748195108304;4217.662586993064;5893.440123188333;5917.881642367129;5925.111233315038;5930.495907847838;5933.139694744281;5449.727513624303;5565.749541270652;5580.246666699984;5584.0507113790345;5596.552275817925;6581.3747693969;6594.208694956588;6607.966960165217;6623.3376662333385;6627.237867645186;4648.767561621939;4650.976785107305;4653.162430762462;4653.488116307203;4663.626909847238;6692.364225398579;6805.890174046012;6841.281665425158;6857.485688573377;6862.656867156622;4770.713757174581;4770.833020844254;4772.188727916263;4780.593649539828;4780.784864681098;4827.975860120677;4838.395200599925;4843;4846.273059041101;4859.441164266154;5520.723963801875;5546.722663866791;5573.470520300565;5573.5819813514145;5574.944250557523;6547.9017814732815;6659.766908158192;6671.132752742113;6671.899921501182;6679.699413526403;1608.388812251337;1662.642531855657;1670.7911511061118;1674.2465890349392;1678.2196278730205;1062.6918193723734;1076.8707755069443;1077.256692881909;1084.7776205877776;1099.5766629847567;6410.711517981702;6422.421982021547;6426.550141490145;6432.581882177644;6446;6770.356816102462;6779.796606101825;6788.287229840796;6790.524663273523;6800.965995169992;6365.777197798055;6387.233531976192;6401.807945761635;6409.487241020707;6409.775657851953;3750.5311836020496;3757.812109394519;3772.13240954582;3784.7161462890394;3789.317922773927;7178.533395329391;7181.964090179516;7188.5327453715345;7194.136703595497;7234.131904171533;6909.343612356818;7070;7072.646367681596;7076.504644674927;7138.607376594337;7122.893156602655;7135.857282854314;7171.677274522659;7194.964025179841;7195.244499327495;6898.344657257552;6904.792856214322;6917.858553338643;6919.135108111486;6934.618595977068;6726.596404215763;6815.863682726219;6828.863422731617;6842.521023528305;6850.828729281808;7173.677184526813;7194.712211511481;7198;7203.2076471589135;7215.366391267255;4619.630429565559;4649.139909116824;4660.883477913079;4662.370579971661;4681.859544213679;6814.8637027260165;6862.588244705334;6897.965510172417;6907.34380233877;6933.237343892067;6721.613827091508;6724.831879202863;6726.428253598303;6728.831779205559;6731.865362692621;6693.431058359899;6694.665266736546;6706.262311145868;6717.16035495563;6717.16035495563;6483.773067942788;6514.771982980573;6581.111549940697;6597.6041437511985;6598.769043083469;6619.470442364695;6673.366030227121;6695.866082678416;6711.395974362331;6717.059611654275;6514.73941042353;6544.051112588743;6546.312637173029;6560.507961902781;6562.048502966947 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: |5;yui.html;788.4993029426314;834.4534330013843;851.0765819086291;858.1418581418582;908.8409528332543;12768.936155319221;13176;13227.20636761795;13290.800637990438;13318.800217996737;12472.438740256688;12502.874741273283;12610.495580176805;12616;12653.240805551673;670.1689904518387;675.8445557521773;806.0488623424357;812.1026265976085;826.1160558202725;818.5907046476761;826.7313123234943;828.4490813608943;832.3341326938455;835.2524490580927;858.459170722444;861.7802460372596;867.6616119713317;869.42183448007;870.7561882672861;853.9231469167805;854.692310768123;858.8239410920778;858.8711693246032;859.1451505751786;629.7386584567399;634.4416913116428;636.7389370358131;638.4955884850962;639.5555089212999;12514.687132821753;12610.558630447982;12615.369231538387;12615.621531354074;12650.367481625883;11267.26762760418;11867.347295898722;11990;12021.459034343476;12165.635030948997;9668.274879384004;9718.951405242928;9724.82552342971;9742.220622350194;9877.160441362494;3647.215848592539;3658.835352409148;3663.4687970244167;3737.8691745788765;3825.407061905409;46797.53202468;46967.76516117432;46994.76502617465;47141;48066;9388.061193880558;9479.857802132974;9498.240140788721;9509.286803489627;9738.220942324739;18071;18300.359487418144;18310.52807870947;18311.63376732458;18499.167537460846;7733.961330193313;7784.455088143775;7829.608519573999;7840.803979900548;7945.165757595485;4232.661387089025;4283.271843786564;4408.272635015187;4414.735115893057;4467.12890986261;3093.0256969054676;3114.5483904833673;3114.8754049838208;3116.111908106179;3127.7341425978593;559.7928766356392;572.7279542217497;575.0999685492192;581.6858896196006;583.7869177750091;646.7485415720596;692.0864458914185;696.3906581740977;699.1470406104544;710.1052673631261;8058.348038652062;8127.715529956541;8331.66673333072;8406.663733450716;8545.188207120314;540.6485784240197;545.0434487474457;670.53062856001;695.3220609905403;715.595688436032;3848.8652897148463;4130.132672138884;4266.5946735060115;4344.82620695175;4407.246318981674;55848.44151558514;57000;57910;58205.417945820845;61147.38852611506;49063.26405103926;49484.50515494799;49613;50299;51294;45996.3100553492;46017;46342.76828615835;46511.53488465072;46613.533864660916;8379;8412.579371031547;8449.197326253996;8522.27560657351;8559.614817333111;34696.306073878884;35024.824875875456;35394.29211415809;35694.4645830318;36226.456603150444;41628.79185604052;42756.57243427526;43774.34338484989;44206.33690494709;44813.551864482244;10379.688609341732;10576;10686.145108391154;10894.836577451502;11393.373364465035;11670.591529296435;11706.122040847142;12144.846239607223;12148.39258037077;12323.69190770238;11416.257943233662;11579.536818527165;11606.535738570701;11923.821142682693;12116.454759535665;10894.346339219672;11386.089112871116;12035.458404371999;12323.50705971787;12390.504379824706;11343.376114313793;11424.428778560872;11542.538298468304;11809;11842.881571184522;8787.956060219658;9065.592048357708;9158.58786354629;9307.348485605942;9466.100720431548;8439.578021099043;8822.470651760916;8825.470471771714;9921.45432001218;9954.303198776017 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,301 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: __startTimestamp1448638801180__endTimestamp 07:40:01 INFO - 2015-11-27 07:40:01,190 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5523.36 Median:5741.91 stddev:619.32 (10.8%) stddev-sans-first:593.81 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: Values: 3200.5 3273.4 3300.3 3321.2 3321.3 5249.7 5485.8 5489.8 5511.9 5516.1 5398.6 5404.1 5470.6 5561.2 5581.3 5013.2 5040.0 5050.4 5055.1 5104.3 5125.3 5136.4 5161.7 5175.6 5177.0 4819.5 4928.8 4960.0 5077.3 5151.4 5061.1 5062.6 5065.8 5081.5 5124.4 5040.1 5042.5 5051.3 5063.2 5082.4 5219.3 5237.3 5299.3 5309.9 5327.5 5981.0 6006.8 6012.5 6014.6 6018.8 5814.0 5988.9 5994.4 6005.3 6013.8 5486.3 5548.3 5553.4 5564.3 5610.7 6115.4 6118.4 6125.0 6126.4 6129.0 5753.5 5879.6 5895.1 5908.9 5925.9 5814.2 5894.9 5906.0 5910.5 5914.4 5876.8 5913.7 5922.8 5924.2 5934.0 5791.1 5873.8 5946.3 5954.0 5955.7 4590.0 4604.3 4620.4 4623.1 4627.7 4088.3 4098.9 4121.8 4129.8 4171.1 5522.1 5597.4 5610.9 5614.3 5741.9 5955.7 5958.2 5964.1 5996.5 6033.9 5712.1 5722.5 5725.9 5731.6 5734.9 4998.4 5101.0 5118.9 5119.2 5126.3 6179.0 6209.7 6219.7 6246.3 6259.0 6035.0 6044.1 6049.9 6052.3 6064.5 5942.4 6038.5 6124.0 6158.5 6233.3 5859.3 5866.9 5879.9 5887.3 5923.6 5964.4 6000.1 6000.5 6006.6 6027.8 5546.1 5694.8 5803.5 5887.7 5941.1 5792.8 5800.3 5820.8 5825.9 5833.8 5520.7 5710.2 5734.2 5735.3 5738.7 5661.1 5751.7 5762.6 5788.3 5932.0 5743.3 5757.7 5758.3 5759.7 5766.7 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,191 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45073.69 Median:35511.06 stddev:73103.53 (205.9%) stddev-sans-first:73232.18 07:40:01 INFO - 2015-11-27 07:40:01,193 DEBUG : BROWSER_OUTPUT: Values: 552.7 571.9 600.9 601.7 602.8 38754.6 39436.4 39620.0 39793.0 39951.2 42242.8 43138.0 43265.4 43290.0 43293.8 8621.7 8728.6 8786.3 8811.5 8816.0 8585.3 8687.6 8688.4 8739.8 8753.3 8694.3 8735.2 8765.2 8769.6 8775.3 8642.5 8728.3 8744.8 8824.5 8840.9 8531.8 8660.1 8695.5 8695.7 8696.6 38859.4 39097.6 39121.2 39331.0 39346.4 3440.9 3453.1 3536.7 3538.7 4011.6 29289.3 30000.5 30010.5 30054.5 30389.7 3747.9 3839.5 3867.3 3934.3 3940.1 269628.0 270043.0 270063.0 270168.6 270806.0 50523.7 51854.7 56051.7 56435.0 56500.7 66984.0 68217.0 68281.0 68506.7 68606.7 15252.2 15390.7 15394.5 15395.3 15615.7 12149.7 12260.2 12301.9 12405.5 12428.6 18976.4 19148.0 19270.1 19343.4 19470.4 7837.3 8073.9 8149.9 8172.8 8186.6 939.8 1020.6 1035.2 1049.5 1080.8 28869.0 29287.4 29301.3 29335.4 29672.7 1033.9 1052.5 1089.3 1165.6 1165.7 15208.2 15208.8 15334.0 15541.9 15546.8 331033.0 334598.0 336818.0 336918.0 338272.0 50531.0 50663.0 50733.0 51259.2 51272.5 1341.7 1346.2 1363.3 1368.2 1374.0 27687.7 28743.3 28910.3 29033.0 29115.0 48818.3 49506.5 50080.7 50140.0 50174.2 219831.0 221028.0 221146.0 222531.0 222561.0 29475.3 31876.7 32158.8 32375.0 32453.8 39223.8 42301.4 42883.8 43543.6 43789.6 35275.8 35429.3 35592.8 35941.0 36080.8 35098.3 36125.6 36132.6 36153.1 36346.3 32821.3 33410.8 33695.2 33817.5 33893.8 31155.5 32575.2 33004.7 33771.3 33812.8 24273.9 25376.7 25404.0 25555.8 25864.9 07:40:01 INFO - 2015-11-27 07:40:01,193 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,193 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25959.93 Median:17977.47 stddev:73470.46 (408.7%) stddev-sans-first:73651.41 07:40:01 INFO - 2015-11-27 07:40:01,193 DEBUG : BROWSER_OUTPUT: Values: 355.6 356.5 357.2 358.3 360.2 16410.1 16747.2 17453.4 17586.9 18267.9 11033.5 11085.0 11232.4 11263.7 11308.3 4869.7 4895.4 5003.8 5018.9 5054.0 4949.3 4964.7 5002.6 5003.0 5019.4 3748.0 3850.8 5046.3 5051.1 5379.3 5448.8 5500.2 5518.5 5519.9 5527.8 5174.9 5284.5 5322.7 5334.4 5339.5 20132.5 20435.3 20776.8 20999.1 21053.5 2123.6 2154.1 2245.6 2275.9 2312.0 9704.2 9722.6 9830.6 10123.6 13534.9 1837.0 1855.2 1865.9 1882.4 1910.2 59940.7 60100.6 61539.1 61717.7 62592.0 10078.2 10145.4 10213.7 10231.0 10232.3 13398.5 13436.4 13457.3 13466.9 13475.6 7745.7 7760.4 7865.4 7908.4 7911.4 7320.6 7462.1 7652.7 7687.8 7769.7 4445.6 4461.1 4489.2 4492.4 4519.1 1879.6 1906.4 1920.9 1927.8 1942.9 422.2 425.7 427.9 891.2 1011.6 10717.0 11248.3 11320.2 16395.8 17103.5 944.6 978.5 990.7 1003.2 1062.4 9648.9 10040.7 10056.7 10068.0 10089.1 414979.0 416689.0 420987.0 424983.0 546792.0 73028.0 76579.8 82645.6 85513.0 85948.6 1119.7 1144.3 1148.4 1149.9 1156.1 15672.7 15684.8 15932.3 15949.5 16335.8 34711.5 35599.3 35646.3 35696.6 36983.8 45786.0 46267.8 46280.0 47683.5 47746.3 9342.2 9429.2 9594.8 9655.8 9711.7 11651.9 11830.6 11832.7 11837.6 12523.0 14669.8 14676.0 14819.5 14869.9 14878.6 14169.1 14192.9 14375.6 14467.7 14828.4 14289.8 14369.0 14719.3 15078.8 15165.0 9388.7 9460.9 9576.3 9585.7 9624.5 10202.9 13216.2 13962.9 14278.5 14952.9 07:40:01 INFO - 2015-11-27 07:40:01,193 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,194 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5510.24 Median:6224.70 stddev:2796.64 (44.9%) stddev-sans-first:2788.39 07:40:01 INFO - 2015-11-27 07:40:01,195 DEBUG : BROWSER_OUTPUT: Values: 1518.9 1681.7 1752.1 1778.4 1784.9 7644.7 7707.9 7931.6 7964.8 7984.6 7932.0 7938.9 7946.6 7954.4 8040.5 2245.0 2268.0 2281.1 2283.9 2289.8 2313.8 2328.1 2377.3 2379.7 2384.2 2277.7 2305.7 2309.7 2326.5 2335.0 2294.6 2313.2 2356.4 2368.7 2369.3 2338.5 2365.0 2368.9 2370.1 2370.6 7812.2 7859.8 7886.3 7914.0 7948.1 4773.3 4832.1 4875.3 4884.3 4898.0 3040.9 3086.8 3177.3 3177.9 3228.9 1049.9 1054.8 1065.2 1074.6 1084.2 10614.3 10739.4 10744.0 10763.2 10794.1 4267.3 4290.7 4335.7 4374.6 4382.3 8639.7 8641.7 8664.9 8671.0 8688.7 4816.7 4822.8 4827.8 4832.3 4880.7 4432.6 4475.6 4475.9 4480.9 4482.9 3513.5 3564.9 3566.6 3586.4 3590.4 1116.4 1117.2 1134.3 1159.8 1198.5 1107.6 1111.4 1147.2 1300.2 1381.6 7116.9 7144.6 7165.0 7517.5 7652.2 1149.8 1156.2 1178.2 1197.4 1207.9 5817.8 5876.3 5887.8 5888.8 5942.0 9188.5 9381.4 9400.7 9477.4 9499.4 9244.4 9271.6 9281.7 9341.6 9393.7 7196.4 7309.2 7311.6 7323.5 7371.0 7238.8 7270.3 7301.9 7302.4 7320.3 8158.7 8245.5 8249.6 8306.9 8353.4 8349.3 8417.3 8427.5 8453.8 8551.3 6938.6 6973.1 7010.7 7028.5 7063.6 7487.9 7557.5 7567.5 7595.5 7620.8 6287.9 7200.4 7224.1 7253.9 7256.3 6161.5 6717.5 7047.3 7164.9 7188.2 6904.2 6947.8 7148.7 7187.9 7188.8 6667.1 6673.7 6697.1 6700.7 6715.0 6675.4 6700.6 6720.4 6734.0 6755.8 07:40:01 INFO - 2015-11-27 07:40:01,195 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,196 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5569.52 Median:6376.51 stddev:1687.11 (26.5%) stddev-sans-first:1645.15 07:40:01 INFO - 2015-11-27 07:40:01,196 DEBUG : BROWSER_OUTPUT: Values: 317.8 328.4 336.9 347.4 348.9 6107.3 6178.5 6191.4 6269.8 6288.4 5996.7 6120.6 6170.8 6198.3 6204.7 4774.6 4784.9 4791.3 4804.6 4808.7 4787.1 4788.7 4792.4 4795.4 4800.6 4627.1 4682.0 4694.6 4699.2 4769.6 4760.9 4761.0 4761.8 4767.8 4777.1 4171.5 4192.8 4194.1 4196.7 4217.7 5893.4 5917.9 5925.1 5930.5 5933.1 5449.7 5565.7 5580.2 5584.1 5596.6 6581.4 6594.2 6608.0 6623.3 6627.2 4648.8 4651.0 4653.2 4653.5 4663.6 6692.4 6805.9 6841.3 6857.5 6862.7 4770.7 4770.8 4772.2 4780.6 4780.8 4828.0 4838.4 4843.0 4846.3 4859.4 5520.7 5546.7 5573.5 5573.6 5574.9 6547.9 6659.8 6671.1 6671.9 6679.7 1608.4 1662.6 1670.8 1674.2 1678.2 1062.7 1076.9 1077.3 1084.8 1099.6 6410.7 6422.4 6426.6 6432.6 6446.0 6770.4 6779.8 6788.3 6790.5 6801.0 6365.8 6387.2 6401.8 6409.5 6409.8 3750.5 3757.8 3772.1 3784.7 3789.3 7178.5 7182.0 7188.5 7194.1 7234.1 6909.3 7070.0 7072.6 7076.5 7138.6 7122.9 7135.9 7171.7 7195.0 7195.2 6898.3 6904.8 6917.9 6919.1 6934.6 6726.6 6815.9 6828.9 6842.5 6850.8 7173.7 7194.7 7198.0 7203.2 7215.4 4619.6 4649.1 4660.9 4662.4 4681.9 6814.9 6862.6 6898.0 6907.3 6933.2 6721.6 6724.8 6726.4 6728.8 6731.9 6693.4 6694.7 6706.3 6717.2 6717.2 6483.8 6514.8 6581.1 6597.6 6598.8 6619.5 6673.4 6695.9 6711.4 6717.1 6514.7 6544.1 6546.3 6560.5 6562.0 07:40:01 INFO - 2015-11-27 07:40:01,196 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,196 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13638.38 Median:49273.88 stddev:15803.67 (32.1%) stddev-sans-first:15818.54 07:40:01 INFO - 2015-11-27 07:40:01,198 DEBUG : BROWSER_OUTPUT: Values: 788.5 834.5 851.1 858.1 908.8 12768.9 13176.0 13227.2 13290.8 13318.8 12472.4 12502.9 12610.5 12616.0 12653.2 670.2 675.8 806.0 812.1 826.1 818.6 826.7 828.4 832.3 835.3 858.5 861.8 867.7 869.4 870.8 853.9 854.7 858.8 858.9 859.1 629.7 634.4 636.7 638.5 639.6 12514.7 12610.6 12615.4 12615.6 12650.4 11267.3 11867.3 11990.0 12021.5 12165.6 9668.3 9719.0 9724.8 9742.2 9877.2 3647.2 3658.8 3663.5 3737.9 3825.4 46797.5 46967.8 46994.8 47141.0 48066.0 9388.1 9479.9 9498.2 9509.3 9738.2 18071.0 18300.4 18310.5 18311.6 18499.2 7734.0 7784.5 7829.6 7840.8 7945.2 4232.7 4283.3 4408.3 4414.7 4467.1 3093.0 3114.5 3114.9 3116.1 3127.7 559.8 572.7 575.1 581.7 583.8 646.7 692.1 696.4 699.1 710.1 8058.3 8127.7 8331.7 8406.7 8545.2 540.6 545.0 670.5 695.3 715.6 3848.9 4130.1 4266.6 4344.8 4407.2 55848.4 57000.0 57910.0 58205.4 61147.4 49063.3 49484.5 49613.0 50299.0 51294.0 45996.3 46017.0 46342.8 46511.5 46613.5 8379.0 8412.6 8449.2 8522.3 8559.6 34696.3 35024.8 35394.3 35694.5 36226.5 41628.8 42756.6 43774.3 44206.3 44813.6 10379.7 10576.0 10686.1 10894.8 11393.4 11670.6 11706.1 12144.8 12148.4 12323.7 11416.3 11579.5 11606.5 11923.8 12116.5 10894.3 11386.1 12035.5 12323.5 12390.5 11343.4 11424.4 11542.5 11809.0 11842.9 8788.0 9065.6 9158.6 9307.3 9466.1 8439.6 8822.5 8825.5 9921.5 9954.3 07:40:01 INFO - 2015-11-27 07:40:01,198 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:40:01 INFO - 2015-11-27 07:40:01,198 DEBUG : BROWSER_OUTPUT: 07:40:01 INFO - 2015-11-27 07:40:01,851 INFO : Browser exited with error code: 0 07:40:01 INFO - 2015-11-27 07:40:01,867 INFO : Completed test dromaeo_css (00:18:30) 07:40:01 INFO - 2015-11-27 07:40:01,867 INFO : Starting test kraken 07:40:01 INFO - 2015-11-27 07:40:01,867 DEBUG : operating with platform_type : linux_ 07:40:01 INFO - 2015-11-27 07:40:01,867 INFO : Initialising browser for kraken test... 07:40:01 INFO - 2015-11-27 07:40:01,874 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLEw5HV/profile http://localhost:56529/getInfo.html 07:40:06 INFO - 2015-11-27 07:40:06,574 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:40:06 INFO - 2015-11-27 07:40:06,575 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:40:06 INFO - 2015-11-27 07:40:06,575 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:40:06 INFO - 2015-11-27 07:40:06,575 DEBUG : BROWSER_OUTPUT: __metrics 07:40:07 INFO - 2015-11-27 07:40:07,595 INFO : Browser initialized. 07:40:07 INFO - 2015-11-27 07:40:07,595 INFO : Running cycle 1/1 for kraken test... 07:40:07 INFO - 2015-11-27 07:40:07,596 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLEw5HV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:40:19 INFO - 2015-11-27 07:40:19,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 07:40:19 INFO - 2015-11-27 07:40:19,339 DEBUG : BROWSER_OUTPUT: 07:40:21 INFO - 2015-11-27 07:40:21,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56529/tests/kraken/driver.html?testName=audio-beat-detection) 07:40:22 INFO - 2015-11-27 07:40:22,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 141111296 07:40:22 INFO - 2015-11-27 07:40:22,389 DEBUG : BROWSER_OUTPUT: 07:40:25 INFO - 2015-11-27 07:40:25,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56529/tests/kraken/driver.html?testName=audio-dft) 07:40:25 INFO - 2015-11-27 07:40:25,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 140984320 07:40:25 INFO - 2015-11-27 07:40:25,603 DEBUG : BROWSER_OUTPUT: 07:40:28 INFO - 2015-11-27 07:40:28,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56529/tests/kraken/driver.html?testName=audio-fft) 07:40:29 INFO - 2015-11-27 07:40:29,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 135507968 07:40:29 INFO - 2015-11-27 07:40:29,035 DEBUG : BROWSER_OUTPUT: 07:40:31 INFO - 2015-11-27 07:40:31,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56529/tests/kraken/driver.html?testName=audio-oscillator) 07:40:31 INFO - 2015-11-27 07:40:31,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 135979008 07:40:31 INFO - 2015-11-27 07:40:31,653 DEBUG : BROWSER_OUTPUT: 07:40:33 INFO - 2015-11-27 07:40:33,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56529/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:40:34 INFO - 2015-11-27 07:40:34,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 137125888 07:40:34 INFO - 2015-11-27 07:40:34,460 DEBUG : BROWSER_OUTPUT: 07:40:37 INFO - 2015-11-27 07:40:37,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56529/tests/kraken/driver.html?testName=imaging-darkroom) 07:40:37 INFO - 2015-11-27 07:40:37,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 07:40:37 INFO - 2015-11-27 07:40:37,996 DEBUG : BROWSER_OUTPUT: 07:40:41 INFO - 2015-11-27 07:40:41,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56529/tests/kraken/driver.html?testName=imaging-desaturate) 07:40:41 INFO - 2015-11-27 07:40:41,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 138399744 07:40:41 INFO - 2015-11-27 07:40:41,969 DEBUG : BROWSER_OUTPUT: 07:40:44 INFO - 2015-11-27 07:40:44,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56529/tests/kraken/driver.html?testName=json-parse-financial) 07:40:45 INFO - 2015-11-27 07:40:45,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 07:40:45 INFO - 2015-11-27 07:40:45,400 DEBUG : BROWSER_OUTPUT: 07:40:46 INFO - 2015-11-27 07:40:46,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56529/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:40:47 INFO - 2015-11-27 07:40:47,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 138592256 07:40:47 INFO - 2015-11-27 07:40:47,567 DEBUG : BROWSER_OUTPUT: 07:40:49 INFO - 2015-11-27 07:40:49,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:40:50 INFO - 2015-11-27 07:40:50,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 137928704 07:40:50 INFO - 2015-11-27 07:40:50,024 DEBUG : BROWSER_OUTPUT: 07:40:52 INFO - 2015-11-27 07:40:52,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:40:52 INFO - 2015-11-27 07:40:52,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 139022336 07:40:52 INFO - 2015-11-27 07:40:52,695 DEBUG : BROWSER_OUTPUT: 07:40:55 INFO - 2015-11-27 07:40:55,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:40:55 INFO - 2015-11-27 07:40:55,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 137953280 07:40:55 INFO - 2015-11-27 07:40:55,766 DEBUG : BROWSER_OUTPUT: 07:40:58 INFO - 2015-11-27 07:40:58,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:40:58 INFO - 2015-11-27 07:40:58,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 138776576 07:40:58 INFO - 2015-11-27 07:40:58,927 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56529/tests/kraken/driver.html?testName=ai-astar) 07:41:00 INFO - 2015-11-27 07:41:00,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 07:41:00 INFO - 2015-11-27 07:41:00,830 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;103;112;109;110;121;109;110;109;109 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;127;160;160;136;156;150;129;164;126 07:41:00 INFO - 2015-11-27 07:41:00,831 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;160;163;160;161;162;178;163 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;70;74;73;71;141;72;74;72 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;144;92;92;93;143;92;93;130 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;113;117;110;110;110;110;110;110 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;146;146;146;146;147;146 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;96;95;97;96;96;95 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;60;68;60;60;60;60;63;60 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;71;70;70;70;71;71;73;70;70 07:41:00 INFO - 2015-11-27 07:41:00,832 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;94;84;85;94;84;85;84;85;84 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;145;115;117;124;126;126;136;125;118;118 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;147;153;158;153;137;138;156;147;150 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;68;66;66;66;66;65;68;66 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 07:41:00 INFO - 2015-11-27 07:41:00,833 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:41:00 INFO - 2015-11-27 07:41:00,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1448638860829__endTimestamp 07:41:00 INFO - 2015-11-27 07:41:00,834 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,841 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:41:00 INFO - 2015-11-27 07:41:00,842 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:41:00 INFO - 2015-11-27 07:41:00,842 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,842 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:4.44 (4.0%) stddev-sans-first:4.71 07:41:00 INFO - 2015-11-27 07:41:00,842 DEBUG : BROWSER_OUTPUT: Values: 110.0 103.0 112.0 109.0 110.0 121.0 109.0 110.0 109.0 109.0 07:41:00 INFO - 2015-11-27 07:41:00,843 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,843 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.40 Median:156.00 stddev:15.20 (9.7%) stddev-sans-first:15.72 07:41:00 INFO - 2015-11-27 07:41:00,843 DEBUG : BROWSER_OUTPUT: Values: 156.0 127.0 160.0 160.0 136.0 156.0 150.0 129.0 164.0 126.0 07:41:00 INFO - 2015-11-27 07:41:00,843 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,843 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:5.40 (3.3%) stddev-sans-first:5.67 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 160.0 163.0 160.0 161.0 162.0 178.0 163.0 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:21.78 (30.3%) stddev-sans-first:22.95 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 70.0 74.0 73.0 71.0 141.0 72.0 74.0 72.0 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:92.00 stddev:22.87 (24.9%) stddev-sans-first:23.66 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 144.0 92.0 92.0 93.0 143.0 92.0 93.0 130.0 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:111.00 Median:110.00 stddev:2.31 (2.1%) stddev-sans-first:2.42 07:41:00 INFO - 2015-11-27 07:41:00,844 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 113.0 117.0 110.0 110.0 110.0 110.0 110.0 110.0 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 96.0 95.0 97.0 96.0 96.0 95.0 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.00 stddev:2.72 (4.5%) stddev-sans-first:2.83 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 60.0 68.0 60.0 60.0 60.0 60.0 63.0 60.0 07:41:00 INFO - 2015-11-27 07:41:00,845 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:1.41 (2.0%) stddev-sans-first:1.00 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 70.0 70.0 70.0 71.0 71.0 73.0 70.0 70.0 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:4.16 (4.9%) stddev-sans-first:4.25 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: Values: 83.0 94.0 84.0 85.0 94.0 84.0 85.0 84.0 85.0 84.0 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:125.50 stddev:9.35 (7.4%) stddev-sans-first:6.53 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: Values: 145.0 115.0 117.0 124.0 126.0 126.0 136.0 125.0 118.0 118.0 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:151.50 stddev:7.61 (5.0%) stddev-sans-first:7.38 07:41:00 INFO - 2015-11-27 07:41:00,846 DEBUG : BROWSER_OUTPUT: Values: 139.0 147.0 153.0 158.0 153.0 137.0 138.0 156.0 147.0 150.0 07:41:00 INFO - 2015-11-27 07:41:00,847 DEBUG : BROWSER_OUTPUT: 07:41:00 INFO - 2015-11-27 07:41:00,847 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 07:41:00 INFO - 2015-11-27 07:41:00,847 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 66.0 66.0 66.0 66.0 65.0 68.0 66.0 07:41:00 INFO - 2015-11-27 07:41:00,847 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:41:00 INFO - 2015-11-27 07:41:00,847 DEBUG : BROWSER_OUTPUT: 07:41:01 INFO - 2015-11-27 07:41:01,787 INFO : Browser exited with error code: 0 07:41:01 INFO - 2015-11-27 07:41:01,840 INFO : Completed test kraken (00:00:59) 07:41:01 INFO - 2015-11-27 07:41:01,840 INFO : Starting test v8_7 07:41:01 INFO - 2015-11-27 07:41:01,840 DEBUG : operating with platform_type : linux_ 07:41:01 INFO - 2015-11-27 07:41:01,840 INFO : Initialising browser for v8_7 test... 07:41:01 INFO - 2015-11-27 07:41:01,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqUSIB9/profile http://localhost:56529/getInfo.html 07:41:06 INFO - 2015-11-27 07:41:06,385 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:41:06 INFO - 2015-11-27 07:41:06,386 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:41:06 INFO - 2015-11-27 07:41:06,386 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:41:06 INFO - 2015-11-27 07:41:06,386 DEBUG : BROWSER_OUTPUT: __metrics 07:41:07 INFO - 2015-11-27 07:41:07,359 INFO : Browser initialized. 07:41:07 INFO - 2015-11-27 07:41:07,359 INFO : Running cycle 1/1 for v8_7 test... 07:41:07 INFO - 2015-11-27 07:41:07,360 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqUSIB9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:41:19 INFO - 2015-11-27 07:41:19,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 138579968 07:41:19 INFO - 2015-11-27 07:41:19,084 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56529/tests/v8_7/run.html (next: http://localhost:56529/tests/v8_7/run.html) 07:41:40 INFO - 2015-11-27 07:41:40,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 137740288 07:41:40 INFO - 2015-11-27 07:41:40,791 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,791 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:41:40 INFO - 2015-11-27 07:41:40,791 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |0;Richards;167.16817118020728 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.21757952192735 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |5;Earley;712.2507122507122 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |7;RegExp;25275 07:41:40 INFO - 2015-11-27 07:41:40,793 DEBUG : BROWSER_OUTPUT: |8;Splay;638.5696040868455 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: __startTimestamp1448638900790__endTimestamp 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: Values: 167.2 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.22 Median:188.22 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: Values: 188.2 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,794 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: Values: 279.3 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: Values: 5196.9 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,795 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: Values: 1060.4 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: Values: 712.3 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,796 DEBUG : BROWSER_OUTPUT: Values: 12096.4 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25275.00 Median:25275.00 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: Values: 25275.0 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:638.57 Median:638.57 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: Values: 638.6 07:41:40 INFO - 2015-11-27 07:41:40,797 DEBUG : BROWSER_OUTPUT: 07:41:40 INFO - 2015-11-27 07:41:40,798 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 07:41:40 INFO - 2015-11-27 07:41:40,798 DEBUG : BROWSER_OUTPUT: Values: 4845.4 07:41:40 INFO - 2015-11-27 07:41:40,798 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:41:40 INFO - 2015-11-27 07:41:40,798 DEBUG : BROWSER_OUTPUT: 07:41:41 INFO - 2015-11-27 07:41:41,655 INFO : Browser exited with error code: 0 07:41:41 INFO - 2015-11-27 07:41:41,667 INFO : Completed test v8_7 (00:00:39) 07:41:41 INFO - 2015-11-27 07:41:41,815 INFO : Completed test suite (00:20:10) 07:41:41 INFO - 2015-11-27 07:41:41,815 DEBUG : Working with test: dromaeo_css 07:41:41 INFO - 2015-11-27 07:41:41,815 DEBUG : Generating results file: dromaeo_css 07:41:41 INFO - 2015-11-27 07:41:41,816 DEBUG : Working with test: kraken 07:41:41 INFO - 2015-11-27 07:41:41,816 DEBUG : Generating results file: kraken 07:41:41 INFO - 2015-11-27 07:41:41,816 INFO : javascript benchmark 07:41:41 INFO - 2015-11-27 07:41:41,817 DEBUG : Working with test: v8_7 07:41:41 INFO - 2015-11-27 07:41:41,817 DEBUG : Generating results file: v8_7 07:41:41 INFO - 2015-11-27 07:41:41,817 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:41:41 INFO - 2015-11-27 07:41:41,872 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:41:41 INFO - 2015-11-27 07:41:41,872 DEBUG : process_Request line: dromaeo_css 7069.39 graph.html#tests=[[72,1,43]] 07:41:41 INFO - 2015-11-27 07:41:41,872 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:41:41 INFO - 2015-11-27 07:41:41,910 DEBUG : process_Request line: kraken 1516.70 graph.html#tests=[[232,1,43]] 07:41:41 INFO - 2015-11-27 07:41:41,910 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:41:41 INFO - 2015-11-27 07:41:41,949 DEBUG : process_Request line: v8_7 21286.87 graph.html#tests=[[230,1,43]] 07:41:41 INFO - 2015-11-27 07:41:41,950 INFO : javascript benchmark 07:41:42 INFO - 2015-11-27 07:41:41,954 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3200.487921932491, 3273.4435146025157, 3300.290437555925, 3321.186309354208, 3321.269320749436, 5249.685018898868, 5485.835424937253, 5489.807856725015, 5511.889762204753, 5516.14499752538, 5398.6220964532495, 5404.054290499166, 5470.5623550116, 5561.193626924093, 5581.330240371161, 5013.2480127980825, 5039.974800125994, 5050.444451110375, 5055.064813009587, 5104.285400043997, 5125.282460455521, 5136.409312929005, 5161.741912904358, 5175.611829112813, 5176.990486855065, 4819.542143496362, 4928.802847886116, 4960.0, 5077.2637967494875, 5151.4075881273575, 5061.089003979282, 5062.645614806965, 5065.848024559269, 5081.542661160476, 5124.385073791132, 5040.092783299005, 5042.546170844605, 5051.318072060299, 5063.164577844651, 5082.364704411949, 5219.269302297681, 5237.292965449692, 5299.258103865462, 5309.893802123975, 5327.547158491533, 5981.013132833077, 6006.819795406145, 6012.518998480111, 6014.578979471439, 6018.759249630009, 5814.0, 5988.9401105989255, 5994.400559944014, 6005.309389420186, 6013.75944962201, 5486.341639003305, 5548.306461692288, 5553.361363443175, 5564.27664403629, 5610.691411972381, 6115.357887421846, 6118.449339559461, 6124.989376752786, 6126.417990290915, 6129.0, 5753.539716822645, 5879.617824841457, 5895.145203945404, 5908.852278692981, 5925.881482370414, 5814.244148260699, 5894.8821023579285, 5906.0, 5910.468057874812, 5914.4381283777975, 5876.823695289148, 5913.733881975236, 5922.792702255487, 5924.229850119457, 5933.970330148321, 5791.131330300489, 5873.823785286449, 5946.316173640001, 5954.0, 5955.672438015864, 4590.0, 4604.286335617984, 4620.3993480847275, 4623.075384923029, 4627.745473998963, 4088.2845502037026, 4098.918021639551, 4121.793910304473, 4129.814158362881, 4171.0823618803815, 5522.088855338824, 5597.412271711493, 5610.943890561042, 5614.326280846324, 5741.909037282986, 5955.731992060368, 5958.225430693982, 5964.135200395918, 5996.5202783777195, 6033.909491357633, 5712.11462223356, 5722.484976352148, 5725.8568535786935, 5731.627444216113, 5734.942650573441, 4998.350214472095, 5101.005303965691, 5118.948810511847, 5119.180931051014, 5126.307948426989, 6179.0, 6209.720562574695, 6219.689015549205, 6246.281677607133, 6258.968705156445, 6034.969825150846, 6044.123602077762, 6049.909251361321, 6052.273727152769, 6064.4541991221, 5942.435468630473, 6038.5169186465855, 6123.958926982335, 6158.507319414526, 6233.314335423009, 5859.326177489644, 5866.853328666817, 5879.882402352015, 5887.264091988502, 5923.5853490256995, 5964.403559644001, 6000.069989151689, 6000.519958403404, 6006.609570377911, 6027.758889644365, 5546.112621980464, 5694.829155125353, 5803.47768700819, 5887.735051922759, 5941.1385349125, 5792.768289268382, 5800.332961709458, 5820.796272130455, 5825.883482330414, 5833.795817146549, 5520.66875987442, 5710.2291190690385, 5734.168545560787, 5735.311762588516, 5738.68437235956, 5661.0659241226385, 5751.654900705971, 5762.596618236851, 5788.334341550607, 5932.0, 5743.3395159557185, 5757.740901659352, 5758.3090029196765, 5759.712014399347, 5766.682832444256], "unit": "ms", "name": "dojo.html", "value": 5482.774080437447}, {"lowerIsBetter": false, "replicates": [552.6683989606237, 571.9199312096309, 600.8918394688956, 601.6931365003848, 602.7588964414234, 38754.61245387545, 39436.40845387321, 39620.0, 39793.0, 39951.200975980464, 42242.78878605603, 43138.0, 43265.35101973473, 43290.0, 43293.78353108238, 8621.698240561582, 8728.607212675413, 8786.341024423162, 8811.515366654832, 8816.0, 8585.270252028586, 8687.609057592423, 8688.391812573122, 8739.825203495959, 8753.255973242281, 8694.304455643565, 8735.21383075523, 8765.211130998208, 8769.56152192391, 8775.297976161892, 8642.524661143634, 8728.345374096936, 8744.825103497895, 8824.470531768082, 8840.8673869892, 8531.829363412759, 8660.090690477535, 8695.478271303742, 8695.652173913037, 8696.565171741451, 38859.41710874339, 39097.60902390968, 39121.21757564833, 39331.0, 39346.40980385296, 3440.9311813763834, 3453.0849324928663, 3536.734744894143, 3538.663826936437, 4011.5988401159943, 29289.316552683922, 30000.54999175014, 30010.549841752392, 30054.54918176229, 30389.69610303913, 3747.906302342436, 3839.520059992501, 3867.323218436762, 3934.311495488278, 3940.093778430948, 269628.0, 270043.0, 270063.0, 270168.64915675495, 270806.0, 50523.74738126286, 51854.74072629613, 56051.71974140103, 56435.0, 56500.71749641225, 66984.0, 68217.0, 68281.0, 68506.65746671334, 68606.65696671484, 15252.23738813077, 15390.692186156215, 15394.461193858162, 15395.307211175525, 15615.657651352389, 12149.696257593454, 12260.203086799329, 12301.876981230253, 12405.503779848885, 12428.62714118578, 18976.43070707881, 19148.0, 19270.132844022053, 19343.4196974091, 19470.415887523395, 7837.294643482114, 8073.878891816627, 8149.877751833608, 8172.75481735537, 8186.631601577943, 939.8026414452904, 1020.5917632946732, 1035.1873779083535, 1049.5434485998614, 1080.773037662084, 28869.0, 29287.414251714847, 29301.26746831346, 29335.413291734472, 29672.703272966995, 1033.850091736709, 1052.484282701486, 1089.2756317049073, 1165.6269993602136, 1165.6561314412268, 15208.163551004802, 15208.771868421982, 15334.0, 15541.922290388477, 15546.76679849803, 331033.0, 334598.0, 336818.0, 336918.0, 338272.0, 50531.0, 50663.0, 50732.98534029299, 51259.23111153336, 51272.48727512677, 1341.7115320206203, 1346.1557665997645, 1363.277462944641, 1368.1654190943516, 1373.9763875912508, 27687.723122768515, 28743.281417964718, 28910.277243069093, 29033.0, 29115.0, 48818.26772598485, 49506.50493495163, 50080.749596251786, 50140.0, 50174.247386289964, 219831.0, 221028.0, 221146.0, 222531.0, 222561.0, 29475.263118422212, 31876.681233188297, 32158.839205803823, 32375.0, 32453.837730811196, 39223.80388098041, 42301.36547951845, 42883.7855810719, 43543.564564353954, 43789.56210437855, 35275.82362088173, 35429.29141417209, 35592.82203588966, 35941.0, 36080.819595901856, 35098.29803403969, 36125.638743612224, 36132.63867361293, 36153.0961725959, 36346.273074537836, 32821.343573128885, 33410.832945835115, 33695.15762105967, 33817.49273760847, 33893.83053084719, 31155.53266700956, 32575.185620358734, 33004.66995330016, 33771.3245735079, 33812.830935845166, 24273.878630606734, 25376.74623253744, 25404.0, 25555.849986751015, 25864.870675647253], "unit": "ms", "name": "ext.html", "value": 18522.2057789967}, {"lowerIsBetter": false, "replicates": [355.6496850602158, 356.47064109796963, 357.2444280347067, 358.28700885238374, 360.2416912399398, 16410.097444640556, 16747.24637391319, 17453.38913138042, 17586.912065439654, 18267.90866045668, 11033.503492342843, 11085.0, 11232.438378081084, 11263.718407039807, 11308.264962777434, 4869.659123861331, 4895.388076490439, 5003.799848006075, 5018.924716129242, 5054.039732450822, 4949.307097006422, 4964.702117872921, 5002.624803139761, 5002.974985125069, 5019.447860735316, 3747.9625203747887, 3850.826712797917, 5046.318746969149, 5051.090803655341, 5379.300690910196, 5448.782048718046, 5500.1749737539285, 5518.530924871371, 5519.9448005519835, 5527.778888844441, 5174.922376164361, 5284.471552844723, 5322.654027488201, 5334.386545547273, 5339.546138578186, 20132.49668758278, 20435.284765033302, 20776.792232077787, 20999.055042523123, 21053.47366315839, 2123.6071326804436, 2154.138344662132, 2245.584566855137, 2275.8748268845206, 2311.9537609247723, 9704.175145112675, 9722.562484688206, 9830.557624906896, 10123.595056197742, 13534.932325338408, 1836.9540761481069, 1855.1651756709534, 1865.8880467172014, 1882.4352694191825, 1910.2263583248669, 59940.70029649824, 60100.56755949443, 61539.07691384633, 61717.691411542655, 62591.99999999954, 10078.193744500422, 10145.391276523433, 10213.744656383502, 10231.0, 10232.283740138268, 13398.531051413154, 13436.395362208725, 13457.25985070811, 13466.93266533661, 13475.595732128051, 7745.728899488491, 7760.417968652374, 7865.370770338359, 7908.446408751447, 7911.367090632735, 7320.633968301564, 7462.104547454232, 7652.73215437457, 7687.769366919001, 7769.72805951789, 4445.599896009375, 4461.107778444324, 4489.169503641837, 4492.3710680504755, 4519.05099929012, 1879.5676994291389, 1906.36136894142, 1920.8847469151895, 1927.759030121235, 1942.893140877237, 422.17675532711337, 425.7488082031616, 427.89516568440933, 891.2023738753779, 1011.6004178349658, 10717.0, 11248.26886252391, 11320.150988675883, 16395.836041639668, 17103.48689539291, 944.6127087893931, 978.5449765858909, 990.7275499237767, 1003.1623594298842, 1062.3944351719447, 9648.890377606525, 10040.748981275381, 10056.74858128538, 10068.0, 10089.142422893989, 414979.0, 416689.0, 420987.0, 424983.0, 546792.0, 73028.0, 76579.7772544004, 82645.58677206696, 85513.0, 85948.57025714831, 1119.7032786311634, 1144.250515912079, 1148.4143087025677, 1149.9195056346143, 1156.0866915137115, 15672.686546269239, 15684.76472852931, 15932.283047262668, 15949.534130443495, 16335.754963675792, 34711.4793278096, 35599.28801424009, 35646.28707425785, 35696.64303356933, 36983.815080924425, 45786.0, 46267.76866115648, 46280.0, 47683.52316476929, 47746.28380574225, 9342.205912497513, 9429.198518125762, 9594.808103838024, 9655.806883862424, 9711.66009189675, 11651.88348116508, 11830.58592949277, 11832.70418239551, 11837.64487065355, 12523.0, 14669.779953300922, 14676.04605700626, 14819.481318153812, 14869.851301486846, 14878.553643390716, 14169.149851008973, 14192.858071419154, 14375.640608984859, 14467.710645787236, 14828.40686372533, 14289.785653215418, 14369.0, 14719.337629806898, 15078.773818392952, 15165.0, 9388.718338449584, 9460.905390946278, 9576.329656923948, 9585.712428627152, 9624.470654114091, 10202.948985255027, 13216.207027578375, 13962.930185349009, 14278.500252491112, 14952.850471495582], "unit": "ms", "name": "jquery.html", "value": 8563.58915184498}, {"lowerIsBetter": false, "replicates": [1518.8633023027926, 1681.688887555802, 1752.1064257228809, 1778.4397914656881, 1784.9464516064515, 7644.694212231504, 7707.92292077079, 7931.6034198290145, 7964.800879978004, 7984.640691168889, 7931.960340198291, 7938.880916786238, 7946.562939038351, 7954.403419743513, 8040.517568945853, 2244.9775502244975, 2268.0, 2281.0533628544135, 2283.931482055541, 2289.8053665438456, 2313.826463015272, 2328.1269523928527, 2377.286813955815, 2379.690640216778, 2384.1893756122913, 2277.6925115109498, 2305.700258966332, 2309.7343805462333, 2326.5463234669246, 2334.9766502335015, 2294.621387471065, 2313.178821518362, 2356.4108972756812, 2368.7394386617457, 2369.3247424484025, 2338.497223097025, 2365.042157926043, 2368.881555922197, 2370.099362242354, 2370.6207006878817, 7812.179721129313, 7859.764207073797, 7886.329661978739, 7914.0, 7948.125706172316, 4773.3078703588135, 4832.081904438145, 4875.317455556225, 4884.267359896008, 4898.044881248158, 3040.8783648654025, 3086.753059755214, 3177.3009937813645, 3177.8728850845937, 3228.9354212915846, 1049.8530205771199, 1054.7679510507676, 1065.2223876570147, 1074.6346242277584, 1084.2193620593239, 10614.257002009863, 10739.355638661706, 10744.033037026706, 10763.19276054299, 10794.136469082454, 4267.317229243368, 4290.656747460196, 4335.674824388184, 4374.5625437456, 4382.276924307517, 8639.6976105836, 8641.654333826576, 8664.91335086641, 8671.046184919654, 8688.739337819876, 4816.686915350491, 4822.842517795703, 4827.782749776268, 4832.347633069561, 4880.731559764247, 4432.601065904019, 4475.552444755564, 4475.888102797391, 4480.887977800581, 4482.932756008662, 3513.5432393789156, 3564.8574057037945, 3566.589842168132, 3586.372384832644, 3590.3537363274863, 1116.3580940958818, 1117.1509652664033, 1134.2740645986576, 1159.8492196014465, 1198.5385626533673, 1107.6289443036674, 1111.360967443723, 1147.1625713229223, 1300.206873806977, 1381.5855243426931, 7116.893246601305, 7144.607046612382, 7165.032720582759, 7517.511361761468, 7652.196519365498, 1149.8332741752567, 1156.1848896527927, 1178.192937837584, 1197.3773637708516, 1207.945642446092, 5817.796377126865, 5876.265466816648, 5887.8233652990475, 5888.793892213752, 5942.049272116527, 9188.49463279526, 9381.390209636353, 9400.717978460658, 9477.383970041925, 9499.38254013487, 9244.352895297265, 9271.582778774971, 9281.72154835356, 9341.579628916716, 9393.718188454357, 7196.352328290479, 7309.232530584212, 7311.597862117528, 7323.450741194431, 7371.0, 7238.782836514913, 7270.272972702687, 7301.926980730337, 7302.415806735555, 7320.267973202637, 8158.714444994397, 8245.505269683597, 8249.628766705633, 8306.920100387153, 8353.373496987871, 8349.332053435832, 8417.326613870753, 8427.536485493356, 8453.78865528342, 8551.315894728532, 6938.618375989369, 6973.093497845451, 7010.68451919675, 7028.50800443964, 7063.576185428685, 7487.887681684888, 7557.470977031555, 7567.508111972704, 7595.5442673439775, 7620.8475830484185, 6287.937120628735, 7200.351968322876, 7224.13310402755, 7253.927460725326, 7256.310650488195, 6161.465677457315, 6717.529772915849, 7047.260037695968, 7164.856702866018, 7188.245234250328, 6904.171499420102, 6947.826304342432, 7148.678309475982, 7187.892181617175, 7188.820279493055, 6667.133272674521, 6673.666316684049, 6697.09589205451, 6700.6984685688285, 6715.026321183499, 6675.4325882300545, 6700.564463309869, 6720.428763554957, 6733.966330168318, 6755.831104222434], "unit": "ms", "name": "mootools.html", "value": 4562.310788722672}, {"lowerIsBetter": false, "replicates": [317.82996097088056, 328.3613371991476, 336.9022983334833, 347.39379782279923, 348.9214926641506, 6107.328193898678, 6178.536609754269, 6191.442770150686, 6269.78055768047, 6288.371162883715, 5996.700164991744, 6120.602160859541, 6170.784022559212, 6198.256209254884, 6204.720787564559, 4774.641901857374, 4784.880377990543, 4791.329213910055, 4804.5916097131785, 4808.687435316702, 4787.114383839001, 4788.736619485944, 4792.376990991166, 4795.448523419799, 4800.639952003597, 4627.07458508298, 4682.0, 4694.647901407391, 4699.177643912319, 4769.618430525549, 4760.880977975544, 4761.023990082025, 4761.833335833247, 4767.809287628491, 4777.0684716479955, 4171.520275168364, 4192.790360481994, 4194.056337324108, 4196.748195108304, 4217.662586993064, 5893.440123188333, 5917.881642367129, 5925.111233315038, 5930.495907847838, 5933.139694744281, 5449.727513624303, 5565.749541270652, 5580.246666699984, 5584.0507113790345, 5596.552275817925, 6581.3747693969, 6594.208694956588, 6607.966960165217, 6623.3376662333385, 6627.237867645186, 4648.767561621939, 4650.976785107305, 4653.162430762462, 4653.488116307203, 4663.626909847238, 6692.364225398579, 6805.890174046012, 6841.281665425158, 6857.485688573377, 6862.656867156622, 4770.713757174581, 4770.833020844254, 4772.188727916263, 4780.593649539828, 4780.784864681098, 4827.975860120677, 4838.395200599925, 4843.0, 4846.273059041101, 4859.441164266154, 5520.723963801875, 5546.722663866791, 5573.470520300565, 5573.5819813514145, 5574.944250557523, 6547.9017814732815, 6659.766908158192, 6671.132752742113, 6671.899921501182, 6679.699413526403, 1608.388812251337, 1662.642531855657, 1670.7911511061118, 1674.2465890349392, 1678.2196278730205, 1062.6918193723734, 1076.8707755069443, 1077.256692881909, 1084.7776205877776, 1099.5766629847567, 6410.711517981702, 6422.421982021547, 6426.550141490145, 6432.581882177644, 6446.0, 6770.356816102462, 6779.796606101825, 6788.287229840796, 6790.524663273523, 6800.965995169992, 6365.777197798055, 6387.233531976192, 6401.807945761635, 6409.487241020707, 6409.775657851953, 3750.5311836020496, 3757.812109394519, 3772.13240954582, 3784.7161462890394, 3789.317922773927, 7178.533395329391, 7181.964090179516, 7188.5327453715345, 7194.136703595497, 7234.131904171533, 6909.343612356818, 7070.0, 7072.646367681596, 7076.504644674927, 7138.607376594337, 7122.893156602655, 7135.857282854314, 7171.677274522659, 7194.964025179841, 7195.244499327495, 6898.344657257552, 6904.792856214322, 6917.858553338643, 6919.135108111486, 6934.618595977068, 6726.596404215763, 6815.863682726219, 6828.863422731617, 6842.521023528305, 6850.828729281808, 7173.677184526813, 7194.712211511481, 7198.0, 7203.2076471589135, 7215.366391267255, 4619.630429565559, 4649.139909116824, 4660.883477913079, 4662.370579971661, 4681.859544213679, 6814.8637027260165, 6862.588244705334, 6897.965510172417, 6907.34380233877, 6933.237343892067, 6721.613827091508, 6724.831879202863, 6726.428253598303, 6728.831779205559, 6731.865362692621, 6693.431058359899, 6694.665266736546, 6706.262311145868, 6717.16035495563, 6717.16035495563, 6483.773067942788, 6514.771982980573, 6581.111549940697, 6597.6041437511985, 6598.769043083469, 6619.470442364695, 6673.366030227121, 6695.866082678416, 6711.395974362331, 6717.059611654275, 6514.73941042353, 6544.051112588743, 6546.312637173029, 6560.507961902781, 6562.048502966947], "unit": "ms", "name": "prototype.html", "value": 5010.376460066909}, {"lowerIsBetter": false, "replicates": [788.4993029426314, 834.4534330013843, 851.0765819086291, 858.1418581418582, 908.8409528332543, 12768.936155319221, 13176.0, 13227.20636761795, 13290.800637990438, 13318.800217996737, 12472.438740256688, 12502.874741273283, 12610.495580176805, 12616.0, 12653.240805551673, 670.1689904518387, 675.8445557521773, 806.0488623424357, 812.1026265976085, 826.1160558202725, 818.5907046476761, 826.7313123234943, 828.4490813608943, 832.3341326938455, 835.2524490580927, 858.459170722444, 861.7802460372596, 867.6616119713317, 869.42183448007, 870.7561882672861, 853.9231469167805, 854.692310768123, 858.8239410920778, 858.8711693246032, 859.1451505751786, 629.7386584567399, 634.4416913116428, 636.7389370358131, 638.4955884850962, 639.5555089212999, 12514.687132821753, 12610.558630447982, 12615.369231538387, 12615.621531354074, 12650.367481625883, 11267.26762760418, 11867.347295898722, 11990.0, 12021.459034343476, 12165.635030948997, 9668.274879384004, 9718.951405242928, 9724.82552342971, 9742.220622350194, 9877.160441362494, 3647.215848592539, 3658.835352409148, 3663.4687970244167, 3737.8691745788765, 3825.407061905409, 46797.53202468, 46967.76516117432, 46994.76502617465, 47141.0, 48066.0, 9388.061193880558, 9479.857802132974, 9498.240140788721, 9509.286803489627, 9738.220942324739, 18071.0, 18300.359487418144, 18310.52807870947, 18311.63376732458, 18499.167537460846, 7733.961330193313, 7784.455088143775, 7829.608519573999, 7840.803979900548, 7945.165757595485, 4232.661387089025, 4283.271843786564, 4408.272635015187, 4414.735115893057, 4467.12890986261, 3093.0256969054676, 3114.5483904833673, 3114.8754049838208, 3116.111908106179, 3127.7341425978593, 559.7928766356392, 572.7279542217497, 575.0999685492192, 581.6858896196006, 583.7869177750091, 646.7485415720596, 692.0864458914185, 696.3906581740977, 699.1470406104544, 710.1052673631261, 8058.348038652062, 8127.715529956541, 8331.66673333072, 8406.663733450716, 8545.188207120314, 540.6485784240197, 545.0434487474457, 670.53062856001, 695.3220609905403, 715.595688436032, 3848.8652897148463, 4130.132672138884, 4266.5946735060115, 4344.82620695175, 4407.246318981674, 55848.44151558514, 57000.0, 57910.0, 58205.417945820845, 61147.38852611506, 49063.26405103926, 49484.50515494799, 49613.0, 50299.0, 51294.0, 45996.3100553492, 46017.0, 46342.76828615835, 46511.53488465072, 46613.533864660916, 8379.0, 8412.579371031547, 8449.197326253996, 8522.27560657351, 8559.614817333111, 34696.306073878884, 35024.824875875456, 35394.29211415809, 35694.4645830318, 36226.456603150444, 41628.79185604052, 42756.57243427526, 43774.34338484989, 44206.33690494709, 44813.551864482244, 10379.688609341732, 10576.0, 10686.145108391154, 10894.836577451502, 11393.373364465035, 11670.591529296435, 11706.122040847142, 12144.846239607223, 12148.39258037077, 12323.69190770238, 11416.257943233662, 11579.536818527165, 11606.535738570701, 11923.821142682693, 12116.454759535665, 10894.346339219672, 11386.089112871116, 12035.458404371999, 12323.50705971787, 12390.504379824706, 11343.376114313793, 11424.428778560872, 11542.538298468304, 11809.0, 11842.881571184522, 8787.956060219658, 9065.592048357708, 9158.58786354629, 9307.348485605942, 9466.100720431548, 8439.578021099043, 8822.470651760916, 8825.470471771714, 9921.45432001218, 9954.303198776017], "unit": "ms", "name": "yui.html", "value": 6278.42847057776}], "name": "dromaeo_css", "value": 7069.387869296759}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 103.0, 112.0, 109.0, 110.0, 121.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 160.0, 160.0, 136.0, 156.0, 150.0, 129.0, 164.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 160.0, 163.0, 160.0, 161.0, 162.0, 178.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 70.0, 74.0, 73.0, 71.0, 141.0, 72.0, 74.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 144.0, 92.0, 92.0, 93.0, 143.0, 92.0, 93.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 113.0, 117.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 111.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 64.0, 60.0, 68.0, 60.0, 60.0, 60.0, 60.0, 63.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 70.0, 70.0, 70.0, 71.0, 71.0, 73.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.0}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 84.0, 85.0, 94.0, 84.0, 85.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [145.0, 115.0, 117.0, 124.0, 126.0, 126.0, 136.0, 125.0, 118.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [139.0, 147.0, 153.0, 158.0, 153.0, 137.0, 138.0, 156.0, 147.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 66.0, 66.0, 66.0, 66.0, 65.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1516.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [188.21757952192735], "unit": "score", "name": "DeltaBlue", "value": 351.2849339999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [712.2507122507122], "unit": "score", "name": "Earley", "value": 935.7140519999998}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25275.0], "unit": "score", "name": "RegExp", "value": 36.042927794263136}, {"lowerIsBetter": false, "replicates": [638.5696040868455], "unit": "score", "name": "Splay", "value": 127.61490600000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21286.8727841318}]} 07:41:42 INFO - RETURN: dromaeo_css: 7069.39 07:41:42 INFO - RETURN: kraken: 1516.70 07:41:42 INFO - RETURN: v8_7: 21286.87 07:41:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21286.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1516.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7069.39"}}} 07:41:42 INFO - Return code: 0 07:41:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:41:42 INFO - # TBPL SUCCESS # 07:41:42 INFO - Running post-action listener: _resource_record_post_action 07:41:42 INFO - Running post-run listener: _resource_record_post_run 07:41:43 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524308480; Read time: 4; Write time: 527908 07:41:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 247406592; Read time: 0; Write time: 377732 07:41:43 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276901888; Read time: 4; Write time: 150176 07:41:43 INFO - Running post-run listener: _upload_blobber_files 07:41:43 INFO - Blob upload gear active. 07:41:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:41:43 INFO - Copying logs to upload dir... 07:41:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.316826 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-27 07:41:42.968610) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:41:42.975499) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009971 build_url: 'https://queue.taskcluster.net/v1/task/eYp_FfqXRH2-qKozVwuCHg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:41:43.030076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:41:43.030475) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448637095.817904-77358367 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004633 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:41:43.079785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 07:41:43.082227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 07:41:43.082586) ========= ========= Total master_lag: 0.28 =========