builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1447347695.43 results: success (0) buildid: 20151112073424 builduid: 1cbc7609280941cab8c2b332b94273b3 revision: 62968e4afd68406ee95f0313a51df2cc0964dae8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.433099) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.433603) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.433963) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006653 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.459087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.459620) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.495560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.495859) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.544729) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.545058) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.545433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.545738) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 09:01:35-- 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% 213M=0s 2015-11-12 09:01:35 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.675455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.675818) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020931 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.726011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:35.726368) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 62968e4afd68406ee95f0313a51df2cc0964dae8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 62968e4afd68406ee95f0313a51df2cc0964dae8 --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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 09:01:35,970 truncating revision to first 12 chars 2015-11-12 09:01:35,970 Setting DEBUG logging. 2015-11-12 09:01:35,970 attempt 1/10 2015-11-12 09:01:35,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/62968e4afd68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 09:01:36,220 unpacking tar archive at: mozilla-inbound-62968e4afd68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534732 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:36.274371) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:36.274690) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:36.287241) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:36.287735) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:36.288447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-12 09:01:36.288842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:36 INFO - MultiFileLogger online at 20151112 09:01:36 in /builds/slave/test-pgo 09:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:01:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:01:36 INFO - {'append_to_log': False, 09:01:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:01:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:01:36 INFO - 'branch': 'Mozilla-Inbound', 09:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:36 INFO - 'config_files': ('talos/linux_config.py',), 09:01:36 INFO - 'default_actions': ('clobber', 09:01:36 INFO - 'read-buildbot-config', 09:01:36 INFO - 'download-and-extract', 09:01:36 INFO - 'populate-webroot', 09:01:36 INFO - 'create-virtualenv', 09:01:36 INFO - 'install', 09:01:36 INFO - 'run-tests'), 09:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:36 INFO - 'download_minidump_stackwalk': True, 09:01:36 INFO - 'download_symbols': 'ondemand', 09:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:36 INFO - 'installer_path': 'installer.exe', 09:01:36 INFO - 'log_level': 'info', 09:01:36 INFO - 'log_name': 'talos', 09:01:36 INFO - 'log_to_console': True, 09:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:36 INFO - 'opt_config_files': (), 09:01:36 INFO - 'pip_index': False, 09:01:36 INFO - 'sps_profile': False, 09:01:36 INFO - 'sps_profile_interval': 0, 09:01:36 INFO - 'suite': 'dromaeojs-e10s', 09:01:36 INFO - 'system_bits': '64', 09:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:36 INFO - 'title': 'talos-linux64-ix-027', 09:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:36 INFO - 'use_talos_json': True, 09:01:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:36 INFO - 'work_dir': 'build'} 09:01:36 INFO - ##### 09:01:36 INFO - ##### Running clobber step. 09:01:36 INFO - ##### 09:01:36 INFO - Running pre-action listener: _resource_record_pre_action 09:01:36 INFO - Running main action method: clobber 09:01:36 INFO - rmtree: /builds/slave/test-pgo/build 09:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:01:37 INFO - Running post-action listener: _resource_record_post_action 09:01:37 INFO - ##### 09:01:37 INFO - ##### Running read-buildbot-config step. 09:01:37 INFO - ##### 09:01:37 INFO - Running pre-action listener: _resource_record_pre_action 09:01:37 INFO - Running main action method: read_buildbot_config 09:01:37 INFO - Using buildbot properties: 09:01:37 INFO - { 09:01:37 INFO - "properties": { 09:01:37 INFO - "buildnumber": 417, 09:01:37 INFO - "product": "firefox", 09:01:37 INFO - "script_repo_revision": "production", 09:01:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:01:37 INFO - "repository": "", 09:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:01:37 INFO - "buildid": "20151112073424", 09:01:37 INFO - "slavename": "talos-linux64-ix-027", 09:01:37 INFO - "pgo_build": "True", 09:01:37 INFO - "basedir": "/builds/slave/test-pgo", 09:01:37 INFO - "project": "", 09:01:37 INFO - "platform": "ubuntu64_hw", 09:01:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:01:37 INFO - "slavebuilddir": "test", 09:01:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:01:37 INFO - "branch": "mozilla-inbound", 09:01:37 INFO - "repo_path": "integration/mozilla-inbound", 09:01:37 INFO - "stage_platform": "linux64-pgo", 09:01:37 INFO - "builduid": "1cbc7609280941cab8c2b332b94273b3", 09:01:37 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:37 INFO - }, 09:01:37 INFO - "sourcestamp": { 09:01:37 INFO - "repository": "", 09:01:37 INFO - "hasPatch": false, 09:01:37 INFO - "project": "", 09:01:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:01:37 INFO - "changes": [ 09:01:37 INFO - { 09:01:37 INFO - "category": null, 09:01:37 INFO - "files": [ 09:01:37 INFO - { 09:01:37 INFO - "url": null, 09:01:37 INFO - "name": "https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:01:37 INFO - } 09:01:37 INFO - ], 09:01:37 INFO - "repository": "", 09:01:37 INFO - "rev": "62968e4afd68406ee95f0313a51df2cc0964dae8", 09:01:37 INFO - "who": "sendchange", 09:01:37 INFO - "when": 1447347651, 09:01:37 INFO - "number": 6654001, 09:01:37 INFO - "comments": "", 09:01:37 INFO - "project": "", 09:01:37 INFO - "at": "Thu 12 Nov 2015 09:00:51", 09:01:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:01:37 INFO - "revlink": "", 09:01:37 INFO - "properties": [ 09:01:37 INFO - [ 09:01:37 INFO - "buildid", 09:01:37 INFO - "20151112073424", 09:01:37 INFO - "Change" 09:01:37 INFO - ], 09:01:37 INFO - [ 09:01:37 INFO - "builduid", 09:01:37 INFO - "1cbc7609280941cab8c2b332b94273b3", 09:01:37 INFO - "Change" 09:01:37 INFO - ], 09:01:37 INFO - [ 09:01:37 INFO - "pgo_build", 09:01:37 INFO - "True", 09:01:37 INFO - "Change" 09:01:37 INFO - ] 09:01:37 INFO - ], 09:01:37 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:37 INFO - } 09:01:37 INFO - ], 09:01:37 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:37 INFO - } 09:01:37 INFO - } 09:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:01:37 INFO - Running post-action listener: _resource_record_post_action 09:01:37 INFO - ##### 09:01:37 INFO - ##### Running download-and-extract step. 09:01:37 INFO - ##### 09:01:37 INFO - Running pre-action listener: _resource_record_pre_action 09:01:37 INFO - Running main action method: download_and_extract 09:01:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:37 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json 09:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json 09:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:01:38 INFO - Downloaded 1302 bytes. 09:01:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:01:38 INFO - Using the following test package requirements: 09:01:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'jsshell-linux-x86_64.zip'], 09:01:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:38 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:45 INFO - Downloaded 22444207 bytes. 09:01:45 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 09:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:45 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 09:01:47 INFO - Return code: 0 09:01:47 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 09:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:47 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:47 INFO - Downloaded 22444207 bytes. 09:01: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 09:01:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01: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 09:01:49 INFO - Return code: 0 09:01: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')]} 09:01:49 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:51 INFO - Downloaded 11131693 bytes. 09:01:51 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 09:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:51 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 09:01:51 INFO - Return code: 0 09:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:51 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:52 INFO - Downloaded 57171457 bytes. 09:01:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:52 INFO - mkdir: /builds/slave/test-pgo/properties 09:01:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:01:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:01:52 INFO - Contents: 09:01:52 INFO - build_url:https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:52 INFO - Running post-action listener: _resource_record_post_action 09:01:52 INFO - Running post-action listener: set_extra_try_arguments 09:01:52 INFO - ##### 09:01:52 INFO - ##### Running populate-webroot step. 09:01:52 INFO - ##### 09:01:52 INFO - Running pre-action listener: _resource_record_pre_action 09:01:52 INFO - Running main action method: populate_webroot 09:01:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:01:52 INFO - '../fennec_ids.txt'], 09:01:52 INFO - 'tests': ['tcheck2']}, 09:01:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:52 INFO - '--tppagecycles', 09:01:52 INFO - '7'], 09:01:52 INFO - 'tests': ['tsvgm']}}, 09:01:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:01:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'tests': ['damp', 'tps']}, 09:01:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['damp', 'tps']}, 09:01:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:01:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:52 INFO - 'other': {'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'other_l64': {'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'other_nol64': {'tests': ['a11yr', 09:01:52 INFO - 'ts_paint', 09:01:52 INFO - 'tpaint', 09:01:52 INFO - 'sessionrestore', 09:01:52 INFO - 'sessionrestore_no_auto_restore']}, 09:01:52 INFO - 'svgr': {'tests': ['tsvgx', 09:01:52 INFO - 'tsvgr_opacity', 09:01:52 INFO - 'tart', 09:01:52 INFO - 'tscrollx', 09:01:52 INFO - 'cart']}, 09:01:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['tsvgx', 09:01:52 INFO - 'tsvgr_opacity', 09:01:52 INFO - 'tart', 09:01:52 INFO - 'tscrollx', 09:01:52 INFO - 'cart']}, 09:01:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'tests': ['tp5o']}, 09:01:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'talos_options': ['--e10s'], 09:01:52 INFO - 'tests': ['tp5o']}, 09:01:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'talos_options': ['--xperf_path', 09:01:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:52 INFO - 'tests': ['tp5n']}, 09:01:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:52 INFO - 'talos_options': ['--e10s', 09:01:52 INFO - '--xperf_path', 09:01:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:52 INFO - 'tests': ['tp5n']}}, 09:01:52 INFO - 'talos.zip': {'path': '', 09:01:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:52 INFO - Running post-action listener: _resource_record_post_action 09:01:52 INFO - ##### 09:01:52 INFO - ##### Running create-virtualenv step. 09:01:52 INFO - ##### 09:01:52 INFO - Running pre-action listener: _resource_record_pre_action 09:01:52 INFO - Running main action method: create_virtualenv 09:01:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:01: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 09:01:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:01:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:52 INFO - Using real prefix '/usr' 09:01:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:01:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:55 INFO - Installing pip.................done. 09:01:55 INFO - Return code: 0 09:01:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:01: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')]} 09:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:01: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:01: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 pip>=1.5 09:01:55 INFO - Using env: {'DISPLAY': ':0', 09:01:55 INFO - 'HOME': '/home/cltbld', 09:01:55 INFO - 'LANG': 'en_US.UTF-8', 09:01:55 INFO - 'LANGUAGE': 'en_US:en', 09:01:55 INFO - 'LOGNAME': 'cltbld', 09:01:55 INFO - 'MAIL': '/var/mail/cltbld', 09:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:55 INFO - 'MOZ_NO_REMOTE': '1', 09:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:55 INFO - 'NO_EM_RESTART': '1', 09:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:01:55 INFO - 'SHELL': '/bin/bash', 09:01:55 INFO - 'SHLVL': '1', 09:01:55 INFO - 'TERM': 'linux', 09:01:55 INFO - 'TMOUT': '86400', 09:01:55 INFO - 'USER': 'cltbld', 09:01:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:55 INFO - '_': '/tools/buildbot/bin/python'} 09:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01: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 09:01:55 INFO - Cleaning up... 09:01:55 INFO - Return code: 0 09:01:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:01: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')]} 09:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:01: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 09:01: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 09:01:55 INFO - Using env: {'DISPLAY': ':0', 09:01:55 INFO - 'HOME': '/home/cltbld', 09:01:55 INFO - 'LANG': 'en_US.UTF-8', 09:01:55 INFO - 'LANGUAGE': 'en_US:en', 09:01:55 INFO - 'LOGNAME': 'cltbld', 09:01:55 INFO - 'MAIL': '/var/mail/cltbld', 09:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:55 INFO - 'MOZ_NO_REMOTE': '1', 09:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:55 INFO - 'NO_EM_RESTART': '1', 09:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:01:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:01:55 INFO - 'SHELL': '/bin/bash', 09:01:55 INFO - 'SHLVL': '1', 09:01:55 INFO - 'TERM': 'linux', 09:01:55 INFO - 'TMOUT': '86400', 09:01:55 INFO - 'USER': 'cltbld', 09:01:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:55 INFO - '_': '/tools/buildbot/bin/python'} 09:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:55 INFO - Downloading/unpacking psutil>=0.7.1 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01: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 09:01:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:01:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:01:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:01:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:57 INFO - Installing collected packages: psutil 09:01:57 INFO - Running setup.py install for psutil 09:01:57 INFO - building 'psutil._psutil_linux' extension 09:01: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 09:01: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 09:01:57 INFO - building 'psutil._psutil_posix' extension 09:01: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 09:01: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 09:01:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:01:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:01:58 INFO - Successfully installed psutil 09:01:58 INFO - Cleaning up... 09:01:58 INFO - Return code: 0 09:01:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:58 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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:01:58 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 09:01:58 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 09:01:58 INFO - Using env: {'DISPLAY': ':0', 09:01:58 INFO - 'HOME': '/home/cltbld', 09:01:58 INFO - 'LANG': 'en_US.UTF-8', 09:01:58 INFO - 'LANGUAGE': 'en_US:en', 09:01:58 INFO - 'LOGNAME': 'cltbld', 09:01:58 INFO - 'MAIL': '/var/mail/cltbld', 09:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:58 INFO - 'MOZ_NO_REMOTE': '1', 09:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:58 INFO - 'NO_EM_RESTART': '1', 09:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:01:58 INFO - 'SHELL': '/bin/bash', 09:01:58 INFO - 'SHLVL': '1', 09:01:58 INFO - 'TERM': 'linux', 09:01:58 INFO - 'TMOUT': '86400', 09:01:58 INFO - 'USER': 'cltbld', 09:01:58 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:58 INFO - '_': '/tools/buildbot/bin/python'} 09:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:01:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:01:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:01:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:02:00 INFO - Installing collected packages: mozsystemmonitor 09:02:00 INFO - Running setup.py install for mozsystemmonitor 09:02:00 INFO - Successfully installed mozsystemmonitor 09:02:00 INFO - Cleaning up... 09:02:00 INFO - Return code: 0 09:02:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:00 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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:02:00 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 09:02:00 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 09:02:00 INFO - Using env: {'DISPLAY': ':0', 09:02:00 INFO - 'HOME': '/home/cltbld', 09:02:00 INFO - 'LANG': 'en_US.UTF-8', 09:02:00 INFO - 'LANGUAGE': 'en_US:en', 09:02:00 INFO - 'LOGNAME': 'cltbld', 09:02:00 INFO - 'MAIL': '/var/mail/cltbld', 09:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:00 INFO - 'MOZ_NO_REMOTE': '1', 09:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:00 INFO - 'NO_EM_RESTART': '1', 09:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:00 INFO - 'SHELL': '/bin/bash', 09:02:00 INFO - 'SHLVL': '1', 09:02:00 INFO - 'TERM': 'linux', 09:02:00 INFO - 'TMOUT': '86400', 09:02:00 INFO - 'USER': 'cltbld', 09:02:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:00 INFO - '_': '/tools/buildbot/bin/python'} 09:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:02:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02: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 09:02:02 INFO - Downloading docopt-0.6.1.tar.gz 09:02:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:02:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:02 INFO - Running setup.py install for blobuploader 09:02:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:02:02 INFO - Running setup.py install for requests 09:02:03 INFO - Running setup.py install for docopt 09:02:03 INFO - Successfully installed blobuploader requests docopt 09:02:03 INFO - Cleaning up... 09:02:03 INFO - Return code: 0 09:02:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:03 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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:02:03 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 09:02:03 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 09:02:03 INFO - Using env: {'DISPLAY': ':0', 09:02:03 INFO - 'HOME': '/home/cltbld', 09:02:03 INFO - 'LANG': 'en_US.UTF-8', 09:02:03 INFO - 'LANGUAGE': 'en_US:en', 09:02:03 INFO - 'LOGNAME': 'cltbld', 09:02:03 INFO - 'MAIL': '/var/mail/cltbld', 09:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:03 INFO - 'MOZ_NO_REMOTE': '1', 09:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:03 INFO - 'NO_EM_RESTART': '1', 09:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:03 INFO - 'SHELL': '/bin/bash', 09:02:03 INFO - 'SHLVL': '1', 09:02:03 INFO - 'TERM': 'linux', 09:02:03 INFO - 'TMOUT': '86400', 09:02:03 INFO - 'USER': 'cltbld', 09:02:03 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:03 INFO - '_': '/tools/buildbot/bin/python'} 09:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:03 INFO - Running setup.py (path:/tmp/pip-T0ZkFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:03 INFO - Running setup.py (path:/tmp/pip-zmlw_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:03 INFO - Running setup.py (path:/tmp/pip-r88S7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:03 INFO - Running setup.py (path:/tmp/pip-oLkeO3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:03 INFO - Running setup.py (path:/tmp/pip-Bg5wLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:03 INFO - Running setup.py (path:/tmp/pip-wxTxZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:04 INFO - Running setup.py (path:/tmp/pip-eCTfMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:04 INFO - Running setup.py (path:/tmp/pip-WcVg8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:04 INFO - Running setup.py (path:/tmp/pip-giSSou-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:04 INFO - Running setup.py (path:/tmp/pip-zlnB32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:04 INFO - Running setup.py (path:/tmp/pip-4GYT7V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:04 INFO - Running setup.py (path:/tmp/pip-kGV7p2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:04 INFO - Running setup.py (path:/tmp/pip-oyfxf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:04 INFO - Running setup.py (path:/tmp/pip-FyEiK7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:04 INFO - Running setup.py (path:/tmp/pip-ce5qv2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:04 INFO - Running setup.py (path:/tmp/pip-ZDtsn9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:04 INFO - Running setup.py (path:/tmp/pip-WcwTju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:02:04 INFO - Running setup.py install for manifestparser 09:02:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:02:04 INFO - Running setup.py install for mozcrash 09:02:04 INFO - Running setup.py install for mozdebug 09:02:05 INFO - Running setup.py install for mozdevice 09:02:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for mozfile 09:02:05 INFO - Running setup.py install for mozhttpd 09:02:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for mozinfo 09:02:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for mozInstall 09:02:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for mozleak 09:02:05 INFO - Running setup.py install for mozlog 09:02:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for moznetwork 09:02:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:02:05 INFO - Running setup.py install for mozprocess 09:02:06 INFO - Running setup.py install for mozprofile 09:02:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:02:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:02:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:02:06 INFO - Running setup.py install for mozrunner 09:02:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:02:06 INFO - Running setup.py install for mozscreenshot 09:02:06 INFO - Running setup.py install for moztest 09:02:06 INFO - Running setup.py install for mozversion 09:02:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:02:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:02:06 INFO - Cleaning up... 09:02:06 INFO - Return code: 0 09:02:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02: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')]} 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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')]} 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:02: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 09:02: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 09:02:06 INFO - Using env: {'DISPLAY': ':0', 09:02:06 INFO - 'HOME': '/home/cltbld', 09:02:06 INFO - 'LANG': 'en_US.UTF-8', 09:02:06 INFO - 'LANGUAGE': 'en_US:en', 09:02:06 INFO - 'LOGNAME': 'cltbld', 09:02:06 INFO - 'MAIL': '/var/mail/cltbld', 09:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:06 INFO - 'MOZ_NO_REMOTE': '1', 09:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:06 INFO - 'NO_EM_RESTART': '1', 09:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:06 INFO - 'SHELL': '/bin/bash', 09:02:06 INFO - 'SHLVL': '1', 09:02:06 INFO - 'TERM': 'linux', 09:02:06 INFO - 'TMOUT': '86400', 09:02:06 INFO - 'USER': 'cltbld', 09:02:06 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:06 INFO - '_': '/tools/buildbot/bin/python'} 09:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:06 INFO - Running setup.py (path:/tmp/pip-vtrS9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02: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)) 09:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:06 INFO - Running setup.py (path:/tmp/pip-RfJMCF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02: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)) 09:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:06 INFO - Running setup.py (path:/tmp/pip-YfxnKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02: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)) 09:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:07 INFO - Running setup.py (path:/tmp/pip-pw63Hr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:07 INFO - Running setup.py (path:/tmp/pip-yymYkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:07 INFO - Running setup.py (path:/tmp/pip-yyQdEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:07 INFO - Running setup.py (path:/tmp/pip-yb5B90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:07 INFO - Running setup.py (path:/tmp/pip-6lgdMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:07 INFO - Running setup.py (path:/tmp/pip-Rwgx3a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:07 INFO - Running setup.py (path:/tmp/pip-LGxPuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:07 INFO - Running setup.py (path:/tmp/pip-gKRBVw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:07 INFO - Running setup.py (path:/tmp/pip-cN4wDt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:07 INFO - Running setup.py (path:/tmp/pip-lWNJz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:07 INFO - Running setup.py (path:/tmp/pip-1mWeNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:07 INFO - Running setup.py (path:/tmp/pip-JGT_uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:07 INFO - Running setup.py (path:/tmp/pip-rEnJ4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:02: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)) 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:07 INFO - Running setup.py (path:/tmp/pip-10VymU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:02:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:09 INFO - Downloading blessings-1.5.1.tar.gz 09:02: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 09:02:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:09 INFO - Installing collected packages: blessings 09:02:09 INFO - Running setup.py install for blessings 09:02:09 INFO - Successfully installed blessings 09:02:09 INFO - Cleaning up... 09:02:09 INFO - Return code: 0 09:02:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:02:10 INFO - Reading from file tmpfile_stdout 09:02:10 INFO - Current package versions: 09:02:10 INFO - argparse == 1.2.1 09:02:10 INFO - blessings == 1.5.1 09:02:10 INFO - blobuploader == 1.2.4 09:02:10 INFO - docopt == 0.6.1 09:02:10 INFO - manifestparser == 1.1 09:02:10 INFO - mozInstall == 1.12 09:02:10 INFO - mozcrash == 0.16 09:02:10 INFO - mozdebug == 0.1 09:02:10 INFO - mozdevice == 0.47 09:02:10 INFO - mozfile == 1.2 09:02:10 INFO - mozhttpd == 0.7 09:02:10 INFO - mozinfo == 0.9 09:02:10 INFO - mozleak == 0.1 09:02:10 INFO - mozlog == 3.0 09:02:10 INFO - moznetwork == 0.27 09:02:10 INFO - mozprocess == 0.22 09:02:10 INFO - mozprofile == 0.27 09:02:10 INFO - mozrunner == 6.11 09:02:10 INFO - mozscreenshot == 0.1 09:02:10 INFO - mozsystemmonitor == 0.0 09:02:10 INFO - moztest == 0.7 09:02:10 INFO - mozversion == 1.4 09:02:10 INFO - psutil == 3.1.1 09:02:10 INFO - requests == 1.2.3 09:02:10 INFO - wsgiref == 0.1.2 09:02:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:10 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 0x7ff1cf5c0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17276c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e86e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:02:10 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 09:02:10 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 09:02:10 INFO - Using env: {'DISPLAY': ':0', 09:02:10 INFO - 'HOME': '/home/cltbld', 09:02:10 INFO - 'LANG': 'en_US.UTF-8', 09:02:10 INFO - 'LANGUAGE': 'en_US:en', 09:02:10 INFO - 'LOGNAME': 'cltbld', 09:02:10 INFO - 'MAIL': '/var/mail/cltbld', 09:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:10 INFO - 'MOZ_NO_REMOTE': '1', 09:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:10 INFO - 'NO_EM_RESTART': '1', 09:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:10 INFO - 'SHELL': '/bin/bash', 09:02:10 INFO - 'SHLVL': '1', 09:02:10 INFO - 'TERM': 'linux', 09:02:10 INFO - 'TMOUT': '86400', 09:02:10 INFO - 'USER': 'cltbld', 09:02:10 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:10 INFO - '_': '/tools/buildbot/bin/python'} 09:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:02:10 INFO - Cleaning up... 09:02:10 INFO - Return code: 0 09:02:10 INFO - Running post-action listener: _resource_record_post_action 09:02:10 INFO - Running post-action listener: _start_resource_monitoring 09:02:10 INFO - Starting resource monitoring. 09:02:10 INFO - ##### 09:02:10 INFO - ##### Running install step. 09:02:10 INFO - ##### 09:02:10 INFO - Running pre-action listener: _resource_record_pre_action 09:02:10 INFO - Running main action method: install 09:02:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:02:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:02:10 INFO - Reading from file tmpfile_stdout 09:02:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:02:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:02:10 INFO - Reading from file tmpfile_stdout 09:02:10 INFO - Output received: 09:02:10 INFO - Usage: mozinstall [options] installer 09:02:10 INFO - Options: 09:02:10 INFO - -h, --help show this help message and exit 09:02:10 INFO - -d DEST, --destination=DEST 09:02:10 INFO - Directory to install application into. [default: 09:02:10 INFO - "/builds/slave/test-pgo"] 09:02:10 INFO - --app=APP Application being installed. [default: firefox] 09:02:10 INFO - mkdir: /builds/slave/test-pgo/build/application 09:02:10 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'] 09:02:10 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 09:02:25 INFO - Reading from file tmpfile_stdout 09:02:25 INFO - Output received: 09:02:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:02:25 INFO - Running post-action listener: _resource_record_post_action 09:02:25 INFO - ##### 09:02:25 INFO - ##### Running run-tests step. 09:02:25 INFO - ##### 09:02:25 INFO - Running pre-action listener: _resource_record_pre_action 09:02:25 INFO - Running main action method: run_tests 09:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:02:25 INFO - Python 2.7.3 09:02:25 INFO - Return code: 0 09:02:25 INFO - grabbing minidump binary from tooltool 09:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:25 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 0x181ea90>, '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 0x1870f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18712e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:02:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:02:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:02:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:25 INFO - Return code: 0 09:02:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:02:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:02:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:02:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:02:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:02:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:02:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 09:02:25 INFO - Using env: {'DISPLAY': ':0', 09:02:25 INFO - 'HOME': '/home/cltbld', 09:02:25 INFO - 'LANG': 'en_US.UTF-8', 09:02:25 INFO - 'LANGUAGE': 'en_US:en', 09:02:25 INFO - 'LOGNAME': 'cltbld', 09:02:25 INFO - 'MAIL': '/var/mail/cltbld', 09:02:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:02:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:25 INFO - 'MOZ_NO_REMOTE': '1', 09:02:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:25 INFO - 'NO_EM_RESTART': '1', 09:02:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:02:25 INFO - 'SHELL': '/bin/bash', 09:02:25 INFO - 'SHLVL': '1', 09:02:25 INFO - 'TERM': 'linux', 09:02:25 INFO - 'TMOUT': '86400', 09:02:25 INFO - 'USER': 'cltbld', 09:02:25 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295', 09:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:25 INFO - '_': '/tools/buildbot/bin/python'} 09:02:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 09:02:25 INFO - mozversion INFO | application_buildid: 20151112073424 09:02:25 INFO - mozversion INFO | application_changeset: 62968e4afd68406ee95f0313a51df2cc0964dae8 09:02:25 INFO - mozversion INFO | application_display_name: Nightly 09:02:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:25 INFO - mozversion INFO | application_name: Firefox 09:02:25 INFO - mozversion INFO | application_remotingname: firefox 09:02:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:02:25 INFO - mozversion INFO | application_vendor: Mozilla 09:02:25 INFO - mozversion INFO | application_version: 45.0a1 09:02:25 INFO - mozversion INFO | platform_buildid: 20151112073424 09:02:25 INFO - mozversion INFO | platform_changeset: 62968e4afd68406ee95f0313a51df2cc0964dae8 09:02:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:02:25 INFO - mozversion INFO | platform_version: 45.0a1 09:02:25 INFO - 2015-11-12 09:02:25,293 DEBUG : using testdate: 1447347745 09:02:25 INFO - 2015-11-12 09:02:25,293 DEBUG : actual date: 1447347745 09:02:25 INFO - 2015-11-12 09:02:25,303 INFO : starting webserver on 'localhost:35691' 09:02:25 INFO - 2015-11-12 09:02:25,304 INFO : Starting test suite talos-linux64-ix-027.e 09:02:25 INFO - 2015-11-12 09:02:25,304 INFO : Starting test dromaeo_css 09:02:25 INFO - 2015-11-12 09:02:25,304 DEBUG : operating with platform_type : linux_ 09:02:25 INFO - 2015-11-12 09:02:25,305 INFO : Initialising browser for dromaeo_css test... 09:02:25 INFO - 2015-11-12 09:02:25,319 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIffMOX/profile http://localhost:35691/getInfo.html 09:02:30 INFO - 2015-11-12 09:02:30,880 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:02:30 INFO - 2015-11-12 09:02:30,880 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:02:30 INFO - 2015-11-12 09:02:30,880 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:02:30 INFO - 2015-11-12 09:02:30,880 DEBUG : BROWSER_OUTPUT: __metrics 09:02:31 INFO - 2015-11-12 09:02:31,909 INFO : Browser initialized. 09:02:31 INFO - 2015-11-12 09:02:31,910 INFO : Running cycle 1/1 for dromaeo_css test... 09:02:31 INFO - 2015-11-12 09:02:31,910 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIffMOX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:02:43 INFO - 2015-11-12 09:02:43,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 141488128 09:02:43 INFO - 2015-11-12 09:02:43,650 DEBUG : BROWSER_OUTPUT: 09:03:33 INFO - 2015-11-12 09:03:33,318 DEBUG : BROWSER_OUTPUT: 1447347813313 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] 09:05:42 INFO - 2015-11-12 09:05:42,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35691/tests/dromaeo/cssquery-ext.html) 09:05:43 INFO - 2015-11-12 09:05:43,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 146374656 09:05:43 INFO - 2015-11-12 09:05:43,442 DEBUG : BROWSER_OUTPUT: 09:08:45 INFO - 2015-11-12 09:08:45,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-ext.html (next: http://localhost:35691/tests/dromaeo/cssquery-jquery.html) 09:08:45 INFO - 2015-11-12 09:08:45,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 139481088 09:08:45 INFO - 2015-11-12 09:08:45,946 DEBUG : BROWSER_OUTPUT: 09:11:47 INFO - 2015-11-12 09:11:47,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35691/tests/dromaeo/cssquery-mootools.html) 09:11:48 INFO - 2015-11-12 09:11:48,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 09:11:48 INFO - 2015-11-12 09:11:48,209 DEBUG : BROWSER_OUTPUT: 09:14:49 INFO - 2015-11-12 09:14:49,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35691/tests/dromaeo/cssquery-prototype.html) 09:14:50 INFO - 2015-11-12 09:14:50,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 139948032 09:14:50 INFO - 2015-11-12 09:14:50,456 DEBUG : BROWSER_OUTPUT: 09:17:52 INFO - 2015-11-12 09:17:52,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35691/tests/dromaeo/cssquery-yui.html) 09:17:53 INFO - 2015-11-12 09:17:53,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 140623872 09:17:53 INFO - 2015-11-12 09:17:53,322 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/dromaeo/cssquery-yui.html (next: http://localhost:35691/tests/dromaeo/cssquery-dojo.html) 09:20:55 INFO - 2015-11-12 09:20:55,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 143167488 09:20:55 INFO - 2015-11-12 09:20:55,957 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:20:55 INFO - 2015-11-12 09:20:55,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:20:55 INFO - 2015-11-12 09:20:55,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:20:55 INFO - 2015-11-12 09:20:55,958 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:20:55 INFO - 2015-11-12 09:20:55,959 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3256.0882952773222;3272.1165285372936;3310.089725325534;3320.4521253993094;3325.501174823776;5345.839624811252;5427.837164885055;5457.890842183154;5470.206820011096;5487.176923461483;5537.058700020996;5559.555235581154;5576.079946808772;5613.915791263134;5714.742836572354;5014.9498505014935;5128.410232823236;5132.666376685522;5185.766640501168;5207.739613019353;4963.379577552806;5038.89144388234;5059.215821547666;5081.339425874649;5096.210087436453;4928.728919909404;4997.30037794709;5061.8734531637;5074.873128171788;5136.640435169521;5014.799408023675;5025.773840177201;5027.572656324217;5031.0441016206805;5084.161113416282;4940.827071052532;5022.271770593244;5036.445990940993;5036.773345199438;5037.194048952187;5324.54741346986;5376.596755243372;5392.865178370533;5408.810691625774;5460.945390546123;6058.333583305833;6085.756569737206;6115.388461153893;6122.418370254819;6123.969380153116;5906.645601263938;6024.246969128859;6115.5413343998935;6148;6154.599951003215;5554.666719996772;5609.66342019472;5616.803411880605;5621.7751289948355;5656.038473459522;6071.939280607226;6086.878262434815;6095.908561371583;6097.847553811191;6099.75600975956;5777.480026797609;5815.41845815415;5896.380880007538;5915.349311575723;5930.8813823723285;6084.5132389408745;6086.056661217518;6089.117078023751;6100.908486372619;6115.021596544531;6041.969790151021;6043.002904520705;6045;6047.092936059538;6052.576319657582;5802.216700745345;5894.852628684317;5908.468237858613;6019;6066.393360663898;4455.2648812946145;4551.180787458289;4569.520200378979;4616.422947131608;4625.051864367797;4059.167870586523;4088.304988151962;4089.20260549196;4120.17596480705;4129.566395528426;5487.917681234785;5589.161625756169;5661.886762264814;5751.309842818805;5771.163181338682;6014.669193194329;6052.878942421127;6097.298810636834;6097.359777223328;6100.298465676504;5474.808381706621;5710.65736055838;5710.71446427677;5727.914081288784;5736.311642602915;5056.696598204119;5093.465186155475;5127.846164615067;5129.538341549279;5169.922451163236;6117.694115294217;6128.754849806047;6143.139960405458;6145.10895920098;6207.937920620826;5750.367459579359;5898.469137777621;6032.185654936703;6035.36628653985;6040.124181993674;6126.081087836682;6171.259448866164;6216.7824126155365;6233.096201050732;6233.470155036873;6015;6048.810596369348;6055.182550355822;6073.696315184135;6109.969450152721;5901.704914754331;6057.363976782551;6067.211262535842;6114.052321890114;6146.200993870768;5776.56675749312;5823.155642431739;5833.358330583547;5842.941570584409;5886.440788125121;5843.211166492639;5903.940960590339;5927.081302398135;5945.940540594712;5947.672877991752;5538.363088244742;5641.774329026793;5723.742431590672;5781.739821708117;5857.7949771757785;5851.882962340645;5877.206577112206;5878.2358293421585;5885.176075349369;5918.763249470146;5720.256366672306;5752.453516915886;5757.481826635623;5757.884842303214;5758.568107391879 09:20:55 INFO - 2015-11-12 09:20:55,961 DEBUG : BROWSER_OUTPUT: |1;ext.html;537.1325309624957;581.3053401185583;589.1810383566841;590.1767034986198;591.9970400147998;31125.221869453275;39678.60321396785;39832.800835995855;39874.80062599683;40148.39777403334;43320.783396083054;43786.12427751443;43959.340609890874;44067;44169;8779.165979231979;8889.377743557954;8892.911070889273;8944.418612790181;8965.058668839743;8715.607797649089;8878.73363799087;8890.644374225023;8906.376553641248;8910.376273660846;8780.473171609723;8854.114588541159;8859.822803543926;8863.379563430562;8909.821803563926;8666.263367613761;8802.779930501725;8826.911730882704;8828.249598784143;8850.424722393089;8718.607662655133;8772.429792063496;8810.779730506725;8845.867311990325;8876;40254;40572.59427405718;40622.593774062174;40660.39009414861;40884;3265.510173473998;3522.6477352264824;3524.4537096750046;3576.3741345264734;3721.9441708374397;31996;32757.6724232757;32780;32943.3411331772;33224.6677533224;3207.9839600801847;3239.864898327098;3251.154699778051;3288.391647545188;3393.4400823864034;279904;280312;280384.59807701036;280720;280835;53116.73441632767;54159.72920135453;60752;61074.38925610687;66818;63800.36199638037;63822.36177638257;64071;64231.67884160643;64285.67857160778;12270.325132117641;12359.3820308986;12367.196132251374;12441.25352478836;12517.248965061943;9670.56482458291;9781.510924453749;9787.608495660093;9793.706188814347;9821.165200957856;20550.794492054887;20580.176792928116;20679.896600516902;20816.583668326548;20935.79064209369;8059.677612895419;8355.582220888931;8410.285125764256;8442.704505342284;8472.068072512018;895.7268033249921;919.4207649181106;1044.5143008501084;1068.647346375694;1078.2613909472036;27893.860530697217;28688;28760;28995.565066524017;29140.854295728386;1009.6970908727352;1054.383185836279;1093.5844379135876;1146.696125526736;1171.5021116025655;14618.561443156723;14962.850371496363;14977.775333370008;15033.548993529992;15182.240887955779;312645;315233;315461;316188;316195;51575.484245157815;51897.48102518926;52033.21950170751;52279.21581176286;52369.21446178311;1281.3401098434315;1288.2721262486666;1309.1032642639823;1314.901382396305;1319.162331919238;27109.72890271151;28135;28198.85900570484;32799.344013120084;33070.33859322752;50488.74755626198;50880.74559627178;51150.488495116064;51320.48679513157;51445.22832157595;299039;301335;302242;303076;303399;42170.57829421666;46348.53651463442;46812.29781553348;47292;47464;43550.56449435465;43760;43783.34324985192;44037.559624403344;44517;36561.634383656885;37569.62430375661;41046.179076417706;42043.36934945917;42820.35769463398;36762;39558;40626.796866016666;40778;41172.79413602913;39229.803850981705;39607.20785584215;43082;43555.34666979934;43777.78111109424;38082;39548.209035819695;39575.80212098921;39670.80164599274;39874;27347.31631709223;27513.862430687717;27745.445091098467;28039.579406308512;28166.564200992896 09:20:55 INFO - 2015-11-12 09:20:55,964 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.8970274363577;330.84284964641785;338.8966365258596;340.93863104641156;341.5116383571493;14074.718505629908;14519.201443920607;16681.58296042598;16965.491035268948;17658.11709414529;14851.405943762236;15060.096394216327;15113.92443037786;15435.3825846966;15445.382184712626;5085.440601533828;5146.382434107903;5198.116320225552;5242.528172464477;5255.605829562779;5201.141811601081;5232.816851410202;5261.053010458116;5265.65773224741;5270.947290527103;5091.66904151229;5195.402528709209;5199.922001169985;5281.128613778722;5285;5227.268182454441;5255.290535777678;5264.2893209416625;5266.078436273637;5289.550388217006;3958.5645578986578;4055.7363771355062;4095.9385609215888;4606.9078618427775;4647.976760116211;13500.257485838274;13509.324533773271;13788.448462061506;13803.447862085604;13817.792733109012;1999.7100420438956;2044.3866839948105;2067.235123004483;2071.5856828634332;2112.746470423559;9476;9535.713928582154;9595.13643772064;9598.568064437117;9752.366096203725;1671.8746094042995;1706.5051135170909;1732.4975757030445;1739.20866005967;1753.0183097465333;57657.42342576604;59799.40200597982;60157.6992115041;60215.698921505114;60378.69810650919;6623.370779775913;6732.225794033651;6785.1518560179975;6789.049533065375;6856.211535673461;7869.3311068559815;8127.349812015024;8137.674493020331;8154.836903261901;8158.755237342889;4907.828226012072;4927.901441971212;4948.802047918043;4956.925646115311;5045.369328833895;4877.487863774323;5068.087744206005;5069.898602027939;5104.846854594368;5124.538791508708;3115.7818952673547;3241.2383089973837;3262.2659901522443;3264.5919260092487;3273.2962413080827;1097.5938902606088;1100.5157730598512;1112.054753459553;1112.2603468693228;1157.785809625222;426.45413870246136;433.9761313127808;441.3225698552706;456.5936316678159;462.03434821223806;11121.27711698737;11640.534378624929;11894.881051189377;11946.776824869501;12099.637010889688;455.3210062693429;456.0969280823921;457.7162159461089;462.2834606360128;465.6554149929096;6199.473044791153;6502.934970650327;6522.086907832907;6551.672416379257;6647.567908085959;532108;544544;548672;552960;557366;70639.64680176566;75724;76628;76828.61585692035;79682;499.9925001124986;505.0429436218346;509.5006893244567;509.8597885581495;510.316176323728;10579.10077643409;10656.62701805433;10713.732156695833;10803.135749139892;10834.891651083388;31778.364432711678;32051.67948320487;32370;34405;36094.278114438086;41722;43751;45794;46748.29877551772;47681;6400;6481.449076828334;6581.539292249497;6587.4071333580205;6601.438877695449;12091.516339346328;12234.632961011184;12294.631161065183;12364.81452778227;12472;10326.070653641209;10591.47042647849;10860.891391085988;10879;10958.671239862499;10341.896581034094;10599.735006624587;10750.946245269037;10795.56817727282;10860.945695271474;10355.741106472398;10568.048875601233;10573.312734672221;10743;10826.67519974402;6450.354964503512;6480.384363485461;6494.285628580947;6508.576942498722;6528.902066469102;10109;10153.746156346151;10524.31591946521;10563.1021363185;10704.357738535713 09:20:55 INFO - 2015-11-12 09:20:55,966 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1457.4097490516342;1460.700556385941;1606.172820997186;1753.4301352060584;1766.549529869883;6687.130673012513;6763.932360676392;7441.441891858112;7827.960860195705;7828.725994590191;7325.780226593198;7547.924520754791;7591.886121708165;7595.354394876428;7601.467897247181;2258.5482903419343;2275.670027845961;2296.1848543766973;2299.4251437140715;2307.157887371106;2277.1802151225547;2305.6772051912744;2318.026428899858;2323.163661082009;2325.5813953488364;2314.3866875278063;2321.350021993836;2327.6043072677685;2327.976720232801;2342.4261056041296;2271.216430331533;2314.4329639238326;2339.0526836631193;2339.2748248043163;2344.0623750499853;2294.070901284982;2321.1063740460045;2328.988355058231;2330.766923307656;2338.2050102964904;7665.540067595962;7673.079230492321;7691.077070751546;7699.538027718355;7711.961440192819;4366.410534577855;4490.191765482212;4549.886252843672;4555.407796986404;4560.589546940758;2930.721581449759;2945.527236381809;2950.1444581071464;2959.4377068356944;2970.064429704658;908.8318661047728;928.5403725156024;928.7445952363087;930.6230976454547;950.7100334398006;10222.233332500093;10330.845037324447;10348.79302413955;10364.48177591125;10369.79260414795;4123.443335149776;4143.854965076208;4193.182329445729;4194.307939189999;4219.746815191037;8486.0665326814;8489.151084891462;8489.61796719149;8500.27747641445;8502.957485212535;4543.1822271990695;4551.499335073139;4554.4990051094355;4573.222552166139;4586.220342541776;4157.792110394529;4184.81168347419;4199.9370009449885;4202.516710578261;4211.073563815956;3518.683318501347;3525.629808870083;3527.6825085742407;3527.894163175109;3581.659742324475;1107.0368779162181;1107.3134656513014;1122.231271578971;1124.8087825069758;1131.185546406586;1303.485123376261;1304.2630913533824;1314.9276789776654;1319.1755153029358;1352.7970804379224;7199.964000179965;7224.277572242734;7353.522021068614;7360.2271761465345;7363.447741419415;475.916714574948;482.8599706085196;483.0242909323148;483.97822098005673;484.3799936081821;5634.098544232985;5635.859103522363;5650.491455769001;5688.943110568925;5696.572757043238;8612.741617751477;8625.439346442587;8628.482291062432;8681.739547813575;8749.343799215085;8565.95717021411;8602.967643882774;8674.522901240367;8678.783030424163;8680.95659521711;7027.121609798775;7141.321574450419;7141.714331426789;7145.39264162552;7159.176694680178;7116.928830711627;7118.145822501333;7151.82120446993;7194.928050719426;7220.602866842374;7896.486728362638;7898.131205567268;8058.83882322362;8136.22705842944;8195.303399210896;8126.065502467056;8162.347012238888;8184.345252379914;8260.091389947222;8264.83470330602;6696.1629796275465;6987.336203060701;6987.441004719712;6994.160700715743;7007.614581198083;7464.850702986018;7490.662920168496;7491.775246742606;7507.174210836913;7509.286617771303;6423.710933007932;6544.280129185881;6563.34366563359;6637.137172167587;6667.2666006738245;6929.861402772017;6939.548929319578;6978.267281935324;6993;7046;6957.860842783217;6976.127984002;6976.930230697831;6991.44068474531;7011.754588589375;6478.255000674794;6519.348065193442;6522.934770652233;6524.836879077871;6525.510586705921;6562.442192413699;6588.308227636221;6608.372204640552;6623.834404139935;6663.300353463011 09:20:55 INFO - 2015-11-12 09:20:55,967 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.59316956261233;298.86401687232313;299.0922550060566;303.80556443875923;307.04508977081287;6194;6206.875862482753;6229.968850155754;6269.7492100315985;6423.7430502779835;6235.282942461618;6333.145025421578;6340.651264180468;6346.968265158668;6347.61914285142;4605.769711514427;4690.812367505296;4694.38972933519;4704.882377940562;4707.223308154151;4709.670323077386;4712.410948631421;4727.534464316073;4729.2433210686295;4729.716217026972;4636.072785442908;4648.0471503341905;4651.7441540715245;4658.347831303603;4673.3223682566;4642.558956899106;4657.06858628274;4673.1121086993535;4678.929816052728;4682;4006.939895901564;4025.81883815229;4032.475778148851;4034.435179074932;4035.273650742865;5758.596898217126;5780.739866706008;5873.3245676746865;5898.321693005317;5907.6750778707155;5482.80810171646;5498.395176530578;5507.7246137693355;5511.173324001392;5514.5864060195645;6650.268470468244;6656.334366563305;6658.400743933069;6669.099671544376;6672;4473.843415480443;4542.954570454319;4544.272916333371;4545.2954792007295;4546.113507865967;6812.284710105417;6898.172219333712;6909.343612356818;6917.100776898971;6924.58452492852;4627.930581041287;4653.95346046542;4659.044895796422;4659.627229821606;4664.580187783048;4676.836310729108;4682.578567928903;4700.412448443944;4721.669483136147;4728.38530990969;5344.198370244494;5471.917921231185;5480.835574932758;5482.150266708666;5496.890062198813;6682.532222744361;6686.197656281277;6694.866102677919;6711.261761206263;6719.227288861844;1634.7547867819922;1683.4865366063223;1690.6365131496786;1691.8223586523484;1695.262560786062;1054.8997845204694;1091.4815462655176;1092.4046394714899;1095.6712986104296;1116.2576886370473;6390.169277993831;6404.199475065617;6410.326915673787;6424.100625912376;6427.742890284337;6830.043793868862;6859.828504287433;6886.793396198122;6896.27589103147;6896.413804826646;6301.369863013753;6361.236651601837;6396.488280937514;6401.647909364937;6409.615423074631;3739.495168152319;3773.754705944105;3779.3764028934916;3804.7907365094634;3806.1626442182674;7152.713891444388;7250.057492525938;7251.274872512812;7278.454115941219;7288.08898887639;7058.788236352918;7064.1876184238445;7089.113860767404;7091.787246382617;7096.935459681089;7217.061781968416;7241.5293005954445;7257.52826066304;7264.23725508814;7264.782056538206;6822.317768223138;6961.269066747918;6965.930340696731;6975.755848545276;6997.090378250795;6864.279250678806;6881.346272104142;6906.5496245786935;6907.13660792401;6908.689108990007;7117.537360071578;7240.312170343809;7249.710011599688;7272.490925635155;7278.781636550912;4497.572730590588;4533.727976321431;4535;4537.1833070047705;4540.0919816037585;6870.45036397077;6932.549384290005;6949.061876646588;6949.965250173919;6952.44380449573;6615.6030638161865;6744.5616034957575;6752.527323087534;6757.695903684247;6782;6738.326167383222;6740.191177058784;6742.123523941857;6757.831054223684;6769.356911093439;6618.669066546557;6619.0733297339375;6629.900551491828;6639.203295604559;6639.502037347122;6605.669716514251;6752.501574417497;6770.729170833309;6783.982402639644;6789.660516974032;6600.768973085919;6610.438112760469;6635.933640663531;6642.4686025118845;6647.302033286629 09:20:55 INFO - 2015-11-12 09:20:55,970 DEBUG : BROWSER_OUTPUT: |5;yui.html;758.3970743259108;783.2598194706003;856.3320609924253;859.3383095016837;891.8929728432589;10967.780644387107;11173;11220.102391808656;11231.157663175274;11284.830727539094;14038;14069.226192559405;14096.506622268224;14139.151650900953;14151.646208844784;803.8392321535687;803.9799005024877;817.5503473089807;818.1082619944259;820.1142765812908;810.7608255564622;816.2735165702529;818.4925346285312;820.6512232301278;821.1829229916212;771.2827070824131;775.5385545600387;778.622368151446;779.4193325972159;779.742684913977;768.8462307538487;769.9422543309219;771.6758961236238;773.5590713293396;777.6617171530374;560.1262031231292;561.0462214235815;561.2703485468874;563.5745012515565;565.4854082784647;13311;13425.261610611413;13448.260345680983;13450.529231476949;13452.05835591509;10019.59921603135;10099.29304948654;10126.443045632488;10355.27513074085;10569.73575660607;10279.229057820694;10396.844047339297;10742.033217010428;11225.158113141548;11385.430728463543;3615.891523254307;3643.125649844045;3646.4348026056005;3818.618138186187;3857.9228415431535;47576;48564.75717621389;48626;48652.513474865154;48899.51100488985;10281.434521101412;10385.2211084169;10563;10726.249162558546;10797.08224800885;19045.333413330467;19172.520686982938;19184.61630767377;19207.32774352919;19249.711254331196;7895.171007044178;8144.144864789112;8311.8337633247;8329.08380078191;8378.41351105429;4356.825726970886;4496.4154659894;4522.66080043998;4535.251683472256;4607.562281583244;3212.245122396235;3222.774405791572;3260.625028121749;3273.9508907366408;3275.9672403275663;471.3895505320618;477.6775676418473;486.49647614718594;489.6645797628636;492.0626207075527;572.4761842913771;636.8503401700597;657.7599176300712;675.8595439184995;686.5949090036902;8537.701180458778;8659.480431174024;8693.521856297964;8716.520591367536;8853.335999800041;650.417876000986;670.6948338505968;683.2689022745714;697.7592730508068;705.8601303355883;3832.3868181091448;3978.76127432355;4140.896477588024;4245.724027938174;4271.081717430705;56584;57064;57562.7121864388;57772.42227577754;58171.127433088535;50313.74843125761;50780.23829642558;50968;51269.743651281504;51566.226506602434;48431.273530897066;48719.5128048722;49956.75021624941;50142.74928625333;50562.49437505578;8379.245867871921;8648;8756.60595273227;9056.36605437613;9063.864042039506;35395.64604354026;35422.114447137996;36491.63508364883;37109.44335835019;37132.44301335536;41126.1774764509;42203.155936880474;43202.35196471993;46321.53678463307;48235.5176448231;7410.368919229646;7508.587027713528;7539.660715267716;7629.771106866803;7647.694092236248;11740.785775509838;12073.698157546132;12126.27242365461;12161.69595760113;12167.81748273759;11421.543138274375;11535.423228838692;11630.244034137753;11768.293902365886;12046.277223366626;10791.514381852992;10998.835017474905;11039.83440248413;11108.389038602954;11395.202335836411;11327.895465455516;11462.254953428;11678.299302041905;11729.648110556696;11953.94023029914;9970.30207885441;10040.549326742415;10189.54147063369;10236;10442.63450779219;9439.575219115293;9538.126123076814;10036.89963100389;10123.443210623487;10232.23258255619 09:20:55 INFO - 2015-11-12 09:20:55,971 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:20:55 INFO - 2015-11-12 09:20:55,971 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:20:55 INFO - 2015-11-12 09:20:55,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,276 09:20:55 INFO - 2015-11-12 09:20:55,971 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:20:55 INFO - 2015-11-12 09:20:55,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348855956__endTimestamp 09:20:55 INFO - 2015-11-12 09:20:55,972 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,972 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:20:55 INFO - 2015-11-12 09:20:55,972 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:20:55 INFO - 2015-11-12 09:20:55,973 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,973 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5560.41 Median:5758.57 stddev:642.47 (11.2%) stddev-sans-first:618.49 09:20:55 INFO - 2015-11-12 09:20:55,973 DEBUG : BROWSER_OUTPUT: Values: 3256.1 3272.1 3310.1 3320.5 3325.5 5345.8 5427.8 5457.9 5470.2 5487.2 5537.1 5559.6 5576.1 5613.9 5714.7 5014.9 5128.4 5132.7 5185.8 5207.7 4963.4 5038.9 5059.2 5081.3 5096.2 4928.7 4997.3 5061.9 5074.9 5136.6 5014.8 5025.8 5027.6 5031.0 5084.2 4940.8 5022.3 5036.4 5036.8 5037.2 5324.5 5376.6 5392.9 5408.8 5460.9 6058.3 6085.8 6115.4 6122.4 6124.0 5906.6 6024.2 6115.5 6148.0 6154.6 5554.7 5609.7 5616.8 5621.8 5656.0 6071.9 6086.9 6095.9 6097.8 6099.8 5777.5 5815.4 5896.4 5915.3 5930.9 6084.5 6086.1 6089.1 6100.9 6115.0 6042.0 6043.0 6045.0 6047.1 6052.6 5802.2 5894.9 5908.5 6019.0 6066.4 4455.3 4551.2 4569.5 4616.4 4625.1 4059.2 4088.3 4089.2 4120.2 4129.6 5487.9 5589.2 5661.9 5751.3 5771.2 6014.7 6052.9 6097.3 6097.4 6100.3 5474.8 5710.7 5710.7 5727.9 5736.3 5056.7 5093.5 5127.8 5129.5 5169.9 6117.7 6128.8 6143.1 6145.1 6207.9 5750.4 5898.5 6032.2 6035.4 6040.1 6126.1 6171.3 6216.8 6233.1 6233.5 6015.0 6048.8 6055.2 6073.7 6110.0 5901.7 6057.4 6067.2 6114.1 6146.2 5776.6 5823.2 5833.4 5842.9 5886.4 5843.2 5903.9 5927.1 5945.9 5947.7 5538.4 5641.8 5723.7 5781.7 5857.8 5851.9 5877.2 5878.2 5885.2 5918.8 5720.3 5752.5 5757.5 5757.9 5758.6 09:20:55 INFO - 2015-11-12 09:20:55,974 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,974 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48262.69 Median:40597.59 stddev:78157.20 (192.5%) stddev-sans-first:78294.31 09:20:55 INFO - 2015-11-12 09:20:55,974 DEBUG : BROWSER_OUTPUT: Values: 537.1 581.3 589.2 590.2 592.0 31125.2 39678.6 39832.8 39874.8 40148.4 43320.8 43786.1 43959.3 44067.0 44169.0 8779.2 8889.4 8892.9 8944.4 8965.1 8715.6 8878.7 8890.6 8906.4 8910.4 8780.5 8854.1 8859.8 8863.4 8909.8 8666.3 8802.8 8826.9 8828.2 8850.4 8718.6 8772.4 8810.8 8845.9 8876.0 40254.0 40572.6 40622.6 40660.4 40884.0 3265.5 3522.6 3524.5 3576.4 3721.9 31996.0 32757.7 32780.0 32943.3 33224.7 3208.0 3239.9 3251.2 3288.4 3393.4 279904.0 280312.0 280384.6 280720.0 280835.0 53116.7 54159.7 60752.0 61074.4 66818.0 63800.4 63822.4 64071.0 64231.7 64285.7 12270.3 12359.4 12367.2 12441.3 12517.2 9670.6 9781.5 9787.6 9793.7 9821.2 20550.8 20580.2 20679.9 20816.6 20935.8 8059.7 8355.6 8410.3 8442.7 8472.1 895.7 919.4 1044.5 1068.6 1078.3 27893.9 28688.0 28760.0 28995.6 29140.9 1009.7 1054.4 1093.6 1146.7 1171.5 14618.6 14962.9 14977.8 15033.5 15182.2 312645.0 315233.0 315461.0 316188.0 316195.0 51575.5 51897.5 52033.2 52279.2 52369.2 1281.3 1288.3 1309.1 1314.9 1319.2 27109.7 28135.0 28198.9 32799.3 33070.3 50488.7 50880.7 51150.5 51320.5 51445.2 299039.0 301335.0 302242.0 303076.0 303399.0 42170.6 46348.5 46812.3 47292.0 47464.0 43550.6 43760.0 43783.3 44037.6 44517.0 36561.6 37569.6 41046.2 42043.4 42820.4 36762.0 39558.0 40626.8 40778.0 41172.8 39229.8 39607.2 43082.0 43555.3 43777.8 38082.0 39548.2 39575.8 39670.8 39874.0 27347.3 27513.9 27745.4 28039.6 28166.6 09:20:55 INFO - 2015-11-12 09:20:55,974 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,975 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27004.59 Median:457.15 stddev:89647.62 (19609.9%) stddev-sans-first:89876.72 09:20:55 INFO - 2015-11-12 09:20:55,976 DEBUG : BROWSER_OUTPUT: Values: 326.9 330.8 338.9 340.9 341.5 14074.7 14519.2 16681.6 16965.5 17658.1 14851.4 15060.1 15113.9 15435.4 15445.4 5085.4 5146.4 5198.1 5242.5 5255.6 5201.1 5232.8 5261.1 5265.7 5270.9 5091.7 5195.4 5199.9 5281.1 5285.0 5227.3 5255.3 5264.3 5266.1 5289.6 3958.6 4055.7 4095.9 4606.9 4648.0 13500.3 13509.3 13788.4 13803.4 13817.8 1999.7 2044.4 2067.2 2071.6 2112.7 9476.0 9535.7 9595.1 9598.6 9752.4 1671.9 1706.5 1732.5 1739.2 1753.0 57657.4 59799.4 60157.7 60215.7 60378.7 6623.4 6732.2 6785.2 6789.0 6856.2 7869.3 8127.3 8137.7 8154.8 8158.8 4907.8 4927.9 4948.8 4956.9 5045.4 4877.5 5068.1 5069.9 5104.8 5124.5 3115.8 3241.2 3262.3 3264.6 3273.3 1097.6 1100.5 1112.1 1112.3 1157.8 426.5 434.0 441.3 456.6 462.0 11121.3 11640.5 11894.9 11946.8 12099.6 455.3 456.1 457.7 462.3 465.7 6199.5 6502.9 6522.1 6551.7 6647.6 532108.0 544544.0 548672.0 552960.0 557366.0 70639.6 75724.0 76628.0 76828.6 79682.0 500.0 505.0 509.5 509.9 510.3 10579.1 10656.6 10713.7 10803.1 10834.9 31778.4 32051.7 32370.0 34405.0 36094.3 41722.0 43751.0 45794.0 46748.3 47681.0 6400.0 6481.4 6581.5 6587.4 6601.4 12091.5 12234.6 12294.6 12364.8 12472.0 10326.1 10591.5 10860.9 10879.0 10958.7 10341.9 10599.7 10750.9 10795.6 10860.9 10355.7 10568.0 10573.3 10743.0 10826.7 6450.4 6480.4 6494.3 6508.6 6528.9 10109.0 10153.7 10524.3 10563.1 10704.4 09:20:55 INFO - 2015-11-12 09:20:55,976 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,977 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5309.92 Median:6534.90 stddev:2715.00 (41.5%) stddev-sans-first:2707.18 09:20:55 INFO - 2015-11-12 09:20:55,978 DEBUG : BROWSER_OUTPUT: Values: 1457.4 1460.7 1606.2 1753.4 1766.5 6687.1 6763.9 7441.4 7828.0 7828.7 7325.8 7547.9 7591.9 7595.4 7601.5 2258.5 2275.7 2296.2 2299.4 2307.2 2277.2 2305.7 2318.0 2323.2 2325.6 2314.4 2321.4 2327.6 2328.0 2342.4 2271.2 2314.4 2339.1 2339.3 2344.1 2294.1 2321.1 2329.0 2330.8 2338.2 7665.5 7673.1 7691.1 7699.5 7712.0 4366.4 4490.2 4549.9 4555.4 4560.6 2930.7 2945.5 2950.1 2959.4 2970.1 908.8 928.5 928.7 930.6 950.7 10222.2 10330.8 10348.8 10364.5 10369.8 4123.4 4143.9 4193.2 4194.3 4219.7 8486.1 8489.2 8489.6 8500.3 8503.0 4543.2 4551.5 4554.5 4573.2 4586.2 4157.8 4184.8 4199.9 4202.5 4211.1 3518.7 3525.6 3527.7 3527.9 3581.7 1107.0 1107.3 1122.2 1124.8 1131.2 1303.5 1304.3 1314.9 1319.2 1352.8 7200.0 7224.3 7353.5 7360.2 7363.4 475.9 482.9 483.0 484.0 484.4 5634.1 5635.9 5650.5 5688.9 5696.6 8612.7 8625.4 8628.5 8681.7 8749.3 8566.0 8603.0 8674.5 8678.8 8681.0 7027.1 7141.3 7141.7 7145.4 7159.2 7116.9 7118.1 7151.8 7194.9 7220.6 7896.5 7898.1 8058.8 8136.2 8195.3 8126.1 8162.3 8184.3 8260.1 8264.8 6696.2 6987.3 6987.4 6994.2 7007.6 7464.9 7490.7 7491.8 7507.2 7509.3 6423.7 6544.3 6563.3 6637.1 6667.3 6929.9 6939.5 6978.3 6993.0 7046.0 6957.9 6976.1 6976.9 6991.4 7011.8 6478.3 6519.3 6522.9 6524.8 6525.5 6562.4 6588.3 6608.4 6623.8 6663.3 09:20:55 INFO - 2015-11-12 09:20:55,978 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,978 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5565.67 Median:6375.70 stddev:1724.35 (27.0%) stddev-sans-first:1683.12 09:20:55 INFO - 2015-11-12 09:20:55,979 DEBUG : BROWSER_OUTPUT: Values: 290.6 298.9 299.1 303.8 307.0 6194.0 6206.9 6230.0 6269.7 6423.7 6235.3 6333.1 6340.7 6347.0 6347.6 4605.8 4690.8 4694.4 4704.9 4707.2 4709.7 4712.4 4727.5 4729.2 4729.7 4636.1 4648.0 4651.7 4658.3 4673.3 4642.6 4657.1 4673.1 4678.9 4682.0 4006.9 4025.8 4032.5 4034.4 4035.3 5758.6 5780.7 5873.3 5898.3 5907.7 5482.8 5498.4 5507.7 5511.2 5514.6 6650.3 6656.3 6658.4 6669.1 6672.0 4473.8 4543.0 4544.3 4545.3 4546.1 6812.3 6898.2 6909.3 6917.1 6924.6 4627.9 4654.0 4659.0 4659.6 4664.6 4676.8 4682.6 4700.4 4721.7 4728.4 5344.2 5471.9 5480.8 5482.2 5496.9 6682.5 6686.2 6694.9 6711.3 6719.2 1634.8 1683.5 1690.6 1691.8 1695.3 1054.9 1091.5 1092.4 1095.7 1116.3 6390.2 6404.2 6410.3 6424.1 6427.7 6830.0 6859.8 6886.8 6896.3 6896.4 6301.4 6361.2 6396.5 6401.6 6409.6 3739.5 3773.8 3779.4 3804.8 3806.2 7152.7 7250.1 7251.3 7278.5 7288.1 7058.8 7064.2 7089.1 7091.8 7096.9 7217.1 7241.5 7257.5 7264.2 7264.8 6822.3 6961.3 6965.9 6975.8 6997.1 6864.3 6881.3 6906.5 6907.1 6908.7 7117.5 7240.3 7249.7 7272.5 7278.8 4497.6 4533.7 4535.0 4537.2 4540.1 6870.5 6932.5 6949.1 6950.0 6952.4 6615.6 6744.6 6752.5 6757.7 6782.0 6738.3 6740.2 6742.1 6757.8 6769.4 6618.7 6619.1 6629.9 6639.2 6639.5 6605.7 6752.5 6770.7 6784.0 6789.7 6600.8 6610.4 6635.9 6642.5 6647.3 09:20:55 INFO - 2015-11-12 09:20:55,979 DEBUG : BROWSER_OUTPUT: 09:20:55 INFO - 2015-11-12 09:20:55,979 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13835.49 Median:23396.46 stddev:16188.81 (69.2%) stddev-sans-first:16204.44 09:20:55 INFO - 2015-11-12 09:20:55,981 DEBUG : BROWSER_OUTPUT: Values: 758.4 783.3 856.3 859.3 891.9 10967.8 11173.0 11220.1 11231.2 11284.8 14038.0 14069.2 14096.5 14139.2 14151.6 803.8 804.0 817.6 818.1 820.1 810.8 816.3 818.5 820.7 821.2 771.3 775.5 778.6 779.4 779.7 768.8 769.9 771.7 773.6 777.7 560.1 561.0 561.3 563.6 565.5 13311.0 13425.3 13448.3 13450.5 13452.1 10019.6 10099.3 10126.4 10355.3 10569.7 10279.2 10396.8 10742.0 11225.2 11385.4 3615.9 3643.1 3646.4 3818.6 3857.9 47576.0 48564.8 48626.0 48652.5 48899.5 10281.4 10385.2 10563.0 10726.2 10797.1 19045.3 19172.5 19184.6 19207.3 19249.7 7895.2 8144.1 8311.8 8329.1 8378.4 4356.8 4496.4 4522.7 4535.3 4607.6 3212.2 3222.8 3260.6 3274.0 3276.0 471.4 477.7 486.5 489.7 492.1 572.5 636.9 657.8 675.9 686.6 8537.7 8659.5 8693.5 8716.5 8853.3 650.4 670.7 683.3 697.8 705.9 3832.4 3978.8 4140.9 4245.7 4271.1 56584.0 57064.0 57562.7 57772.4 58171.1 50313.7 50780.2 50968.0 51269.7 51566.2 48431.3 48719.5 49956.8 50142.7 50562.5 8379.2 8648.0 8756.6 9056.4 9063.9 35395.6 35422.1 36491.6 37109.4 37132.4 41126.2 42203.2 43202.4 46321.5 48235.5 7410.4 7508.6 7539.7 7629.8 7647.7 11740.8 12073.7 12126.3 12161.7 12167.8 11421.5 11535.4 11630.2 11768.3 12046.3 10791.5 10998.8 11039.8 11108.4 11395.2 11327.9 11462.3 11678.3 11729.6 11953.9 9970.3 10040.5 10189.5 10236.0 10442.6 9439.6 9538.1 10036.9 10123.4 10232.2 09:20:55 INFO - 2015-11-12 09:20:55,981 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:20:55 INFO - 2015-11-12 09:20:55,981 DEBUG : BROWSER_OUTPUT: 09:20:56 INFO - 2015-11-12 09:20:56,573 INFO : Browser exited with error code: 0 09:20:56 INFO - 2015-11-12 09:20:56,595 INFO : Completed test dromaeo_css (00:18:31) 09:20:56 INFO - 2015-11-12 09:20:56,595 INFO : Starting test kraken 09:20:56 INFO - 2015-11-12 09:20:56,595 DEBUG : operating with platform_type : linux_ 09:20:56 INFO - 2015-11-12 09:20:56,595 INFO : Initialising browser for kraken test... 09:20:56 INFO - 2015-11-12 09:20:56,601 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZz412P/profile http://localhost:35691/getInfo.html 09:21:01 INFO - 2015-11-12 09:21:01,374 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:21:01 INFO - 2015-11-12 09:21:01,375 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:21:01 INFO - 2015-11-12 09:21:01,375 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:21:01 INFO - 2015-11-12 09:21:01,375 DEBUG : BROWSER_OUTPUT: __metrics 09:21:02 INFO - 2015-11-12 09:21:02,425 INFO : Browser initialized. 09:21:02 INFO - 2015-11-12 09:21:02,426 INFO : Running cycle 1/1 for kraken test... 09:21:02 INFO - 2015-11-12 09:21:02,426 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZz412P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:21:14 INFO - 2015-11-12 09:21:14,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 09:21:14 INFO - 2015-11-12 09:21:14,214 DEBUG : BROWSER_OUTPUT: 09:21:16 INFO - 2015-11-12 09:21:16,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35691/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:17 INFO - 2015-11-12 09:21:17,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 141639680 09:21:17 INFO - 2015-11-12 09:21:17,289 DEBUG : BROWSER_OUTPUT: 09:21:19 INFO - 2015-11-12 09:21:19,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35691/tests/kraken/driver.html?testName=audio-dft) 09:21:20 INFO - 2015-11-12 09:21:20,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 141029376 09:21:20 INFO - 2015-11-12 09:21:20,485 DEBUG : BROWSER_OUTPUT: 09:21:23 INFO - 2015-11-12 09:21:23,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35691/tests/kraken/driver.html?testName=audio-fft) 09:21:23 INFO - 2015-11-12 09:21:23,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 136712192 09:21:23 INFO - 2015-11-12 09:21:23,946 DEBUG : BROWSER_OUTPUT: 09:21:25 INFO - 2015-11-12 09:21:25,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35691/tests/kraken/driver.html?testName=audio-oscillator) 09:21:26 INFO - 2015-11-12 09:21:26,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 137306112 09:21:26 INFO - 2015-11-12 09:21:26,505 DEBUG : BROWSER_OUTPUT: 09:21:28 INFO - 2015-11-12 09:21:28,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35691/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:29 INFO - 2015-11-12 09:21:29,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 137498624 09:21:29 INFO - 2015-11-12 09:21:29,272 DEBUG : BROWSER_OUTPUT: 09:21:32 INFO - 2015-11-12 09:21:32,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35691/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:32 INFO - 2015-11-12 09:21:32,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 136851456 09:21:32 INFO - 2015-11-12 09:21:32,858 DEBUG : BROWSER_OUTPUT: 09:21:36 INFO - 2015-11-12 09:21:36,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35691/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:36 INFO - 2015-11-12 09:21:36,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 138485760 09:21:36 INFO - 2015-11-12 09:21:36,841 DEBUG : BROWSER_OUTPUT: 09:21:39 INFO - 2015-11-12 09:21:39,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35691/tests/kraken/driver.html?testName=json-parse-financial) 09:21:40 INFO - 2015-11-12 09:21:40,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 138657792 09:21:40 INFO - 2015-11-12 09:21:40,334 DEBUG : BROWSER_OUTPUT: 09:21:41 INFO - 2015-11-12 09:21:41,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35691/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:42 INFO - 2015-11-12 09:21:42,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 139030528 09:21:42 INFO - 2015-11-12 09:21:42,488 DEBUG : BROWSER_OUTPUT: 09:21:44 INFO - 2015-11-12 09:21:44,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:44 INFO - 2015-11-12 09:21:44,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 09:21:44 INFO - 2015-11-12 09:21:44,925 DEBUG : BROWSER_OUTPUT: 09:21:47 INFO - 2015-11-12 09:21:47,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:47 INFO - 2015-11-12 09:21:47,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 139321344 09:21:47 INFO - 2015-11-12 09:21:47,613 DEBUG : BROWSER_OUTPUT: 09:21:50 INFO - 2015-11-12 09:21:50,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:50 INFO - 2015-11-12 09:21:50,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 139423744 09:21:50 INFO - 2015-11-12 09:21:50,682 DEBUG : BROWSER_OUTPUT: 09:21:53 INFO - 2015-11-12 09:21:53,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:53 INFO - 2015-11-12 09:21:53,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 09:21:53 INFO - 2015-11-12 09:21:53,830 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35691/tests/kraken/driver.html?testName=ai-astar) 09:21:55 INFO - 2015-11-12 09:21:55,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 138858496 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:21:55 INFO - 2015-11-12 09:21:55,771 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;111;111;110;121;110;111;112;110 09:21:55 INFO - 2015-11-12 09:21:55,772 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;126;149;166;127;153;146;126;167;126 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;162;163;163;164;167;174;164 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;73;73;149;73;71;73;72 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;141;89;91;90;134;91;91;132 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;109;109;110;109;111;110;110 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;146;147;146;147;148;147;148 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;97;97;97;96;96 09:21:55 INFO - 2015-11-12 09:21:55,773 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;62;60;62;62;62;61;59;60 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;67;67;67;68;68;67;67;67 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;94;87;94;91;86;87;86 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;117;134;119;118;127;121;126;125;124 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;149;151;152;150;144;140;148;155;149 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;66;70;68;68;70;66;69;67;66 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,747 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:21:55 INFO - 2015-11-12 09:21:55,774 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348915770__endTimestamp 09:21:55 INFO - 2015-11-12 09:21:55,775 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.63 (3.3%) stddev-sans-first:3.84 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 111.0 111.0 110.0 121.0 110.0 111.0 112.0 110.0 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.70 Median:150.00 stddev:16.44 (11.0%) stddev-sans-first:17.22 09:21:55 INFO - 2015-11-12 09:21:55,776 DEBUG : BROWSER_OUTPUT: Values: 151.0 126.0 149.0 166.0 127.0 153.0 146.0 126.0 167.0 126.0 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.60 (2.2%) stddev-sans-first:3.81 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 162.0 163.0 163.0 164.0 167.0 174.0 164.0 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:24.18 (33.1%) stddev-sans-first:25.51 09:21:55 INFO - 2015-11-12 09:21:55,777 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 73.0 73.0 149.0 73.0 71.0 73.0 72.0 09:21:55 INFO - 2015-11-12 09:21:55,778 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,778 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:91.00 stddev:21.91 (24.1%) stddev-sans-first:22.72 09:21:55 INFO - 2015-11-12 09:21:55,778 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 141.0 89.0 91.0 90.0 134.0 91.0 91.0 132.0 09:21:55 INFO - 2015-11-12 09:21:55,778 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,778 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 09:21:55 INFO - 2015-11-12 09:21:55,779 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 109.0 109.0 110.0 109.0 111.0 110.0 110.0 09:21:55 INFO - 2015-11-12 09:21:55,779 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,779 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 09:21:55 INFO - 2015-11-12 09:21:55,779 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 146.0 147.0 146.0 147.0 148.0 147.0 148.0 09:21:55 INFO - 2015-11-12 09:21:55,779 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 96.0 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.50 stddev:1.10 (1.8%) stddev-sans-first:1.17 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 62.0 60.0 62.0 62.0 62.0 61.0 59.0 60.0 09:21:55 INFO - 2015-11-12 09:21:55,780 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,781 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 09:21:55 INFO - 2015-11-12 09:21:55,781 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 67.0 09:21:55 INFO - 2015-11-12 09:21:55,781 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,781 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:87.00 stddev:3.46 (4.0%) stddev-sans-first:3.47 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 94.0 87.0 94.0 91.0 86.0 87.0 86.0 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.50 stddev:5.06 (4.1%) stddev-sans-first:5.36 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: Values: 123.0 117.0 134.0 119.0 118.0 127.0 121.0 126.0 125.0 124.0 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,782 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.50 stddev:5.17 (3.5%) stddev-sans-first:4.42 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: Values: 139.0 149.0 151.0 152.0 150.0 144.0 140.0 148.0 155.0 149.0 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.64 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: Values: 70.0 66.0 70.0 68.0 68.0 70.0 66.0 69.0 67.0 66.0 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:21:55 INFO - 2015-11-12 09:21:55,783 DEBUG : BROWSER_OUTPUT: 09:21:56 INFO - 2015-11-12 09:21:56,665 INFO : Browser exited with error code: 0 09:21:56 INFO - 2015-11-12 09:21:56,714 INFO : Completed test kraken (00:01:00) 09:21:56 INFO - 2015-11-12 09:21:56,714 INFO : Starting test v8_7 09:21:56 INFO - 2015-11-12 09:21:56,714 DEBUG : operating with platform_type : linux_ 09:21:56 INFO - 2015-11-12 09:21:56,714 INFO : Initialising browser for v8_7 test... 09:21:56 INFO - 2015-11-12 09:21:56,720 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUE9s4v/profile http://localhost:35691/getInfo.html 09:22:01 INFO - 2015-11-12 09:22:01,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:22:01 INFO - 2015-11-12 09:22:01,523 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:22:01 INFO - 2015-11-12 09:22:01,523 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:22:01 INFO - 2015-11-12 09:22:01,523 DEBUG : BROWSER_OUTPUT: __metrics 09:22:02 INFO - 2015-11-12 09:22:02,621 INFO : Browser initialized. 09:22:02 INFO - 2015-11-12 09:22:02,622 INFO : Running cycle 1/1 for v8_7 test... 09:22:02 INFO - 2015-11-12 09:22:02,622 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUE9s4v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:22:14 INFO - 2015-11-12 09:22:14,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 141066240 09:22:14 INFO - 2015-11-12 09:22:14,396 DEBUG : BROWSER_OUTPUT: 09:22:35 INFO - 2015-11-12 09:22:35,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35691/tests/v8_7/run.html (next: http://localhost:35691/tests/v8_7/run.html) 09:22:36 INFO - 2015-11-12 09:22:36,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 136777728 09:22:36 INFO - 2015-11-12 09:22:36,082 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,083 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:36 INFO - 2015-11-12 09:22:36,083 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |0;Richards;161.57699143641946 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.27773527161438 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.135788585887 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 09:22:36 INFO - 2015-11-12 09:22:36,084 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1048.2180293501049 09:22:36 INFO - 2015-11-12 09:22:36,085 DEBUG : BROWSER_OUTPUT: |5;Earley;723.589001447178 09:22:36 INFO - 2015-11-12 09:22:36,085 DEBUG : BROWSER_OUTPUT: |6;Boyer;11651.162790697674 09:22:36 INFO - 2015-11-12 09:22:36,085 DEBUG : BROWSER_OUTPUT: |7;RegExp;24804.878048780487 09:22:36 INFO - 2015-11-12 09:22:36,085 DEBUG : BROWSER_OUTPUT: |8;Splay;913.2420091324201 09:22:36 INFO - 2015-11-12 09:22:36,085 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 09:22:36 INFO - 2015-11-12 09:22:36,086 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:36 INFO - 2015-11-12 09:22:36,086 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348956083__endTimestamp 09:22:36 INFO - 2015-11-12 09:22:36,086 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,086 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:36 INFO - 2015-11-12 09:22:36,087 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:22:36 INFO - 2015-11-12 09:22:36,087 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,087 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:161.58 Median:161.58 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,087 DEBUG : BROWSER_OUTPUT: Values: 161.6 09:22:36 INFO - 2015-11-12 09:22:36,088 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,088 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.28 Median:191.28 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,088 DEBUG : BROWSER_OUTPUT: Values: 191.3 09:22:36 INFO - 2015-11-12 09:22:36,088 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,088 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.14 Median:281.14 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,089 DEBUG : BROWSER_OUTPUT: Values: 281.1 09:22:36 INFO - 2015-11-12 09:22:36,089 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,089 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,090 DEBUG : BROWSER_OUTPUT: Values: 5060.6 09:22:36 INFO - 2015-11-12 09:22:36,091 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,091 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1048.22 Median:1048.22 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,091 DEBUG : BROWSER_OUTPUT: Values: 1048.2 09:22:36 INFO - 2015-11-12 09:22:36,091 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,091 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: Values: 723.6 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11651.16 Median:11651.16 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: Values: 11651.2 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24804.88 Median:24804.88 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,092 DEBUG : BROWSER_OUTPUT: Values: 24804.9 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:913.24 Median:913.24 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: Values: 913.2 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: Values: 4830.9 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:36 INFO - 2015-11-12 09:22:36,093 DEBUG : BROWSER_OUTPUT: 09:22:36 INFO - 2015-11-12 09:22:36,941 INFO : Browser exited with error code: 0 09:22:36 INFO - 2015-11-12 09:22:36,958 INFO : Completed test v8_7 (00:00:40) 09:22:37 INFO - 2015-11-12 09:22:37,115 INFO : Completed test suite (00:20:11) 09:22:37 INFO - 2015-11-12 09:22:37,115 DEBUG : Working with test: dromaeo_css 09:22:37 INFO - 2015-11-12 09:22:37,115 DEBUG : Generating results file: dromaeo_css 09:22:37 INFO - 2015-11-12 09:22:37,117 DEBUG : Working with test: kraken 09:22:37 INFO - 2015-11-12 09:22:37,117 DEBUG : Generating results file: kraken 09:22:37 INFO - 2015-11-12 09:22:37,117 INFO : javascript benchmark 09:22:37 INFO - 2015-11-12 09:22:37,118 DEBUG : Working with test: v8_7 09:22:37 INFO - 2015-11-12 09:22:37,118 DEBUG : Generating results file: v8_7 09:22:37 INFO - 2015-11-12 09:22:37,118 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:37 INFO - 2015-11-12 09:22:37,167 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 09:22:37 INFO - 2015-11-12 09:22:37,167 DEBUG : process_Request line: dromaeo_css 6774.99 graph.html#tests=[[72,63,43]] 09:22:37 INFO - 2015-11-12 09:22:37,167 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:37 INFO - 2015-11-12 09:22:37,201 DEBUG : process_Request line: kraken 1512.70 graph.html#tests=[[232,63,43]] 09:22:37 INFO - 2015-11-12 09:22:37,201 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:37 INFO - 2015-11-12 09:22:37,233 DEBUG : process_Request line: v8_7 20730.92 graph.html#tests=[[230,63,43]] 09:22:37 INFO - 2015-11-12 09:22:37,235 INFO : javascript benchmark 09:22:37 INFO - 2015-11-12 09:22:37,239 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [326.8970274363577, 330.84284964641785, 338.8966365258596, 340.93863104641156, 341.5116383571493, 14074.718505629908, 14519.201443920607, 16681.58296042598, 16965.491035268948, 17658.11709414529, 14851.405943762236, 15060.096394216327, 15113.92443037786, 15435.3825846966, 15445.382184712626, 5085.440601533828, 5146.382434107903, 5198.116320225552, 5242.528172464477, 5255.605829562779, 5201.141811601081, 5232.816851410202, 5261.053010458116, 5265.65773224741, 5270.947290527103, 5091.66904151229, 5195.402528709209, 5199.922001169985, 5281.128613778722, 5285.0, 5227.268182454441, 5255.290535777678, 5264.2893209416625, 5266.078436273637, 5289.550388217006, 3958.5645578986578, 4055.7363771355062, 4095.9385609215888, 4606.9078618427775, 4647.976760116211, 13500.257485838274, 13509.324533773271, 13788.448462061506, 13803.447862085604, 13817.792733109012, 1999.7100420438956, 2044.3866839948105, 2067.235123004483, 2071.5856828634332, 2112.746470423559, 9476.0, 9535.713928582154, 9595.13643772064, 9598.568064437117, 9752.366096203725, 1671.8746094042995, 1706.5051135170909, 1732.4975757030445, 1739.20866005967, 1753.0183097465333, 57657.42342576604, 59799.40200597982, 60157.6992115041, 60215.698921505114, 60378.69810650919, 6623.370779775913, 6732.225794033651, 6785.1518560179975, 6789.049533065375, 6856.211535673461, 7869.3311068559815, 8127.349812015024, 8137.674493020331, 8154.836903261901, 8158.755237342889, 4907.828226012072, 4927.901441971212, 4948.802047918043, 4956.925646115311, 5045.369328833895, 4877.487863774323, 5068.087744206005, 5069.898602027939, 5104.846854594368, 5124.538791508708, 3115.7818952673547, 3241.2383089973837, 3262.2659901522443, 3264.5919260092487, 3273.2962413080827, 1097.5938902606088, 1100.5157730598512, 1112.054753459553, 1112.2603468693228, 1157.785809625222, 426.45413870246136, 433.9761313127808, 441.3225698552706, 456.5936316678159, 462.03434821223806, 11121.27711698737, 11640.534378624929, 11894.881051189377, 11946.776824869501, 12099.637010889688, 455.3210062693429, 456.0969280823921, 457.7162159461089, 462.2834606360128, 465.6554149929096, 6199.473044791153, 6502.934970650327, 6522.086907832907, 6551.672416379257, 6647.567908085959, 532108.0, 544544.0, 548672.0, 552960.0, 557366.0, 70639.64680176566, 75724.0, 76628.0, 76828.61585692035, 79682.0, 499.9925001124986, 505.0429436218346, 509.5006893244567, 509.8597885581495, 510.316176323728, 10579.10077643409, 10656.62701805433, 10713.732156695833, 10803.135749139892, 10834.891651083388, 31778.364432711678, 32051.67948320487, 32370.0, 34405.0, 36094.278114438086, 41722.0, 43751.0, 45794.0, 46748.29877551772, 47681.0, 6400.0, 6481.449076828334, 6581.539292249497, 6587.4071333580205, 6601.438877695449, 12091.516339346328, 12234.632961011184, 12294.631161065183, 12364.81452778227, 12472.0, 10326.070653641209, 10591.47042647849, 10860.891391085988, 10879.0, 10958.671239862499, 10341.896581034094, 10599.735006624587, 10750.946245269037, 10795.56817727282, 10860.945695271474, 10355.741106472398, 10568.048875601233, 10573.312734672221, 10743.0, 10826.67519974402, 6450.354964503512, 6480.384363485461, 6494.285628580947, 6508.576942498722, 6528.902066469102, 10109.0, 10153.746156346151, 10524.31591946521, 10563.1021363185, 10704.357738535713], "dojo.html": [3256.0882952773222, 3272.1165285372936, 3310.089725325534, 3320.4521253993094, 3325.501174823776, 5345.839624811252, 5427.837164885055, 5457.890842183154, 5470.206820011096, 5487.176923461483, 5537.058700020996, 5559.555235581154, 5576.079946808772, 5613.915791263134, 5714.742836572354, 5014.9498505014935, 5128.410232823236, 5132.666376685522, 5185.766640501168, 5207.739613019353, 4963.379577552806, 5038.89144388234, 5059.215821547666, 5081.339425874649, 5096.210087436453, 4928.728919909404, 4997.30037794709, 5061.8734531637, 5074.873128171788, 5136.640435169521, 5014.799408023675, 5025.773840177201, 5027.572656324217, 5031.0441016206805, 5084.161113416282, 4940.827071052532, 5022.271770593244, 5036.445990940993, 5036.773345199438, 5037.194048952187, 5324.54741346986, 5376.596755243372, 5392.865178370533, 5408.810691625774, 5460.945390546123, 6058.333583305833, 6085.756569737206, 6115.388461153893, 6122.418370254819, 6123.969380153116, 5906.645601263938, 6024.246969128859, 6115.5413343998935, 6148.0, 6154.599951003215, 5554.666719996772, 5609.66342019472, 5616.803411880605, 5621.7751289948355, 5656.038473459522, 6071.939280607226, 6086.878262434815, 6095.908561371583, 6097.847553811191, 6099.75600975956, 5777.480026797609, 5815.41845815415, 5896.380880007538, 5915.349311575723, 5930.8813823723285, 6084.5132389408745, 6086.056661217518, 6089.117078023751, 6100.908486372619, 6115.021596544531, 6041.969790151021, 6043.002904520705, 6045.0, 6047.092936059538, 6052.576319657582, 5802.216700745345, 5894.852628684317, 5908.468237858613, 6019.0, 6066.393360663898, 4455.2648812946145, 4551.180787458289, 4569.520200378979, 4616.422947131608, 4625.051864367797, 4059.167870586523, 4088.304988151962, 4089.20260549196, 4120.17596480705, 4129.566395528426, 5487.917681234785, 5589.161625756169, 5661.886762264814, 5751.309842818805, 5771.163181338682, 6014.669193194329, 6052.878942421127, 6097.298810636834, 6097.359777223328, 6100.298465676504, 5474.808381706621, 5710.65736055838, 5710.71446427677, 5727.914081288784, 5736.311642602915, 5056.696598204119, 5093.465186155475, 5127.846164615067, 5129.538341549279, 5169.922451163236, 6117.694115294217, 6128.754849806047, 6143.139960405458, 6145.10895920098, 6207.937920620826, 5750.367459579359, 5898.469137777621, 6032.185654936703, 6035.36628653985, 6040.124181993674, 6126.081087836682, 6171.259448866164, 6216.7824126155365, 6233.096201050732, 6233.470155036873, 6015.0, 6048.810596369348, 6055.182550355822, 6073.696315184135, 6109.969450152721, 5901.704914754331, 6057.363976782551, 6067.211262535842, 6114.052321890114, 6146.200993870768, 5776.56675749312, 5823.155642431739, 5833.358330583547, 5842.941570584409, 5886.440788125121, 5843.211166492639, 5903.940960590339, 5927.081302398135, 5945.940540594712, 5947.672877991752, 5538.363088244742, 5641.774329026793, 5723.742431590672, 5781.739821708117, 5857.7949771757785, 5851.882962340645, 5877.206577112206, 5878.2358293421585, 5885.176075349369, 5918.763249470146, 5720.256366672306, 5752.453516915886, 5757.481826635623, 5757.884842303214, 5758.568107391879], "mootools.html": [1457.4097490516342, 1460.700556385941, 1606.172820997186, 1753.4301352060584, 1766.549529869883, 6687.130673012513, 6763.932360676392, 7441.441891858112, 7827.960860195705, 7828.725994590191, 7325.780226593198, 7547.924520754791, 7591.886121708165, 7595.354394876428, 7601.467897247181, 2258.5482903419343, 2275.670027845961, 2296.1848543766973, 2299.4251437140715, 2307.157887371106, 2277.1802151225547, 2305.6772051912744, 2318.026428899858, 2323.163661082009, 2325.5813953488364, 2314.3866875278063, 2321.350021993836, 2327.6043072677685, 2327.976720232801, 2342.4261056041296, 2271.216430331533, 2314.4329639238326, 2339.0526836631193, 2339.2748248043163, 2344.0623750499853, 2294.070901284982, 2321.1063740460045, 2328.988355058231, 2330.766923307656, 2338.2050102964904, 7665.540067595962, 7673.079230492321, 7691.077070751546, 7699.538027718355, 7711.961440192819, 4366.410534577855, 4490.191765482212, 4549.886252843672, 4555.407796986404, 4560.589546940758, 2930.721581449759, 2945.527236381809, 2950.1444581071464, 2959.4377068356944, 2970.064429704658, 908.8318661047728, 928.5403725156024, 928.7445952363087, 930.6230976454547, 950.7100334398006, 10222.233332500093, 10330.845037324447, 10348.79302413955, 10364.48177591125, 10369.79260414795, 4123.443335149776, 4143.854965076208, 4193.182329445729, 4194.307939189999, 4219.746815191037, 8486.0665326814, 8489.151084891462, 8489.61796719149, 8500.27747641445, 8502.957485212535, 4543.1822271990695, 4551.499335073139, 4554.4990051094355, 4573.222552166139, 4586.220342541776, 4157.792110394529, 4184.81168347419, 4199.9370009449885, 4202.516710578261, 4211.073563815956, 3518.683318501347, 3525.629808870083, 3527.6825085742407, 3527.894163175109, 3581.659742324475, 1107.0368779162181, 1107.3134656513014, 1122.231271578971, 1124.8087825069758, 1131.185546406586, 1303.485123376261, 1304.2630913533824, 1314.9276789776654, 1319.1755153029358, 1352.7970804379224, 7199.964000179965, 7224.277572242734, 7353.522021068614, 7360.2271761465345, 7363.447741419415, 475.916714574948, 482.8599706085196, 483.0242909323148, 483.97822098005673, 484.3799936081821, 5634.098544232985, 5635.859103522363, 5650.491455769001, 5688.943110568925, 5696.572757043238, 8612.741617751477, 8625.439346442587, 8628.482291062432, 8681.739547813575, 8749.343799215085, 8565.95717021411, 8602.967643882774, 8674.522901240367, 8678.783030424163, 8680.95659521711, 7027.121609798775, 7141.321574450419, 7141.714331426789, 7145.39264162552, 7159.176694680178, 7116.928830711627, 7118.145822501333, 7151.82120446993, 7194.928050719426, 7220.602866842374, 7896.486728362638, 7898.131205567268, 8058.83882322362, 8136.22705842944, 8195.303399210896, 8126.065502467056, 8162.347012238888, 8184.345252379914, 8260.091389947222, 8264.83470330602, 6696.1629796275465, 6987.336203060701, 6987.441004719712, 6994.160700715743, 7007.614581198083, 7464.850702986018, 7490.662920168496, 7491.775246742606, 7507.174210836913, 7509.286617771303, 6423.710933007932, 6544.280129185881, 6563.34366563359, 6637.137172167587, 6667.2666006738245, 6929.861402772017, 6939.548929319578, 6978.267281935324, 6993.0, 7046.0, 6957.860842783217, 6976.127984002, 6976.930230697831, 6991.44068474531, 7011.754588589375, 6478.255000674794, 6519.348065193442, 6522.934770652233, 6524.836879077871, 6525.510586705921, 6562.442192413699, 6588.308227636221, 6608.372204640552, 6623.834404139935, 6663.300353463011], "ext.html": [537.1325309624957, 581.3053401185583, 589.1810383566841, 590.1767034986198, 591.9970400147998, 31125.221869453275, 39678.60321396785, 39832.800835995855, 39874.80062599683, 40148.39777403334, 43320.783396083054, 43786.12427751443, 43959.340609890874, 44067.0, 44169.0, 8779.165979231979, 8889.377743557954, 8892.911070889273, 8944.418612790181, 8965.058668839743, 8715.607797649089, 8878.73363799087, 8890.644374225023, 8906.376553641248, 8910.376273660846, 8780.473171609723, 8854.114588541159, 8859.822803543926, 8863.379563430562, 8909.821803563926, 8666.263367613761, 8802.779930501725, 8826.911730882704, 8828.249598784143, 8850.424722393089, 8718.607662655133, 8772.429792063496, 8810.779730506725, 8845.867311990325, 8876.0, 40254.0, 40572.59427405718, 40622.593774062174, 40660.39009414861, 40884.0, 3265.510173473998, 3522.6477352264824, 3524.4537096750046, 3576.3741345264734, 3721.9441708374397, 31996.0, 32757.6724232757, 32780.0, 32943.3411331772, 33224.6677533224, 3207.9839600801847, 3239.864898327098, 3251.154699778051, 3288.391647545188, 3393.4400823864034, 279904.0, 280312.0, 280384.59807701036, 280720.0, 280835.0, 53116.73441632767, 54159.72920135453, 60752.0, 61074.38925610687, 66818.0, 63800.36199638037, 63822.36177638257, 64071.0, 64231.67884160643, 64285.67857160778, 12270.325132117641, 12359.3820308986, 12367.196132251374, 12441.25352478836, 12517.248965061943, 9670.56482458291, 9781.510924453749, 9787.608495660093, 9793.706188814347, 9821.165200957856, 20550.794492054887, 20580.176792928116, 20679.896600516902, 20816.583668326548, 20935.79064209369, 8059.677612895419, 8355.582220888931, 8410.285125764256, 8442.704505342284, 8472.068072512018, 895.7268033249921, 919.4207649181106, 1044.5143008501084, 1068.647346375694, 1078.2613909472036, 27893.860530697217, 28688.0, 28760.0, 28995.565066524017, 29140.854295728386, 1009.6970908727352, 1054.383185836279, 1093.5844379135876, 1146.696125526736, 1171.5021116025655, 14618.561443156723, 14962.850371496363, 14977.775333370008, 15033.548993529992, 15182.240887955779, 312645.0, 315233.0, 315461.0, 316188.0, 316195.0, 51575.484245157815, 51897.48102518926, 52033.21950170751, 52279.21581176286, 52369.21446178311, 1281.3401098434315, 1288.2721262486666, 1309.1032642639823, 1314.901382396305, 1319.162331919238, 27109.72890271151, 28135.0, 28198.85900570484, 32799.344013120084, 33070.33859322752, 50488.74755626198, 50880.74559627178, 51150.488495116064, 51320.48679513157, 51445.22832157595, 299039.0, 301335.0, 302242.0, 303076.0, 303399.0, 42170.57829421666, 46348.53651463442, 46812.29781553348, 47292.0, 47464.0, 43550.56449435465, 43760.0, 43783.34324985192, 44037.559624403344, 44517.0, 36561.634383656885, 37569.62430375661, 41046.179076417706, 42043.36934945917, 42820.35769463398, 36762.0, 39558.0, 40626.796866016666, 40778.0, 41172.79413602913, 39229.803850981705, 39607.20785584215, 43082.0, 43555.34666979934, 43777.78111109424, 38082.0, 39548.209035819695, 39575.80212098921, 39670.80164599274, 39874.0, 27347.31631709223, 27513.862430687717, 27745.445091098467, 28039.579406308512, 28166.564200992896], "prototype.html": [290.59316956261233, 298.86401687232313, 299.0922550060566, 303.80556443875923, 307.04508977081287, 6194.0, 6206.875862482753, 6229.968850155754, 6269.7492100315985, 6423.7430502779835, 6235.282942461618, 6333.145025421578, 6340.651264180468, 6346.968265158668, 6347.61914285142, 4605.769711514427, 4690.812367505296, 4694.38972933519, 4704.882377940562, 4707.223308154151, 4709.670323077386, 4712.410948631421, 4727.534464316073, 4729.2433210686295, 4729.716217026972, 4636.072785442908, 4648.0471503341905, 4651.7441540715245, 4658.347831303603, 4673.3223682566, 4642.558956899106, 4657.06858628274, 4673.1121086993535, 4678.929816052728, 4682.0, 4006.939895901564, 4025.81883815229, 4032.475778148851, 4034.435179074932, 4035.273650742865, 5758.596898217126, 5780.739866706008, 5873.3245676746865, 5898.321693005317, 5907.6750778707155, 5482.80810171646, 5498.395176530578, 5507.7246137693355, 5511.173324001392, 5514.5864060195645, 6650.268470468244, 6656.334366563305, 6658.400743933069, 6669.099671544376, 6672.0, 4473.843415480443, 4542.954570454319, 4544.272916333371, 4545.2954792007295, 4546.113507865967, 6812.284710105417, 6898.172219333712, 6909.343612356818, 6917.100776898971, 6924.58452492852, 4627.930581041287, 4653.95346046542, 4659.044895796422, 4659.627229821606, 4664.580187783048, 4676.836310729108, 4682.578567928903, 4700.412448443944, 4721.669483136147, 4728.38530990969, 5344.198370244494, 5471.917921231185, 5480.835574932758, 5482.150266708666, 5496.890062198813, 6682.532222744361, 6686.197656281277, 6694.866102677919, 6711.261761206263, 6719.227288861844, 1634.7547867819922, 1683.4865366063223, 1690.6365131496786, 1691.8223586523484, 1695.262560786062, 1054.8997845204694, 1091.4815462655176, 1092.4046394714899, 1095.6712986104296, 1116.2576886370473, 6390.169277993831, 6404.199475065617, 6410.326915673787, 6424.100625912376, 6427.742890284337, 6830.043793868862, 6859.828504287433, 6886.793396198122, 6896.27589103147, 6896.413804826646, 6301.369863013753, 6361.236651601837, 6396.488280937514, 6401.647909364937, 6409.615423074631, 3739.495168152319, 3773.754705944105, 3779.3764028934916, 3804.7907365094634, 3806.1626442182674, 7152.713891444388, 7250.057492525938, 7251.274872512812, 7278.454115941219, 7288.08898887639, 7058.788236352918, 7064.1876184238445, 7089.113860767404, 7091.787246382617, 7096.935459681089, 7217.061781968416, 7241.5293005954445, 7257.52826066304, 7264.23725508814, 7264.782056538206, 6822.317768223138, 6961.269066747918, 6965.930340696731, 6975.755848545276, 6997.090378250795, 6864.279250678806, 6881.346272104142, 6906.5496245786935, 6907.13660792401, 6908.689108990007, 7117.537360071578, 7240.312170343809, 7249.710011599688, 7272.490925635155, 7278.781636550912, 4497.572730590588, 4533.727976321431, 4535.0, 4537.1833070047705, 4540.0919816037585, 6870.45036397077, 6932.549384290005, 6949.061876646588, 6949.965250173919, 6952.44380449573, 6615.6030638161865, 6744.5616034957575, 6752.527323087534, 6757.695903684247, 6782.0, 6738.326167383222, 6740.191177058784, 6742.123523941857, 6757.831054223684, 6769.356911093439, 6618.669066546557, 6619.0733297339375, 6629.900551491828, 6639.203295604559, 6639.502037347122, 6605.669716514251, 6752.501574417497, 6770.729170833309, 6783.982402639644, 6789.660516974032, 6600.768973085919, 6610.438112760469, 6635.933640663531, 6642.4686025118845, 6647.302033286629], "yui.html": [758.3970743259108, 783.2598194706003, 856.3320609924253, 859.3383095016837, 891.8929728432589, 10967.780644387107, 11173.0, 11220.102391808656, 11231.157663175274, 11284.830727539094, 14038.0, 14069.226192559405, 14096.506622268224, 14139.151650900953, 14151.646208844784, 803.8392321535687, 803.9799005024877, 817.5503473089807, 818.1082619944259, 820.1142765812908, 810.7608255564622, 816.2735165702529, 818.4925346285312, 820.6512232301278, 821.1829229916212, 771.2827070824131, 775.5385545600387, 778.622368151446, 779.4193325972159, 779.742684913977, 768.8462307538487, 769.9422543309219, 771.6758961236238, 773.5590713293396, 777.6617171530374, 560.1262031231292, 561.0462214235815, 561.2703485468874, 563.5745012515565, 565.4854082784647, 13311.0, 13425.261610611413, 13448.260345680983, 13450.529231476949, 13452.05835591509, 10019.59921603135, 10099.29304948654, 10126.443045632488, 10355.27513074085, 10569.73575660607, 10279.229057820694, 10396.844047339297, 10742.033217010428, 11225.158113141548, 11385.430728463543, 3615.891523254307, 3643.125649844045, 3646.4348026056005, 3818.618138186187, 3857.9228415431535, 47576.0, 48564.75717621389, 48626.0, 48652.513474865154, 48899.51100488985, 10281.434521101412, 10385.2211084169, 10563.0, 10726.249162558546, 10797.08224800885, 19045.333413330467, 19172.520686982938, 19184.61630767377, 19207.32774352919, 19249.711254331196, 7895.171007044178, 8144.144864789112, 8311.8337633247, 8329.08380078191, 8378.41351105429, 4356.825726970886, 4496.4154659894, 4522.66080043998, 4535.251683472256, 4607.562281583244, 3212.245122396235, 3222.774405791572, 3260.625028121749, 3273.9508907366408, 3275.9672403275663, 471.3895505320618, 477.6775676418473, 486.49647614718594, 489.6645797628636, 492.0626207075527, 572.4761842913771, 636.8503401700597, 657.7599176300712, 675.8595439184995, 686.5949090036902, 8537.701180458778, 8659.480431174024, 8693.521856297964, 8716.520591367536, 8853.335999800041, 650.417876000986, 670.6948338505968, 683.2689022745714, 697.7592730508068, 705.8601303355883, 3832.3868181091448, 3978.76127432355, 4140.896477588024, 4245.724027938174, 4271.081717430705, 56584.0, 57064.0, 57562.7121864388, 57772.42227577754, 58171.127433088535, 50313.74843125761, 50780.23829642558, 50968.0, 51269.743651281504, 51566.226506602434, 48431.273530897066, 48719.5128048722, 49956.75021624941, 50142.74928625333, 50562.49437505578, 8379.245867871921, 8648.0, 8756.60595273227, 9056.36605437613, 9063.864042039506, 35395.64604354026, 35422.114447137996, 36491.63508364883, 37109.44335835019, 37132.44301335536, 41126.1774764509, 42203.155936880474, 43202.35196471993, 46321.53678463307, 48235.5176448231, 7410.368919229646, 7508.587027713528, 7539.660715267716, 7629.771106866803, 7647.694092236248, 11740.785775509838, 12073.698157546132, 12126.27242365461, 12161.69595760113, 12167.81748273759, 11421.543138274375, 11535.423228838692, 11630.244034137753, 11768.293902365886, 12046.277223366626, 10791.514381852992, 10998.835017474905, 11039.83440248413, 11108.389038602954, 11395.202335836411, 11327.895465455516, 11462.254953428, 11678.299302041905, 11729.648110556696, 11953.94023029914, 9970.30207885441, 10040.549326742415, 10189.54147063369, 10236.0, 10442.63450779219, 9439.575219115293, 9538.126123076814, 10036.89963100389, 10123.443210623487, 10232.23258255619]}, "summary": {"lowerIsBetter": false, "suite": 6774.986269751692, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6854.709765397474, "unit": "ms", "value": 6854.709765397474}, "dojo.html": {"lowerIsBetter": false, "filtered": 5517.115581785272, "unit": "ms", "value": 5517.115581785272}, "mootools.html": {"lowerIsBetter": false, "filtered": 4316.64672101816, "unit": "ms", "value": 4316.64672101816}, "ext.html": {"lowerIsBetter": false, "filtered": 19061.594451356646, "unit": "ms", "value": 19061.594451356646}, "prototype.html": {"lowerIsBetter": false, "filtered": 4984.500202933535, "unit": "ms", "value": 4984.500202933535}, "yui.html": {"lowerIsBetter": false, "filtered": 6234.252368369684, "unit": "ms", "value": 6234.252368369684}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-027.e"}, "testrun": {"date": 1447347745, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 163.0, 162.0, 162.0, 163.0, 163.0, 164.0, 167.0, 174.0, 164.0], "ai-astar": [111.0, 107.0, 111.0, 111.0, 110.0, 121.0, 110.0, 111.0, 112.0, 110.0], "imaging-gaussian-blur": [110.0, 111.0, 111.0, 109.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0], "audio-beat-detection": [151.0, 126.0, 149.0, 166.0, 127.0, 153.0, 146.0, 126.0, 167.0, 126.0], "json-stringify-tinderbox": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [139.0, 149.0, 151.0, 152.0, 150.0, 144.0, 140.0, 148.0, 155.0, 149.0], "json-parse-financial": [61.0, 60.0, 62.0, 60.0, 62.0, 62.0, 62.0, 61.0, 59.0, 60.0], "stanford-crypto-sha256-iterative": [70.0, 66.0, 70.0, 68.0, 68.0, 70.0, 66.0, 69.0, 67.0, 66.0], "audio-fft": [73.0, 73.0, 72.0, 73.0, 73.0, 149.0, 73.0, 71.0, 73.0, 72.0], "imaging-darkroom": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 148.0], "stanford-crypto-ccm": [123.0, 117.0, 134.0, 119.0, 118.0, 127.0, 121.0, 126.0, 125.0, 124.0], "audio-oscillator": [91.0, 91.0, 141.0, 89.0, 91.0, 90.0, 134.0, 91.0, 91.0, 132.0], "stanford-crypto-aes": [85.0, 86.0, 86.0, 94.0, 87.0, 94.0, 91.0, 86.0, 87.0, 86.0], "imaging-desaturate": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1512.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.7, "unit": "ms", "value": 147.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.7, "unit": "ms", "value": 143.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 123.4, "unit": "ms", "value": 123.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 147.0, "unit": "ms", "value": 147.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.9, "unit": "ms", "value": 60.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.4, "unit": "ms", "value": 111.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.6, "unit": "ms", "value": 164.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 88.2, "unit": "ms", "value": 88.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.4, "unit": "ms", "value": 96.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-027.e"}, "testrun": {"date": 1447347745, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.27773527161438], "Encrypt": [281.135788585887], "NavierStokes": [4830.917874396136], "Decrypt": [5060.606060606061], "Splay": [913.2420091324201], "Richards": [161.57699143641946], "RegExp": [24804.878048780487], "Earley": [723.589001447178], "Boyer": [11651.162790697674], "RayTrace": [1048.2180293501049]}, "summary": {"lowerIsBetter": false, "suite": 20730.917521458443, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 345.66490400000004, "unit": "score", "value": 345.66490400000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 946.8058169999996, "unit": "score", "value": 946.8058169999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.59864071856286, "unit": "score", "value": 52.59864071856286}, "Splay": {"lowerIsBetter": false, "filtered": 89.23264499999998, "unit": "score", "value": 89.23264499999998}, "RegExp": {"lowerIsBetter": false, "filtered": 36.72604228121927, "unit": "score", "value": 36.72604228121927}, "Richards": {"lowerIsBetter": false, "filtered": 218.48407799999993, "unit": "score", "value": 218.48407799999993}, "Earley": {"lowerIsBetter": false, "filtered": 921.051866, "unit": "score", "value": 921.051866}, "Boyer": {"lowerIsBetter": false, "filtered": 57.20141516966067, "unit": "score", "value": 57.20141516966067}, "RayTrace": {"lowerIsBetter": false, "filtered": 705.9495059999997, "unit": "score", "value": 705.9495059999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-027.e"}, "testrun": {"date": 1447347745, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}] 09:22:37 INFO - RETURN: dromaeo_css: 6774.99 09:22:37 INFO - RETURN: kraken: 1512.70 09:22:37 INFO - RETURN: v8_7: 20730.92 09:22:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20730.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1512.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6774.99"}}} 09:22:37 INFO - Return code: 0 09:22:37 INFO - # TBPL SUCCESS # 09:22:37 INFO - Running post-action listener: _resource_record_post_action 09:22:37 INFO - Running post-run listener: _resource_record_post_run 09:22:38 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524394496; Read time: 8; Write time: 445284 09:22:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 177065984; Read time: 0; Write time: 190872 09:22:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 343388160; Read time: 8; Write time: 253900 09:22:38 INFO - Running post-run listener: _upload_blobber_files 09:22:38 INFO - Blob upload gear active. 09:22:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:22:38 INFO - Copying logs to upload dir... 09:22:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.930654 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-12 09:22:38.248396) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:38.252556) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010036 build_url: 'https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:38.308133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:38.308456) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447346587.624604-219859295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:38.357842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:22:38.358166) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:22:38.358457) ========= ========= Total master_lag: 0.24 =========