builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1447351249.38 results: success (0) buildid: 20151112083105 builduid: 244a1ddceb12411289cdd65887e115d2 revision: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.379841) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.380371) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.380665) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006442 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.432183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.432521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.559822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.560087) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.637394) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.637670) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.638025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:49.641354) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 10:00:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.1M=0s 2015-11-12 10:00:50 (44.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091079 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:50.027873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:50.028164) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017236 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:50.096379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:50.096694) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb --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/fx-team --rev 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb --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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 10:00:50,492 truncating revision to first 12 chars 2015-11-12 10:00:50,492 Setting DEBUG logging. 2015-11-12 10:00:50,492 attempt 1/10 2015-11-12 10:00:50,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/73119a9a7da2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 10:00:51,125 unpacking tar archive at: fx-team-73119a9a7da2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890106 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:51.020050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:51.023381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:51.034929) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:51.035353) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 10:00:51.035963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-12 10:00:51.036384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:51 INFO - MultiFileLogger online at 20151112 10:00:51 in /builds/slave/test-pgo 10:00:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:00:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:00:51 INFO - {'append_to_log': False, 10:00:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:00:51 INFO - 'blob_upload_branch': 'Fx-Team', 10:00:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:00:51 INFO - 'branch': 'Fx-Team', 10:00:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:51 INFO - 'config_files': ('talos/linux_config.py',), 10:00:51 INFO - 'default_actions': ('clobber', 10:00:51 INFO - 'read-buildbot-config', 10:00:51 INFO - 'download-and-extract', 10:00:51 INFO - 'populate-webroot', 10:00:51 INFO - 'create-virtualenv', 10:00:51 INFO - 'install', 10:00:51 INFO - 'run-tests'), 10:00:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:51 INFO - 'download_minidump_stackwalk': True, 10:00:51 INFO - 'download_symbols': 'ondemand', 10:00:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:51 INFO - 'installer_path': 'installer.exe', 10:00:51 INFO - 'log_level': 'info', 10:00:51 INFO - 'log_name': 'talos', 10:00:51 INFO - 'log_to_console': True, 10:00:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:51 INFO - 'opt_config_files': (), 10:00:51 INFO - 'pip_index': False, 10:00:51 INFO - 'sps_profile': False, 10:00:51 INFO - 'sps_profile_interval': 0, 10:00:51 INFO - 'suite': 'dromaeojs', 10:00:51 INFO - 'system_bits': '64', 10:00:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:51 INFO - 'title': 'talos-linux64-ix-061', 10:00:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:51 INFO - 'use_talos_json': True, 10:00:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:00:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:51 INFO - 'work_dir': 'build'} 10:00:51 INFO - ##### 10:00:51 INFO - ##### Running clobber step. 10:00:51 INFO - ##### 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: clobber 10:00:51 INFO - rmtree: /builds/slave/test-pgo/build 10:00:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:00:51 INFO - Running post-action listener: _resource_record_post_action 10:00:51 INFO - ##### 10:00:51 INFO - ##### Running read-buildbot-config step. 10:00:51 INFO - ##### 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: read_buildbot_config 10:00:51 INFO - Using buildbot properties: 10:00:51 INFO - { 10:00:51 INFO - "properties": { 10:00:51 INFO - "buildnumber": 481, 10:00:51 INFO - "product": "firefox", 10:00:51 INFO - "script_repo_revision": "production", 10:00:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:00:51 INFO - "repository": "", 10:00:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:00:51 INFO - "buildid": "20151112083105", 10:00:51 INFO - "slavename": "talos-linux64-ix-061", 10:00:51 INFO - "pgo_build": "True", 10:00:51 INFO - "basedir": "/builds/slave/test-pgo", 10:00:51 INFO - "project": "", 10:00:51 INFO - "platform": "ubuntu64_hw", 10:00:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:00:51 INFO - "slavebuilddir": "test", 10:00:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:00:51 INFO - "branch": "fx-team", 10:00:51 INFO - "repo_path": "integration/fx-team", 10:00:51 INFO - "stage_platform": "linux64-pgo", 10:00:51 INFO - "builduid": "244a1ddceb12411289cdd65887e115d2", 10:00:51 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 10:00:51 INFO - }, 10:00:51 INFO - "sourcestamp": { 10:00:51 INFO - "repository": "", 10:00:51 INFO - "hasPatch": false, 10:00:51 INFO - "project": "", 10:00:51 INFO - "branch": "fx-team-linux64-pgo-talos", 10:00:51 INFO - "changes": [ 10:00:51 INFO - { 10:00:51 INFO - "category": null, 10:00:51 INFO - "files": [ 10:00:51 INFO - { 10:00:51 INFO - "url": null, 10:00:51 INFO - "name": "https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:00:51 INFO - } 10:00:51 INFO - ], 10:00:51 INFO - "repository": "", 10:00:51 INFO - "rev": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb", 10:00:51 INFO - "who": "sendchange", 10:00:51 INFO - "when": 1447351182, 10:00:51 INFO - "number": 6654181, 10:00:51 INFO - "comments": "", 10:00:51 INFO - "project": "", 10:00:51 INFO - "at": "Thu 12 Nov 2015 09:59:42", 10:00:51 INFO - "branch": "fx-team-linux64-pgo-talos", 10:00:51 INFO - "revlink": "", 10:00:51 INFO - "properties": [ 10:00:51 INFO - [ 10:00:51 INFO - "buildid", 10:00:51 INFO - "20151112083105", 10:00:51 INFO - "Change" 10:00:51 INFO - ], 10:00:51 INFO - [ 10:00:51 INFO - "builduid", 10:00:51 INFO - "244a1ddceb12411289cdd65887e115d2", 10:00:51 INFO - "Change" 10:00:51 INFO - ], 10:00:51 INFO - [ 10:00:51 INFO - "pgo_build", 10:00:51 INFO - "True", 10:00:51 INFO - "Change" 10:00:51 INFO - ] 10:00:51 INFO - ], 10:00:51 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 10:00:51 INFO - } 10:00:51 INFO - ], 10:00:51 INFO - "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb" 10:00:51 INFO - } 10:00:51 INFO - } 10:00:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:00:51 INFO - Running post-action listener: _resource_record_post_action 10:00:51 INFO - ##### 10:00:51 INFO - ##### Running download-and-extract step. 10:00:51 INFO - ##### 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: download_and_extract 10:00:51 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:00: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')]} 10:00:51 INFO - https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:00:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/test_packages.json 10:00:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/test_packages.json 10:00:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:00:53 INFO - Downloaded 1302 bytes. 10:00:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:00:53 INFO - Using the following test package requirements: 10:00:53 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'jsshell-linux-x86_64.zip'], 10:00:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:53 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:53 INFO - https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:54 INFO - Downloaded 22438756 bytes. 10:00:54 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 10:00:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:54 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 10:00:55 INFO - Return code: 0 10:00:55 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 10:00: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')]} 10:00:55 INFO - https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:00:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:56 INFO - Downloaded 22438756 bytes. 10:00:56 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 10:00:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:00:56 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 10:00:57 INFO - Return code: 0 10:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:57 INFO - https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:00:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:58 INFO - Downloaded 11131693 bytes. 10:00:58 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 10:00:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:58 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 10:00:58 INFO - Return code: 0 10:00: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')]} 10:00:58 INFO - https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:00:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:00:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:00:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:00:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/niRvHwMkQIuTQVp24uVq_A/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 10:01:00 INFO - Downloaded 57174629 bytes. 10:01:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:00 INFO - mkdir: /builds/slave/test-pgo/properties 10:01:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:01:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:01:00 INFO - Contents: 10:01:00 INFO - build_url:https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:01:00 INFO - Running post-action listener: _resource_record_post_action 10:01:00 INFO - Running post-action listener: set_extra_try_arguments 10:01:00 INFO - ##### 10:01:00 INFO - ##### Running populate-webroot step. 10:01:00 INFO - ##### 10:01:00 INFO - Running pre-action listener: _resource_record_pre_action 10:01:00 INFO - Running main action method: populate_webroot 10:01:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:00 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:01:00 INFO - '../fennec_ids.txt'], 10:01:00 INFO - 'tests': ['tcheck2']}, 10:01:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:00 INFO - '--tppagecycles', 10:01:00 INFO - '7'], 10:01:00 INFO - 'tests': ['tsvgm']}}, 10:01:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:01:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'tests': ['damp', 'tps']}, 10:01:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['damp', 'tps']}, 10:01:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:01:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:00 INFO - 'other': {'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'other_l64': {'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'other_nol64': {'tests': ['a11yr', 10:01:00 INFO - 'ts_paint', 10:01:00 INFO - 'tpaint', 10:01:00 INFO - 'sessionrestore', 10:01:00 INFO - 'sessionrestore_no_auto_restore']}, 10:01:00 INFO - 'svgr': {'tests': ['tsvgx', 10:01:00 INFO - 'tsvgr_opacity', 10:01:00 INFO - 'tart', 10:01:00 INFO - 'tscrollx', 10:01:00 INFO - 'cart']}, 10:01:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['tsvgx', 10:01:00 INFO - 'tsvgr_opacity', 10:01:00 INFO - 'tart', 10:01:00 INFO - 'tscrollx', 10:01:00 INFO - 'cart']}, 10:01:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'tests': ['tp5o']}, 10:01:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'talos_options': ['--e10s'], 10:01:00 INFO - 'tests': ['tp5o']}, 10:01:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'talos_options': ['--xperf_path', 10:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:00 INFO - 'tests': ['tp5n']}, 10:01:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:00 INFO - 'talos_options': ['--e10s', 10:01:00 INFO - '--xperf_path', 10:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:00 INFO - 'tests': ['tp5n']}}, 10:01:00 INFO - 'talos.zip': {'path': '', 10:01:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:00 INFO - Running post-action listener: _resource_record_post_action 10:01:00 INFO - ##### 10:01:00 INFO - ##### Running create-virtualenv step. 10:01:00 INFO - ##### 10:01:00 INFO - Running pre-action listener: _resource_record_pre_action 10:01:00 INFO - Running main action method: create_virtualenv 10:01:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:01:00 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 10:01:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:01:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:00 INFO - Using real prefix '/usr' 10:01:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:01:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:02 INFO - Installing pip.................done. 10:01:02 INFO - Return code: 0 10:01:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:02 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:02 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 10:01:02 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 10:01:02 INFO - Using env: {'DISPLAY': ':0', 10:01:02 INFO - 'HOME': '/home/cltbld', 10:01:02 INFO - 'LANG': 'en_US.UTF-8', 10:01:02 INFO - 'LANGUAGE': 'en_US:en', 10:01:02 INFO - 'LOGNAME': 'cltbld', 10:01:02 INFO - 'MAIL': '/var/mail/cltbld', 10:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:02 INFO - 'MOZ_NO_REMOTE': '1', 10:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:02 INFO - 'NO_EM_RESTART': '1', 10:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:02 INFO - 'SHELL': '/bin/bash', 10:01:02 INFO - 'SHLVL': '1', 10:01:02 INFO - 'TERM': 'linux', 10:01:02 INFO - 'TMOUT': '86400', 10:01:02 INFO - 'USER': 'cltbld', 10:01:02 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:02 INFO - '_': '/tools/buildbot/bin/python'} 10:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:03 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 10:01:03 INFO - Cleaning up... 10:01:03 INFO - Return code: 0 10:01:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:03 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:03 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 10:01:03 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 10:01:03 INFO - Using env: {'DISPLAY': ':0', 10:01:03 INFO - 'HOME': '/home/cltbld', 10:01:03 INFO - 'LANG': 'en_US.UTF-8', 10:01:03 INFO - 'LANGUAGE': 'en_US:en', 10:01:03 INFO - 'LOGNAME': 'cltbld', 10:01:03 INFO - 'MAIL': '/var/mail/cltbld', 10:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:03 INFO - 'MOZ_NO_REMOTE': '1', 10:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:03 INFO - 'NO_EM_RESTART': '1', 10:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:03 INFO - 'SHELL': '/bin/bash', 10:01:03 INFO - 'SHLVL': '1', 10:01:03 INFO - 'TERM': 'linux', 10:01:03 INFO - 'TMOUT': '86400', 10:01:03 INFO - 'USER': 'cltbld', 10:01:03 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:03 INFO - '_': '/tools/buildbot/bin/python'} 10:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:03 INFO - Downloading/unpacking psutil>=0.7.1 10:01:03 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 10:01:03 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 10:01:03 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 10:01:03 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 10:01:03 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 10:01:03 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 10:01:05 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:01:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:01:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:05 INFO - Installing collected packages: psutil 10:01:05 INFO - Running setup.py install for psutil 10:01:05 INFO - building 'psutil._psutil_linux' extension 10:01:05 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 10:01:05 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 10:01:05 INFO - building 'psutil._psutil_posix' extension 10:01:05 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 10:01:05 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 10:01:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:05 INFO - Successfully installed psutil 10:01:05 INFO - Cleaning up... 10:01:05 INFO - Return code: 0 10:01:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:01:05 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')]} 10:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:05 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')]} 10:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:05 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:05 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 10:01:05 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 10:01:05 INFO - Using env: {'DISPLAY': ':0', 10:01:05 INFO - 'HOME': '/home/cltbld', 10:01:05 INFO - 'LANG': 'en_US.UTF-8', 10:01:05 INFO - 'LANGUAGE': 'en_US:en', 10:01:05 INFO - 'LOGNAME': 'cltbld', 10:01:05 INFO - 'MAIL': '/var/mail/cltbld', 10:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:05 INFO - 'MOZ_NO_REMOTE': '1', 10:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:05 INFO - 'NO_EM_RESTART': '1', 10:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:05 INFO - 'SHELL': '/bin/bash', 10:01:05 INFO - 'SHLVL': '1', 10:01:05 INFO - 'TERM': 'linux', 10:01:05 INFO - 'TMOUT': '86400', 10:01:05 INFO - 'USER': 'cltbld', 10:01:05 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:05 INFO - '_': '/tools/buildbot/bin/python'} 10:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:01:05 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 10:01:05 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 10:01:05 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 10:01:05 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 10:01:05 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 10:01:05 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 10:01:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:01:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:01:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:01:07 INFO - Installing collected packages: mozsystemmonitor 10:01:07 INFO - Running setup.py install for mozsystemmonitor 10:01:07 INFO - Successfully installed mozsystemmonitor 10:01:07 INFO - Cleaning up... 10:01:07 INFO - Return code: 0 10:01:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:01:07 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')]} 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:07 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')]} 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:07 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:07 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 10:01:07 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 10:01:07 INFO - Using env: {'DISPLAY': ':0', 10:01:07 INFO - 'HOME': '/home/cltbld', 10:01:07 INFO - 'LANG': 'en_US.UTF-8', 10:01:07 INFO - 'LANGUAGE': 'en_US:en', 10:01:07 INFO - 'LOGNAME': 'cltbld', 10:01:07 INFO - 'MAIL': '/var/mail/cltbld', 10:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:07 INFO - 'MOZ_NO_REMOTE': '1', 10:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:07 INFO - 'NO_EM_RESTART': '1', 10:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:07 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:07 INFO - 'SHELL': '/bin/bash', 10:01:07 INFO - 'SHLVL': '1', 10:01:07 INFO - 'TERM': 'linux', 10:01:07 INFO - 'TMOUT': '86400', 10:01:07 INFO - 'USER': 'cltbld', 10:01:07 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:07 INFO - '_': '/tools/buildbot/bin/python'} 10:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:07 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:01:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:01:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:01:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:10 INFO - Downloading docopt-0.6.1.tar.gz 10:01:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:01:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:10 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:10 INFO - Running setup.py install for blobuploader 10:01:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:01:10 INFO - Running setup.py install for requests 10:01:10 INFO - Running setup.py install for docopt 10:01:10 INFO - Successfully installed blobuploader requests docopt 10:01:10 INFO - Cleaning up... 10:01:10 INFO - Return code: 0 10:01:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:10 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:10 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 10:01:10 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 10:01:10 INFO - Using env: {'DISPLAY': ':0', 10:01:10 INFO - 'HOME': '/home/cltbld', 10:01:10 INFO - 'LANG': 'en_US.UTF-8', 10:01:10 INFO - 'LANGUAGE': 'en_US:en', 10:01:10 INFO - 'LOGNAME': 'cltbld', 10:01:10 INFO - 'MAIL': '/var/mail/cltbld', 10:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:10 INFO - 'MOZ_NO_REMOTE': '1', 10:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:10 INFO - 'NO_EM_RESTART': '1', 10:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:10 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:10 INFO - 'SHELL': '/bin/bash', 10:01:10 INFO - 'SHLVL': '1', 10:01:10 INFO - 'TERM': 'linux', 10:01:10 INFO - 'TMOUT': '86400', 10:01:10 INFO - 'USER': 'cltbld', 10:01:10 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:10 INFO - '_': '/tools/buildbot/bin/python'} 10:01:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:11 INFO - Running setup.py (path:/tmp/pip-7dhzPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:11 INFO - Running setup.py (path:/tmp/pip-X8UCnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:11 INFO - Running setup.py (path:/tmp/pip-jdMquv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:11 INFO - Running setup.py (path:/tmp/pip-bGrsZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:11 INFO - Running setup.py (path:/tmp/pip-ui4jvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:11 INFO - Running setup.py (path:/tmp/pip-nSb_T8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:11 INFO - Running setup.py (path:/tmp/pip-eZ1R0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:11 INFO - Running setup.py (path:/tmp/pip-h8mloD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:11 INFO - Running setup.py (path:/tmp/pip-5yim5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:11 INFO - Running setup.py (path:/tmp/pip-lmpeWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:11 INFO - Running setup.py (path:/tmp/pip-of_0WS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:11 INFO - Running setup.py (path:/tmp/pip-TaHb52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:11 INFO - Running setup.py (path:/tmp/pip-0OGnf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:12 INFO - Running setup.py (path:/tmp/pip-3Xdr5Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:12 INFO - Running setup.py (path:/tmp/pip-eG6V9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:12 INFO - Running setup.py (path:/tmp/pip-2cUok6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:12 INFO - Running setup.py (path:/tmp/pip-QA8toU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:12 INFO - Running setup.py install for manifestparser 10:01:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:01:12 INFO - Running setup.py install for mozcrash 10:01:12 INFO - Running setup.py install for mozdebug 10:01:12 INFO - Running setup.py install for mozdevice 10:01:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:01:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:01:12 INFO - Running setup.py install for mozfile 10:01:12 INFO - Running setup.py install for mozhttpd 10:01:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:01:12 INFO - Running setup.py install for mozinfo 10:01:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for mozInstall 10:01:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for mozleak 10:01:13 INFO - Running setup.py install for mozlog 10:01:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for moznetwork 10:01:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for mozprocess 10:01:13 INFO - Running setup.py install for mozprofile 10:01:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for mozrunner 10:01:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:01:13 INFO - Running setup.py install for mozscreenshot 10:01:13 INFO - Running setup.py install for moztest 10:01:13 INFO - Running setup.py install for mozversion 10:01:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:01:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:14 INFO - Cleaning up... 10:01:14 INFO - Return code: 0 10:01:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:14 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')]} 10:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 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')]} 10:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:14 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:14 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 10:01:14 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 10:01:14 INFO - Using env: {'DISPLAY': ':0', 10:01:14 INFO - 'HOME': '/home/cltbld', 10:01:14 INFO - 'LANG': 'en_US.UTF-8', 10:01:14 INFO - 'LANGUAGE': 'en_US:en', 10:01:14 INFO - 'LOGNAME': 'cltbld', 10:01:14 INFO - 'MAIL': '/var/mail/cltbld', 10:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:14 INFO - 'MOZ_NO_REMOTE': '1', 10:01:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:14 INFO - 'NO_EM_RESTART': '1', 10:01:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:14 INFO - 'SHELL': '/bin/bash', 10:01:14 INFO - 'SHLVL': '1', 10:01:14 INFO - 'TERM': 'linux', 10:01:14 INFO - 'TMOUT': '86400', 10:01:14 INFO - 'USER': 'cltbld', 10:01:14 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:14 INFO - '_': '/tools/buildbot/bin/python'} 10:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:14 INFO - Running setup.py (path:/tmp/pip-pBbcLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:14 INFO - Running setup.py (path:/tmp/pip-9EPz3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:14 INFO - Running setup.py (path:/tmp/pip-KPbrtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:14 INFO - Running setup.py (path:/tmp/pip-bLWzNH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:14 INFO - Running setup.py (path:/tmp/pip-TW7O9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:14 INFO - Running setup.py (path:/tmp/pip-cBjF6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:14 INFO - Running setup.py (path:/tmp/pip-82JFGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:14 INFO - Running setup.py (path:/tmp/pip-Z0rZsZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:14 INFO - Running setup.py (path:/tmp/pip-TphRKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:14 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)) 10:01:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:14 INFO - Running setup.py (path:/tmp/pip-dVx1Ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:15 INFO - Running setup.py (path:/tmp/pip-mmmTjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:15 INFO - Running setup.py (path:/tmp/pip-EDAwkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:15 INFO - Running setup.py (path:/tmp/pip-HaaIo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:15 INFO - Running setup.py (path:/tmp/pip-B4UL6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:15 INFO - Running setup.py (path:/tmp/pip-7kgBHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:15 INFO - Running setup.py (path:/tmp/pip-QhF1ZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:15 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)) 10:01:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:15 INFO - Running setup.py (path:/tmp/pip-jsUdd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:15 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)) 10:01:15 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)) 10:01:15 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)) 10:01:15 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)) 10:01:15 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)) 10:01:15 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)) 10:01:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:01:15 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 10:01:15 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 10:01:15 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 10:01:15 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 10:01:15 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 10:01:15 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 10:01:17 INFO - Downloading blessings-1.5.1.tar.gz 10:01:17 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 10:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:17 INFO - Installing collected packages: blessings 10:01:17 INFO - Running setup.py install for blessings 10:01:17 INFO - Successfully installed blessings 10:01:17 INFO - Cleaning up... 10:01:17 INFO - Return code: 0 10:01:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:01:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:17 INFO - Reading from file tmpfile_stdout 10:01:17 INFO - Current package versions: 10:01:17 INFO - argparse == 1.2.1 10:01:17 INFO - blessings == 1.5.1 10:01:17 INFO - blobuploader == 1.2.4 10:01:17 INFO - docopt == 0.6.1 10:01:17 INFO - manifestparser == 1.1 10:01:17 INFO - mozInstall == 1.12 10:01:17 INFO - mozcrash == 0.16 10:01:17 INFO - mozdebug == 0.1 10:01:17 INFO - mozdevice == 0.47 10:01:17 INFO - mozfile == 1.2 10:01:17 INFO - mozhttpd == 0.7 10:01:17 INFO - mozinfo == 0.9 10:01:17 INFO - mozleak == 0.1 10:01:17 INFO - mozlog == 3.0 10:01:17 INFO - moznetwork == 0.27 10:01:17 INFO - mozprocess == 0.22 10:01:17 INFO - mozprofile == 0.27 10:01:17 INFO - mozrunner == 6.11 10:01:17 INFO - mozscreenshot == 0.1 10:01:17 INFO - mozsystemmonitor == 0.0 10:01:17 INFO - moztest == 0.7 10:01:17 INFO - mozversion == 1.4 10:01:17 INFO - psutil == 3.1.1 10:01:17 INFO - requests == 1.2.3 10:01:17 INFO - wsgiref == 0.1.2 10:01:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:17 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')]} 10:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 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')]} 10:01:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:17 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 0x7f20ed437c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27796c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, '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': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', '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 10:01:17 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 10:01:17 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 10:01:17 INFO - Using env: {'DISPLAY': ':0', 10:01:17 INFO - 'HOME': '/home/cltbld', 10:01:17 INFO - 'LANG': 'en_US.UTF-8', 10:01:17 INFO - 'LANGUAGE': 'en_US:en', 10:01:17 INFO - 'LOGNAME': 'cltbld', 10:01:17 INFO - 'MAIL': '/var/mail/cltbld', 10:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:17 INFO - 'MOZ_NO_REMOTE': '1', 10:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:17 INFO - 'NO_EM_RESTART': '1', 10:01:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:17 INFO - 'SHELL': '/bin/bash', 10:01:17 INFO - 'SHLVL': '1', 10:01:17 INFO - 'TERM': 'linux', 10:01:17 INFO - 'TMOUT': '86400', 10:01:17 INFO - 'USER': 'cltbld', 10:01:17 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:17 INFO - '_': '/tools/buildbot/bin/python'} 10:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 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)) 10:01:17 INFO - Cleaning up... 10:01:17 INFO - Return code: 0 10:01:17 INFO - Running post-action listener: _resource_record_post_action 10:01:17 INFO - Running post-action listener: _start_resource_monitoring 10:01:17 INFO - Starting resource monitoring. 10:01:17 INFO - ##### 10:01:17 INFO - ##### Running install step. 10:01:17 INFO - ##### 10:01:17 INFO - Running pre-action listener: _resource_record_pre_action 10:01:17 INFO - Running main action method: install 10:01:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:18 INFO - Reading from file tmpfile_stdout 10:01:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:01:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:01:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:01:18 INFO - Reading from file tmpfile_stdout 10:01:18 INFO - Output received: 10:01:18 INFO - Usage: mozinstall [options] installer 10:01:18 INFO - Options: 10:01:18 INFO - -h, --help show this help message and exit 10:01:18 INFO - -d DEST, --destination=DEST 10:01:18 INFO - Directory to install application into. [default: 10:01:18 INFO - "/builds/slave/test-pgo"] 10:01:18 INFO - --app=APP Application being installed. [default: firefox] 10:01:18 INFO - mkdir: /builds/slave/test-pgo/build/application 10:01:18 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'] 10:01:18 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 10:01:32 INFO - Reading from file tmpfile_stdout 10:01:32 INFO - Output received: 10:01:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:01:32 INFO - Running post-action listener: _resource_record_post_action 10:01:32 INFO - ##### 10:01:32 INFO - ##### Running run-tests step. 10:01:32 INFO - ##### 10:01:32 INFO - Running pre-action listener: _resource_record_pre_action 10:01:32 INFO - Running main action method: run_tests 10:01:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:01:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:01:32 INFO - Python 2.7.3 10:01:32 INFO - Return code: 0 10:01:32 INFO - grabbing minidump binary from tooltool 10:01:32 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')]} 10:01:32 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 0x28c38c0>, '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 0x2870420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28708b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:01:32 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 10:01:32 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 10:01:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:32 INFO - Return code: 0 10:01:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:01:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:01:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:01:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:01:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:01:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:01:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 10:01:32 INFO - Using env: {'DISPLAY': ':0', 10:01:32 INFO - 'HOME': '/home/cltbld', 10:01:32 INFO - 'LANG': 'en_US.UTF-8', 10:01:32 INFO - 'LANGUAGE': 'en_US:en', 10:01:32 INFO - 'LOGNAME': 'cltbld', 10:01:32 INFO - 'MAIL': '/var/mail/cltbld', 10:01:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:01:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:32 INFO - 'MOZ_NO_REMOTE': '1', 10:01:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:32 INFO - 'NO_EM_RESTART': '1', 10:01:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:01:32 INFO - 'SHELL': '/bin/bash', 10:01:32 INFO - 'SHLVL': '1', 10:01:32 INFO - 'TERM': 'linux', 10:01:32 INFO - 'TMOUT': '86400', 10:01:32 INFO - 'USER': 'cltbld', 10:01:32 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930', 10:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:32 INFO - '_': '/tools/buildbot/bin/python'} 10:01:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 10:01:32 INFO - mozversion INFO | application_buildid: 20151112083105 10:01:32 INFO - mozversion INFO | application_changeset: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb 10:01:32 INFO - mozversion INFO | application_display_name: Nightly 10:01:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:32 INFO - mozversion INFO | application_name: Firefox 10:01:32 INFO - mozversion INFO | application_remotingname: firefox 10:01:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:01:32 INFO - mozversion INFO | application_vendor: Mozilla 10:01:32 INFO - mozversion INFO | application_version: 45.0a1 10:01:32 INFO - mozversion INFO | platform_buildid: 20151112083105 10:01:32 INFO - mozversion INFO | platform_changeset: 73119a9a7da215431a8b4c8b31a28cb8dd78d3bb 10:01:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:01:32 INFO - mozversion INFO | platform_version: 45.0a1 10:01:32 INFO - 2015-11-12 10:01:32,822 DEBUG : using testdate: 1447351292 10:01:32 INFO - 2015-11-12 10:01:32,822 DEBUG : actual date: 1447351292 10:01:32 INFO - 2015-11-12 10:01:32,836 INFO : starting webserver on 'localhost:37959' 10:01:32 INFO - 2015-11-12 10:01:32,837 INFO : Starting test suite talos-linux64-ix-061 10:01:32 INFO - 2015-11-12 10:01:32,837 INFO : Starting test dromaeo_css 10:01:32 INFO - 2015-11-12 10:01:32,837 DEBUG : operating with platform_type : linux_ 10:01:32 INFO - 2015-11-12 10:01:32,838 INFO : Initialising browser for dromaeo_css test... 10:01:32 INFO - 2015-11-12 10:01:32,854 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOOENki/profile http://localhost:37959/getInfo.html 10:01:36 INFO - 2015-11-12 10:01:36,631 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:01:36 INFO - 2015-11-12 10:01:36,631 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:01:36 INFO - 2015-11-12 10:01:36,631 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:01:36 INFO - 2015-11-12 10:01:36,632 DEBUG : BROWSER_OUTPUT: __metrics 10:01:36 INFO - 2015-11-12 10:01:36,780 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:01:37 INFO - 2015-11-12 10:01:37,923 INFO : Browser initialized. 10:01:37 INFO - 2015-11-12 10:01:37,923 INFO : Running cycle 1/1 for dromaeo_css test... 10:01:37 INFO - 2015-11-12 10:01:37,924 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOOENki/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:01:49 INFO - 2015-11-12 10:01:49,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 141176832 10:01:49 INFO - 2015-11-12 10:01:49,650 DEBUG : BROWSER_OUTPUT: 10:02:40 INFO - 2015-11-12 10:02:40,327 DEBUG : BROWSER_OUTPUT: 1447351360325 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:04:49 INFO - 2015-11-12 10:04:49,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37959/tests/dromaeo/cssquery-ext.html) 10:04:50 INFO - 2015-11-12 10:04:50,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 234876928 10:04:50 INFO - 2015-11-12 10:04:50,840 DEBUG : BROWSER_OUTPUT: 10:07:53 INFO - 2015-11-12 10:07:53,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-ext.html (next: http://localhost:37959/tests/dromaeo/cssquery-jquery.html) 10:07:53 INFO - 2015-11-12 10:07:53,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 212385792 10:07:53 INFO - 2015-11-12 10:07:53,643 DEBUG : BROWSER_OUTPUT: 10:10:55 INFO - 2015-11-12 10:10:55,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37959/tests/dromaeo/cssquery-mootools.html) 10:10:56 INFO - 2015-11-12 10:10:56,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 213540864 10:10:56 INFO - 2015-11-12 10:10:56,054 DEBUG : BROWSER_OUTPUT: 10:13:57 INFO - 2015-11-12 10:13:57,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37959/tests/dromaeo/cssquery-prototype.html) 10:13:58 INFO - 2015-11-12 10:13:58,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 199405568 10:13:58 INFO - 2015-11-12 10:13:58,443 DEBUG : BROWSER_OUTPUT: 10:17:00 INFO - 2015-11-12 10:17:00,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37959/tests/dromaeo/cssquery-yui.html) 10:17:01 INFO - 2015-11-12 10:17:01,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 202686464 10:17:01 INFO - 2015-11-12 10:17:01,467 DEBUG : BROWSER_OUTPUT: 10:20:03 INFO - 2015-11-12 10:20:03,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-yui.html (next: http://localhost:37959/tests/dromaeo/cssquery-dojo.html) 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 284647424 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:20:04 INFO - 2015-11-12 10:20:04,186 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:20:04 INFO - 2015-11-12 10:20:04,190 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3196.71229589337;3296.752743544235;3348.4140275451805;3353.6814002669753;3359.8152101634414;5347.866303342418;5423.267858839055;5434.103372943459;5469.726513674315;5473.91789123163;5473.67157970522;5480.177973303997;5523.475269849368;5525.0883604205355;5547.389787123413;4973.801047958095;4987.476314986929;5101.770420331075;5178.637495375326;5223.294855194557;4900.9754951225195;5158.3552055993005;5182.248573956774;5201.947980520203;5229.921551176735;4949.282354058641;5017.52333528316;5026.045051440215;5029.019341228462;5076.923846142311;5039.09296326661;5053.519915608012;5053.545180933734;5054.82308119214;5080.77136528857;4852.247901575226;5051.974740126276;5065.822696205652;5072.771725272371;5087.23691446286;5232.241325007891;5293.311869456985;5329.626926115174;5347.679139251619;5378.865528361783;5962.791302304398;5986.311574168983;5986.880262394728;5992.640441573476;5999.910001349983;5832.941670583325;5948.940510594925;5993.520518358521;5994.700264986734;6024.126501657235;5539.335279766414;5623.606347555714;5625;5632.971835140839;5677.687727175004;6158;6159.784407545714;6173.9073913891325;6175.876482470326;6175.907361389583;5701.116326969326;5819.476247137778;5853.853653658607;5913.733881975321;5959.433853783884;6018.789342372996;6021.367756385516;6029.366916473795;6031.60794548353;6074.483668888106;5988.461038506468;5991.7902873399225;5993.460588547052;5994.490468310155;5998.520118390518;5709.800156994485;5819.301683797887;5868.941310586925;5983.670898100646;5984;4615.699979501322;4637.46669133054;4660.533946605312;4662;4675.018246168274;4108.897277568025;4120.196561670446;4120.567340429272;4126.339785634284;4165.125323682;5567.610267281251;5648;5693.17448969897;5705.914411283834;5776.5089967352405;5989.64062156272;6079.452849243589;6088.726007329681;6092.786752463642;6092.878142437126;5763.221965034667;5763.827085187451;5768.596198266081;5771.365149833515;5780.53755699543;5113.1052065888325;5148.794048238028;5181.3782346118705;5216.061109000417;5248.9737551312;6312.305646378894;6361.713722882574;6364.745410183541;6366.363363663597;6370.554061215763;5774.653520788766;6064.545159112996;6074.392560744067;6078.209832721895;6079.270487541523;6145.66198859067;6209.906851397323;6345.682715864281;6367.681615919093;6369.617822930453;5932;5937.168796368425;5943.661127377125;5948.2862056553495;6005.879882402415;5794.4205579443405;5902.881942361215;6009.7295621698;6015.939840601538;6019.067044608093;5735.71321433935;5824.650520968756;5824.9806283901;5833.241678581757;5858.150568167677;5762;5797.971010144923;5819.76720931158;5823.70881455934;5826.883462330645;5556.499915007668;5604.8879022418505;5686.516646085129;5739.139129130664;5739.9139012914;5853.882922341614;5915.852103697442;5927.199828023334;5928.140419639214;5937.762489500372;5766.336871259691;5784.1034639630925;5789.2763404574425;5796.333421656394;5840.795572154954 10:20:04 INFO - 2015-11-12 10:20:04,190 DEBUG : BROWSER_OUTPUT: |1;ext.html;572.9427057294268;590.6279044202157;597.2534332084894;610.7984365159498;623.5292354272524;32522.83738581307;33061.504077438825;42099.78950105249;42574;42724.14551708972;44040;44443;44503.1099378013;44555.10889782211;44652.3302150468;7591.354734847545;8654.480731156134;8813.38306318558;8821.117888211193;8844.646214151426;7742.729004484844;10455;10509.316894401878;10584.259101862834;10671.35971841692;10273.589056437771;10364.948175259151;10379.792404151913;10384.221183411237;10384.584616615326;7936.285734283913;8096.919030809676;10295.63965261216;10386;10522.894771052344;10113.443760593165;10155.339902906288;10162.39025658463;10221.488925553767;10236.539355728935;40623.39064914029;41067;41130;41138.588614113774;41145.06259248879;2862.261126742388;2987.2041106482707;2998.040626999361;3026.273694313371;3066.3254084101463;30638.69361306403;30788.384232315228;30892.134506279614;30970.225744356347;31197.688023119932;3301.1912081540177;3336.132605522582;3342.8328583570724;3381.323735252959;3437.604675462329;281888;284776;285547;285756;285833;53839.730801345744;55099.17351239654;63296;63709;68352.3164768356;64443.355566444676;64520.677396612715;64825.35174648193;64836.67581662061;64914.35085649083;15484.612884677974;15660.451884183998;15698.68602627941;15705.842941570667;15706.214689265491;11285.153613479022;11327.490262938187;11355.148363872742;11366.829497557543;11399.943000284946;20195.192192312436;20273.391798246077;20370.796292037187;20376.388708338774;20433.795662043485;7758.573278469738;7878.881816772753;7910.683572657144;7933;8018.558979256197;875.8117004843862;962.4033099478369;1053.0995998421392;1068.1668298727006;1127.937963412004;26293;27097.1870843875;27418.862905685743;27641.170764877086;28028.159155225378;1047.266494945532;1088.9727756806144;1109.1071687291808;1124.1175677093606;1131.8924702153283;14288.785668214985;14386.424543018371;14475.65859427019;14509.274536273144;14672.339744711513;344715;349012;350510;351948;353385;46973.29540056902;53694;54166.729166353914;54167;54207.45792542024;1226.6871947653292;1261.1802328486374;1321.062045947388;1337.3179678364104;1337.5987203838808;26766.464670706868;27313.453730924874;27853.86073069622;28905.132846014654;29432.705672942997;44863.32705009493;45162.548374515834;45915.54084459246;45983.3102503456;46159.3076103852;434429;442890;445705;446821;447528;31435.371292573564;31825.68174318227;31920.5211921826;32044.19889502781;32075.67924320727;44438.3334249993;44951.32573011342;45057.32414013858;45357;45928.77035614801;36242;36966.445503316936;37821.62178378181;37853.242935141694;38647;37115.8144209288;37456.625433746405;38547.614523854405;38616;38770.4184437228;36647.81676091602;37499;37610;37662;37675.43486847754;32434.675653243165;34036;34100.14749631279;34473;34597.30805383928;25335;25519.617205741557;25734.613980790677;25912.352191194615;26128.477430451665 10:20:04 INFO - 2015-11-12 10:20:04,194 DEBUG : BROWSER_OUTPUT: |2;jquery.html;348.11404974340303;349.74468637894336;352.66672994020627;353.3692359138937;357.61020487668435;14449.060811047275;14564;17547.912260438712;18026.278948842046;18999;11766.117541184403;12082.939585302061;16260.105694186816;16695.165241737894;16771.748423773624;4597.563231493003;4702.811887524512;4706;4709.64677649176;4712.481627021042;3630.0743310455928;3699.3896007158787;4676.3453116563705;4718.57532822046;5025;5043.974780126095;5064.442911279756;5093;5101.464346243647;5115.335006449156;4971.900561988758;5046.520580544842;5081.771320290577;5087.771050302746;5095.566876815476;4354.216241076605;4400.4939431965095;4400.9559904401185;4401.075774087413;4401.317795741633;14451.349689264009;14618.049826761333;14885.553433396906;14890.181040042793;14897.47858824936;1958.1482055305846;2003;2012.7383440152832;2050.0979568989596;2083.677030060343;10032.097111259949;10188.388696678223;10324.122449591794;10468.633597824115;10501.894981050169;1590.506942847721;1733;1752.2377765671847;1765.0645158066245;1773.8314860088271;63084;64882.484988776014;65106.348936510505;65274.67362663204;65559.3444065558;7067.787966361017;7107.538010029331;7141.428685705131;7170.569765814068;7217.675204615805;8646.697365592174;8649.437786543855;8714.259287960595;8719.782005449788;8723.171298726611;5579.38626751057;5619.381867994517;5620.9437905621235;5647.350554686182;5685.147227915763;5687.886242275132;5699.202111704365;5815.9709201453725;5827.621204621686;5847.853803654858;3293.489509126089;3347.581552305962;3350;3367.343368043208;3375.341808347349;1132.592266783957;1162.593092417647;1166.055495049013;1177.5760726138583;1194.1342526668095;482.9227323628203;494.94308154561963;497.5124378109473;510.01312460389266;518.7380372911731;12243.08176886737;12331.594850367375;12429.813552796715;12610.81083783744;12670.303133327756;444.7153821554208;503.08187557707333;504.7299694663337;522.7464679630376;530.6656806212139;6521;6592.80221593353;6714.865702685919;6726.293739157318;6750.189977202767;570228;572409;573798.1310093423;574784;579695;77037.61481192558;78088.60955695185;79243.60378198072;80033.59983200047;80522.58432247041;566.6401834834827;579.5161040531203;586.1588620329841;589.3428826858108;590.1207201269991;11366.829497557708;11577.247478913843;11861.466234019663;11924.76150477003;11928.343941083323;36843.26313473662;36942.44586331261;37162.442563362114;37614.81192594129;37819;49941;51048.48951510586;51214.74392628013;52023;52464.65494830803;6669.46644268467;6871.381575658214;6926.272741362286;7013.544119632412;7015.088038554955;12185.939070304947;12441.129120961446;12584.370781460708;12648.620541383772;12650;10738.46307684597;10855.511501982588;11157.21899467062;11170.441477926233;11192.552297907992;10551.261411701107;10733.677989660322;10863.022327990519;10910.127189824636;10954.945225273823;11398.487068081791;11444.542218311175;11617.941910290732;11708;11716.824247636121;7009.369156775914;7047.08387909589;7090.503664743418;7092.25531319204;7094.716211351488;10582.629607963685;11000.559977601126;11131.666050018512;11340;11357.716057098309 10:20:04 INFO - 2015-11-12 10:20:04,194 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.0534058202745;1658.9253483593236;1727.3695101288026;1738.5132162994357;1755.7278621813616;6342.809715708525;7182.353588177063;7422.443316751252;7449.739259125919;7490;7189.209186989427;7366.815829604263;7367.594782286972;7384.22465641108;7388.519746216505;2226.1206823304783;2229.1752051740878;2251.549690061994;2252.538229662915;2253.763354847734;2246.4159318577126;2253.4704344479114;2289.1301305503885;2296.5292115116363;2300.217925905192;2200.8239340852692;2213.2032468311395;2214.446388402899;2221.4113259986116;2251.628481300592;2211.281333566581;2225.9888700556394;2230.542738738563;2237.7650346713604;2241.237979087102;2226.1206823304865;2241.9887900560557;2246.70792796937;2246.9213577524706;2251.594712951668;6198.752049917998;6400.359964003563;7274.927250727478;7312.670929808171;7332.340089391927;4179.791010449496;4315.805788739514;4337.501187363462;4341.913161736779;4362.2366085935155;2910.8544572771275;2924.7952643314975;2989.8505074746176;2990;3055.572219889217;973.8928717841031;978.5792109392958;996.1632228927735;1004.1213937804421;1006.4112494190907;9405.341626086176;9445;9448.433094014312;9480.905190948071;9485.857712134324;3866.3620502617314;3909.3158697227873;3958.6239307265764;3965.2466031453932;3968.206358728208;8427.367947403969;8447.704330348408;8452.239298463168;8462.492250464991;8475;4283.5502272260965;4300.6989510734575;4304.117655880599;4305.56944305567;4308.655307575386;3903.902402439962;3926.2147570486018;3927.136030073379;3929.03738584043;3932.528096628423;3491.720662347006;3503.8773642922374;3534.823258837048;3553.911152221215;3562.5012498250267;1117.6144230240554;1127.9661610151709;1133.0482394788417;1133.240728711765;1137.141458199071;1060.1995493402585;1085.9511321990528;1237.9876201238053;1286.0547497589264;1286.2861112082696;6873.931260687329;6908.792736217922;6911;6923.792286231421;6938.687759050855;1128.2497139402205;1131.4964840645998;1135.8523391958993;1141.1099342512853;1156.1964434717959;5296.417394086648;5510.283663123849;5552.7223638817895;5562.16567514876;5572.498475137257;8136.982877140357;8392.916070839336;8660.437071590326;8796.47221166732;8805.559722013873;7740.8838867417035;7777.844443111106;7793.493422927491;7820.882686759704;7861.842763144705;6516.674166291667;6758.76344327956;6814.352636499525;6816.352446517573;6821.283765204681;6869.416099631588;6886.345797149263;6956.2695916928;6965.582065076112;6981.720731170696;7585.924140758742;7783.883241751265;7828.765137045898;7865.921340786747;7885.881711774443;7982.800429989296;8092.6762929482165;8093.109757926505;8093.35253179756;8220.794480138044;6976.686049127903;7190.676419561028;7198.74804381865;7204.747833825791;7209.783706488814;7296.124465064227;7329.780106596811;7366.631668416665;7374.188839227788;7379.704811807467;6586.407223349922;6828.214755303204;6861.588304701734;6910.585364878123;7007.824804379931;6774.3225677431865;6794.626295553792;6824.829379265359;6829.317068293131;6892.896606551006;6370.840728981812;6466.935330646634;6493.350664933658;6667.49993750461;6685.197776266879;6095.969520152371;6296.275928268308;6308.495320374451;6318.241810982711;6322.178116844781;6093.878122437438;6351.555391122577;6377.553571250153;6391.009393544008;6396.168498095218 10:20:04 INFO - 2015-11-12 10:20:04,195 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.30938697318015;332.40997229916894;332.50456819339195;334.4297971957812;336.11433871747954;5672.801451949183;5768.163616275638;5776.104703770911;5801.158831969362;5828;5592.916106258399;5702.8289151325525;5717.2281741964825;5717.256756621644;5727.198192253088;4431.401760762288;4431.734095954237;4435.024294655179;4437.334399840018;4443.577860103301;4283.250431174532;4347.804348804296;4365.301551751721;4407.735535867842;4422.579854913778;4388.758618275993;4417.73493590384;4422.933655995163;4428.047969686517;4428.623566996809;4377.606015458592;4405.273129933557;4422.800973956164;4424.269995450747;4426.535213802553;3873.573906870242;3904.3752999520225;3911.5306163260307;3918.0596656802445;3920.2159568086495;5354.464553544653;5450.972745136249;5460.153676180198;5527.695976721278;5538.196961440569;5187.662801917863;5189.558887494568;5190;5190.247414124969;5193.9740301298625;6049.334573196945;6060.030395136801;6086.2087928569;6100.23747031621;6104.938950610526;4177.4569305990335;4227.387028880826;4262.573742625744;4335.653147748204;4338.457692788402;6256.249250090018;6259.561830671855;6277.591956522811;6278.372162783685;6281.780137695158;4411.426514553087;4422.778861056934;4423.60187583119;4423.867283981485;4426.313921342197;4401.977990110093;4473.217186992263;4475.843345482893;4477.753723545171;4479.776011199427;5162.148245539444;5163.66436181647;5165.74171291434;5168.379794424618;5170.741462926839;6141.07883817431;6142.969285153546;6149.877002459926;6153.107799369066;6164.106204600308;1583.6753465539537;1618.287953300544;1618.336482042357;1620.335662378419;1620.813606435275;1061.741835924432;1078.1321036565482;1080.4273734920505;1096.736783172033;1107.341132026443;5999.100134979701;6001.339852616209;6002.249718785152;6002.54980876436;6012.188354572077;6300.338464461165;6310.085037669604;6310.873782524323;6313.77901773445;6317.305096439388;5988.37122102173;5991.310999235056;5993.700314984233;5999.820005399845;6003.279606447254;3440.7935523868646;3498.2653642734804;3507.824608769551;3512.877049303262;3521.29574085184;6518.641474718936;6573.816712991707;6577.276499585042;6580.670966451658;6581.2760596334365;6523.478121750249;6523.836904077436;6538.051982462516;6539.215294164731;6552.770653027121;6501.024846273002;6574.276829548746;6583.012548117821;6588.439982601437;6589.80230593083;6286.214223222098;6303.338149494237;6345.46063584582;6382.266039405527;6384.553081284265;6032.4570788629235;6108.541859360655;6153.907691384722;6238.812835614939;6242.813865365566;6511.73953041873;6554.082428459924;6566.343365663395;6567.737290508326;6590.8352291193105;4427.3358996149545;4505.954940450684;4507.098580284022;4509.849988252974;4510.939929116721;6151.169592105188;6295.464885484785;6322.589031712924;6326.4622507087415;6354.26925903527;6125.173101631401;6134;6144.016957286813;6151.907721384094;6155.569110162246;6126.203593532812;6127.356627554221;6131.63210207389;6132.41742034506;6133.141360209485;5916.852078698067;6018.247719035121;6036.0644100164545;6040.969795150996;6044.214252147192;6174.938250617436;6176.011838105882;6178.227721534809;6178.6292822429;6187.969060154851;6008.54935879802;6024;6027.57806953509;6030.698465076816;6036.8188954331445 10:20:04 INFO - 2015-11-12 10:20:04,196 DEBUG : BROWSER_OUTPUT: |5;yui.html;688.6453476459623;715.3490323805335;738.5125816960807;751.5528260684897;786.8859015442757;14321.140731556101;14617.634559136;14644.194569298685;14716.852831471682;14738.63153421165;13986.860131398684;14048;14055.297235138254;14060.367283472242;14066.578002659911;670.795407400745;677.7560078371782;808.8099296665279;824.9935079203362;825.0429501777938;810.6797814863125;825.3273582030625;829.5105887526358;829.8589239829213;830.3440282177073;858.8067684770939;869.7695110795644;869.8738682890977;870.2428886868433;871.2898987325341;706.7279097547456;715.7673756029285;842.9747107586783;855.1363123245504;863.1842908451484;625.3590070178059;627.4854619212248;628.4972022382121;628.5066223014957;629.0281515059245;12077.15459917806;12331.383430828513;12411.627651170389;12481.56314528987;12607.306598137098;9652.806943861153;9753;9821.263405244636;10662.680119596425;11016.669499915015;9189.540522973824;9297.125394419683;9501.857472137923;9749.853752193723;9884.604615815359;3077.692230776927;3114.470540008204;3163.2882601414726;3192.632847222576;3233.304839459504;47930;48162.51837481651;48638.513614863754;48717.75641121772;48876;7633.923660763321;7700.383969282444;7769.805754856174;7965.681372745141;8042.919570804334;12230.388480575935;12318.199317044364;12323.568675096329;12396.81404778929;12399;6450.032495125769;6674;6675.566088204251;6867.931320686729;6990.510664253454;4457.732536047847;4481.887952801206;4533.546645335506;4564.84023059198;4583.495815460296;2783.178962206154;2786.484500367398;2794.0779542750843;2802.9859850701023;2809.269589906639;425.84882366759354;426.7162337045892;433.5014733056947;440.65408654206294;443.4191209515545;599.5383554662885;640.225327353907;649.1885143570537;657.1916542652564;690.848013437043;7774.727884524014;8486.363522735695;8913.197812196804;9158.86261706075;9450.90549094514;527.3539913605879;572.5562688916124;655.4003087175181;659.4592434203906;669.7689297192461;3938.133610605662;3949;4027.496562929634;4045.3527435610163;4169.124483858363;60688;61221.38778612246;61592.38407615866;62061.689691551255;62231.377686223466;53109.46890531122;53197;53266.467335326925;54480.18279725807;54679.72660136674;47197.8200544996;47211.29183062257;47876.52123478721;48464;49262.26106608404;8901.51041692713;9043.773905652411;9076.137766912132;9114.589843457194;9273.119053689888;37920.81039594785;38579.80710096432;38876.63931762375;39462.80268598639;39602.801985989885;50222;50525;50816.745916270185;51423;51836;8109.8378032440205;8133.715319963773;8163.061247956323;8178.386621003568;8199.836003280021;12401.25592464455;12511.499540018298;12742.426590803621;12780.233186008869;12955.870441295467;10696.14430845515;10842.620508282173;11056.889431105586;11310.434478275889;11320.150988675718;11492.310461372344;11500.884991149982;12098.576549820715;12455.937720311704;12534.811977820158;11491.367974761468;11688.94155529217;11741.29552226869;11763.411829408666;11768.646940591796;10184.541695623566;10380.636677716244;10411.975358854277;10564;10607.363558186533;9293.86059209126;9337.813243735223;9558.56986435598;10076.294659373774;10497.47512624381 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,788 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352404185__endTimestamp 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,197 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5557.91 Median:5771.37 stddev:632.53 (11.0%) stddev-sans-first:606.74 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: Values: 3196.7 3296.8 3348.4 3353.7 3359.8 5347.9 5423.3 5434.1 5469.7 5473.9 5473.7 5480.2 5523.5 5525.1 5547.4 4973.8 4987.5 5101.8 5178.6 5223.3 4901.0 5158.4 5182.2 5201.9 5229.9 4949.3 5017.5 5026.0 5029.0 5076.9 5039.1 5053.5 5053.5 5054.8 5080.8 4852.2 5052.0 5065.8 5072.8 5087.2 5232.2 5293.3 5329.6 5347.7 5378.9 5962.8 5986.3 5986.9 5992.6 5999.9 5832.9 5948.9 5993.5 5994.7 6024.1 5539.3 5623.6 5625.0 5633.0 5677.7 6158.0 6159.8 6173.9 6175.9 6175.9 5701.1 5819.5 5853.9 5913.7 5959.4 6018.8 6021.4 6029.4 6031.6 6074.5 5988.5 5991.8 5993.5 5994.5 5998.5 5709.8 5819.3 5868.9 5983.7 5984.0 4615.7 4637.5 4660.5 4662.0 4675.0 4108.9 4120.2 4120.6 4126.3 4165.1 5567.6 5648.0 5693.2 5705.9 5776.5 5989.6 6079.5 6088.7 6092.8 6092.9 5763.2 5763.8 5768.6 5771.4 5780.5 5113.1 5148.8 5181.4 5216.1 5249.0 6312.3 6361.7 6364.7 6366.4 6370.6 5774.7 6064.5 6074.4 6078.2 6079.3 6145.7 6209.9 6345.7 6367.7 6369.6 5932.0 5937.2 5943.7 5948.3 6005.9 5794.4 5902.9 6009.7 6015.9 6019.1 5735.7 5824.7 5825.0 5833.2 5858.2 5762.0 5798.0 5819.8 5823.7 5826.9 5556.5 5604.9 5686.5 5739.1 5739.9 5853.9 5915.9 5927.2 5928.1 5937.8 5766.3 5784.1 5789.3 5796.3 5840.8 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52515.04 Median:3362.08 stddev:96311.30 (2864.6%) stddev-sans-first:96502.52 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: Values: 572.9 590.6 597.3 610.8 623.5 32522.8 33061.5 42099.8 42574.0 42724.1 44040.0 44443.0 44503.1 44555.1 44652.3 7591.4 8654.5 8813.4 8821.1 8844.6 7742.7 10455.0 10509.3 10584.3 10671.4 10273.6 10364.9 10379.8 10384.2 10384.6 7936.3 8096.9 10295.6 10386.0 10522.9 10113.4 10155.3 10162.4 10221.5 10236.5 40623.4 41067.0 41130.0 41138.6 41145.1 2862.3 2987.2 2998.0 3026.3 3066.3 30638.7 30788.4 30892.1 30970.2 31197.7 3301.2 3336.1 3342.8 3381.3 3437.6 281888.0 284776.0 285547.0 285756.0 285833.0 53839.7 55099.2 63296.0 63709.0 68352.3 64443.4 64520.7 64825.4 64836.7 64914.4 15484.6 15660.5 15698.7 15705.8 15706.2 11285.2 11327.5 11355.1 11366.8 11399.9 20195.2 20273.4 20370.8 20376.4 20433.8 7758.6 7878.9 7910.7 7933.0 8018.6 875.8 962.4 1053.1 1068.2 1127.9 26293.0 27097.2 27418.9 27641.2 28028.2 1047.3 1089.0 1109.1 1124.1 1131.9 14288.8 14386.4 14475.7 14509.3 14672.3 344715.0 349012.0 350510.0 351948.0 353385.0 46973.3 53694.0 54166.7 54167.0 54207.5 1226.7 1261.2 1321.1 1337.3 1337.6 26766.5 27313.5 27853.9 28905.1 29432.7 44863.3 45162.5 45915.5 45983.3 46159.3 434429.0 442890.0 445705.0 446821.0 447528.0 31435.4 31825.7 31920.5 32044.2 32075.7 44438.3 44951.3 45057.3 45357.0 45928.8 36242.0 36966.4 37821.6 37853.2 38647.0 37115.8 37456.6 38547.6 38616.0 38770.4 36647.8 37499.0 37610.0 37662.0 37675.4 32434.7 34036.0 34100.1 34473.0 34597.3 25335.0 25519.6 25734.6 25912.4 26128.5 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,198 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28495.86 Median:4401.20 stddev:94124.31 (2138.6%) stddev-sans-first:94364.62 10:20:04 INFO - 2015-11-12 10:20:04,199 DEBUG : BROWSER_OUTPUT: Values: 348.1 349.7 352.7 353.4 357.6 14449.1 14564.0 17547.9 18026.3 18999.0 11766.1 12082.9 16260.1 16695.2 16771.7 4597.6 4702.8 4706.0 4709.6 4712.5 3630.1 3699.4 4676.3 4718.6 5025.0 5044.0 5064.4 5093.0 5101.5 5115.3 4971.9 5046.5 5081.8 5087.8 5095.6 4354.2 4400.5 4401.0 4401.1 4401.3 14451.3 14618.0 14885.6 14890.2 14897.5 1958.1 2003.0 2012.7 2050.1 2083.7 10032.1 10188.4 10324.1 10468.6 10501.9 1590.5 1733.0 1752.2 1765.1 1773.8 63084.0 64882.5 65106.3 65274.7 65559.3 7067.8 7107.5 7141.4 7170.6 7217.7 8646.7 8649.4 8714.3 8719.8 8723.2 5579.4 5619.4 5620.9 5647.4 5685.1 5687.9 5699.2 5816.0 5827.6 5847.9 3293.5 3347.6 3350.0 3367.3 3375.3 1132.6 1162.6 1166.1 1177.6 1194.1 482.9 494.9 497.5 510.0 518.7 12243.1 12331.6 12429.8 12610.8 12670.3 444.7 503.1 504.7 522.7 530.7 6521.0 6592.8 6714.9 6726.3 6750.2 570228.0 572409.0 573798.1 574784.0 579695.0 77037.6 78088.6 79243.6 80033.6 80522.6 566.6 579.5 586.2 589.3 590.1 11366.8 11577.2 11861.5 11924.8 11928.3 36843.3 36942.4 37162.4 37614.8 37819.0 49941.0 51048.5 51214.7 52023.0 52464.7 6669.5 6871.4 6926.3 7013.5 7015.1 12185.9 12441.1 12584.4 12648.6 12650.0 10738.5 10855.5 11157.2 11170.4 11192.6 10551.3 10733.7 10863.0 10910.1 10954.9 11398.5 11444.5 11617.9 11708.0 11716.8 7009.4 7047.1 7090.5 7092.3 7094.7 10582.6 11000.6 11131.7 11340.0 11357.7 10:20:04 INFO - 2015-11-12 10:20:04,200 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,200 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5146.03 Median:6361.20 stddev:2565.92 (40.3%) stddev-sans-first:2558.32 10:20:04 INFO - 2015-11-12 10:20:04,200 DEBUG : BROWSER_OUTPUT: Values: 1479.1 1658.9 1727.4 1738.5 1755.7 6342.8 7182.4 7422.4 7449.7 7490.0 7189.2 7366.8 7367.6 7384.2 7388.5 2226.1 2229.2 2251.5 2252.5 2253.8 2246.4 2253.5 2289.1 2296.5 2300.2 2200.8 2213.2 2214.4 2221.4 2251.6 2211.3 2226.0 2230.5 2237.8 2241.2 2226.1 2242.0 2246.7 2246.9 2251.6 6198.8 6400.4 7274.9 7312.7 7332.3 4179.8 4315.8 4337.5 4341.9 4362.2 2910.9 2924.8 2989.9 2990.0 3055.6 973.9 978.6 996.2 1004.1 1006.4 9405.3 9445.0 9448.4 9480.9 9485.9 3866.4 3909.3 3958.6 3965.2 3968.2 8427.4 8447.7 8452.2 8462.5 8475.0 4283.6 4300.7 4304.1 4305.6 4308.7 3903.9 3926.2 3927.1 3929.0 3932.5 3491.7 3503.9 3534.8 3553.9 3562.5 1117.6 1128.0 1133.0 1133.2 1137.1 1060.2 1086.0 1238.0 1286.1 1286.3 6873.9 6908.8 6911.0 6923.8 6938.7 1128.2 1131.5 1135.9 1141.1 1156.2 5296.4 5510.3 5552.7 5562.2 5572.5 8137.0 8392.9 8660.4 8796.5 8805.6 7740.9 7777.8 7793.5 7820.9 7861.8 6516.7 6758.8 6814.4 6816.4 6821.3 6869.4 6886.3 6956.3 6965.6 6981.7 7585.9 7783.9 7828.8 7865.9 7885.9 7982.8 8092.7 8093.1 8093.4 8220.8 6976.7 7190.7 7198.7 7204.7 7209.8 7296.1 7329.8 7366.6 7374.2 7379.7 6586.4 6828.2 6861.6 6910.6 7007.8 6774.3 6794.6 6824.8 6829.3 6892.9 6370.8 6466.9 6493.4 6667.5 6685.2 6096.0 6296.3 6308.5 6318.2 6322.2 6093.9 6351.6 6377.6 6391.0 6396.2 10:20:04 INFO - 2015-11-12 10:20:04,200 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,201 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5147.12 Median:5952.61 stddev:1530.66 (25.7%) stddev-sans-first:1491.25 10:20:04 INFO - 2015-11-12 10:20:04,201 DEBUG : BROWSER_OUTPUT: Values: 308.3 332.4 332.5 334.4 336.1 5672.8 5768.2 5776.1 5801.2 5828.0 5592.9 5702.8 5717.2 5717.3 5727.2 4431.4 4431.7 4435.0 4437.3 4443.6 4283.3 4347.8 4365.3 4407.7 4422.6 4388.8 4417.7 4422.9 4428.0 4428.6 4377.6 4405.3 4422.8 4424.3 4426.5 3873.6 3904.4 3911.5 3918.1 3920.2 5354.5 5451.0 5460.2 5527.7 5538.2 5187.7 5189.6 5190.0 5190.2 5194.0 6049.3 6060.0 6086.2 6100.2 6104.9 4177.5 4227.4 4262.6 4335.7 4338.5 6256.2 6259.6 6277.6 6278.4 6281.8 4411.4 4422.8 4423.6 4423.9 4426.3 4402.0 4473.2 4475.8 4477.8 4479.8 5162.1 5163.7 5165.7 5168.4 5170.7 6141.1 6143.0 6149.9 6153.1 6164.1 1583.7 1618.3 1618.3 1620.3 1620.8 1061.7 1078.1 1080.4 1096.7 1107.3 5999.1 6001.3 6002.2 6002.5 6012.2 6300.3 6310.1 6310.9 6313.8 6317.3 5988.4 5991.3 5993.7 5999.8 6003.3 3440.8 3498.3 3507.8 3512.9 3521.3 6518.6 6573.8 6577.3 6580.7 6581.3 6523.5 6523.8 6538.1 6539.2 6552.8 6501.0 6574.3 6583.0 6588.4 6589.8 6286.2 6303.3 6345.5 6382.3 6384.6 6032.5 6108.5 6153.9 6238.8 6242.8 6511.7 6554.1 6566.3 6567.7 6590.8 4427.3 4506.0 4507.1 4509.8 4510.9 6151.2 6295.5 6322.6 6326.5 6354.3 6125.2 6134.0 6144.0 6151.9 6155.6 6126.2 6127.4 6131.6 6132.4 6133.1 5916.9 6018.2 6036.1 6041.0 6044.2 6174.9 6176.0 6178.2 6178.6 6188.0 6008.5 6024.0 6027.6 6030.7 6036.8 10:20:04 INFO - 2015-11-12 10:20:04,201 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,201 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13991.02 Median:50670.87 stddev:17099.00 (33.7%) stddev-sans-first:17117.79 10:20:04 INFO - 2015-11-12 10:20:04,201 DEBUG : BROWSER_OUTPUT: Values: 688.6 715.3 738.5 751.6 786.9 14321.1 14617.6 14644.2 14716.9 14738.6 13986.9 14048.0 14055.3 14060.4 14066.6 670.8 677.8 808.8 825.0 825.0 810.7 825.3 829.5 829.9 830.3 858.8 869.8 869.9 870.2 871.3 706.7 715.8 843.0 855.1 863.2 625.4 627.5 628.5 628.5 629.0 12077.2 12331.4 12411.6 12481.6 12607.3 9652.8 9753.0 9821.3 10662.7 11016.7 9189.5 9297.1 9501.9 9749.9 9884.6 3077.7 3114.5 3163.3 3192.6 3233.3 47930.0 48162.5 48638.5 48717.8 48876.0 7633.9 7700.4 7769.8 7965.7 8042.9 12230.4 12318.2 12323.6 12396.8 12399.0 6450.0 6674.0 6675.6 6867.9 6990.5 4457.7 4481.9 4533.5 4564.8 4583.5 2783.2 2786.5 2794.1 2803.0 2809.3 425.8 426.7 433.5 440.7 443.4 599.5 640.2 649.2 657.2 690.8 7774.7 8486.4 8913.2 9158.9 9450.9 527.4 572.6 655.4 659.5 669.8 3938.1 3949.0 4027.5 4045.4 4169.1 60688.0 61221.4 61592.4 62061.7 62231.4 53109.5 53197.0 53266.5 54480.2 54679.7 47197.8 47211.3 47876.5 48464.0 49262.3 8901.5 9043.8 9076.1 9114.6 9273.1 37920.8 38579.8 38876.6 39462.8 39602.8 50222.0 50525.0 50816.7 51423.0 51836.0 8109.8 8133.7 8163.1 8178.4 8199.8 12401.3 12511.5 12742.4 12780.2 12955.9 10696.1 10842.6 11056.9 11310.4 11320.2 11492.3 11500.9 12098.6 12455.9 12534.8 11491.4 11688.9 11741.3 11763.4 11768.6 10184.5 10380.6 10412.0 10564.0 10607.4 9293.9 9337.8 9558.6 10076.3 10497.5 10:20:04 INFO - 2015-11-12 10:20:04,202 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:20:04 INFO - 2015-11-12 10:20:04,202 DEBUG : BROWSER_OUTPUT: 10:20:04 INFO - 2015-11-12 10:20:04,907 INFO : Browser exited with error code: 0 10:20:04 INFO - 2015-11-12 10:20:04,925 INFO : Completed test dromaeo_css (00:18:32) 10:20:04 INFO - 2015-11-12 10:20:04,926 INFO : Starting test kraken 10:20:04 INFO - 2015-11-12 10:20:04,926 DEBUG : operating with platform_type : linux_ 10:20:04 INFO - 2015-11-12 10:20:04,926 INFO : Initialising browser for kraken test... 10:20:04 INFO - 2015-11-12 10:20:04,932 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJanOma/profile http://localhost:37959/getInfo.html 10:20:08 INFO - 2015-11-12 10:20:08,608 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:20:08 INFO - 2015-11-12 10:20:08,608 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:20:08 INFO - 2015-11-12 10:20:08,608 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:20:08 INFO - 2015-11-12 10:20:08,608 DEBUG : BROWSER_OUTPUT: __metrics 10:20:08 INFO - 2015-11-12 10:20:08,731 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:20:09 INFO - 2015-11-12 10:20:09,852 INFO : Browser initialized. 10:20:09 INFO - 2015-11-12 10:20:09,852 INFO : Running cycle 1/1 for kraken test... 10:20:09 INFO - 2015-11-12 10:20:09,853 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJanOma/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:20:21 INFO - 2015-11-12 10:20:21,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 141303808 10:20:21 INFO - 2015-11-12 10:20:21,610 DEBUG : BROWSER_OUTPUT: 10:20:24 INFO - 2015-11-12 10:20:24,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-beat-detection) 10:20:24 INFO - 2015-11-12 10:20:24,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 181571584 10:20:24 INFO - 2015-11-12 10:20:24,638 DEBUG : BROWSER_OUTPUT: 10:20:27 INFO - 2015-11-12 10:20:27,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-dft) 10:20:27 INFO - 2015-11-12 10:20:27,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 169168896 10:20:27 INFO - 2015-11-12 10:20:27,808 DEBUG : BROWSER_OUTPUT: 10:20:30 INFO - 2015-11-12 10:20:30,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-fft) 10:20:31 INFO - 2015-11-12 10:20:31,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 149409792 10:20:31 INFO - 2015-11-12 10:20:31,221 DEBUG : BROWSER_OUTPUT: 10:20:33 INFO - 2015-11-12 10:20:33,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-oscillator) 10:20:33 INFO - 2015-11-12 10:20:33,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 152961024 10:20:33 INFO - 2015-11-12 10:20:33,750 DEBUG : BROWSER_OUTPUT: 10:20:35 INFO - 2015-11-12 10:20:35,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:36 INFO - 2015-11-12 10:20:36,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 154259456 10:20:36 INFO - 2015-11-12 10:20:36,500 DEBUG : BROWSER_OUTPUT: 10:20:39 INFO - 2015-11-12 10:20:39,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:39 INFO - 2015-11-12 10:20:39,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 155791360 10:20:39 INFO - 2015-11-12 10:20:39,979 DEBUG : BROWSER_OUTPUT: 10:20:43 INFO - 2015-11-12 10:20:43,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:43 INFO - 2015-11-12 10:20:43,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 157638656 10:20:43 INFO - 2015-11-12 10:20:43,947 DEBUG : BROWSER_OUTPUT: 10:20:46 INFO - 2015-11-12 10:20:46,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37959/tests/kraken/driver.html?testName=json-parse-financial) 10:20:47 INFO - 2015-11-12 10:20:47,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 156925952 10:20:47 INFO - 2015-11-12 10:20:47,330 DEBUG : BROWSER_OUTPUT: 10:20:48 INFO - 2015-11-12 10:20:48,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:49 INFO - 2015-11-12 10:20:49,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 162758656 10:20:49 INFO - 2015-11-12 10:20:49,455 DEBUG : BROWSER_OUTPUT: 10:20:51 INFO - 2015-11-12 10:20:51,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:51 INFO - 2015-11-12 10:20:51,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 161935360 10:20:51 INFO - 2015-11-12 10:20:51,826 DEBUG : BROWSER_OUTPUT: 10:20:53 INFO - 2015-11-12 10:20:53,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:54 INFO - 2015-11-12 10:20:54,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 173617152 10:20:54 INFO - 2015-11-12 10:20:54,439 DEBUG : BROWSER_OUTPUT: 10:20:56 INFO - 2015-11-12 10:20:56,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:57 INFO - 2015-11-12 10:20:57,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 180801536 10:20:57 INFO - 2015-11-12 10:20:57,447 DEBUG : BROWSER_OUTPUT: 10:20:59 INFO - 2015-11-12 10:20:59,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:00 INFO - 2015-11-12 10:21:00,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 178880512 10:21:00 INFO - 2015-11-12 10:21:00,565 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37959/tests/kraken/driver.html?testName=ai-astar) 10:21:02 INFO - 2015-11-12 10:21:02,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 237780992 10:21:02 INFO - 2015-11-12 10:21:02,498 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,501 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:21:02 INFO - 2015-11-12 10:21:02,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:21:02 INFO - 2015-11-12 10:21:02,502 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:21:02 INFO - 2015-11-12 10:21:02,502 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:21:02 INFO - 2015-11-12 10:21:02,502 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;109;110;109;101;109;115;108 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;147;163;124;148;158;128;162;124 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;160;159;161;161;162;159;161 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;84;95;72;73;72;114;88;72 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;146;90;90;91;134;90;91;132 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;111;110;112;109;109 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;147;145;146;146;145;146;144;146 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;95;96;96 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;60;59;60;59;63;68;58;57 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;66;66;67;68;67;67;66;67 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;84;85;84;84;85;85;85;85;85 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;124;119;115;131;115;128;124;123;121 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;160;144;152;145;135;145;144;144;136 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;65;65;64;65;66;63;66 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:21:02 INFO - 2015-11-12 10:21:02,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 10:21:02 INFO - 2015-11-12 10:21:02,504 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:21:02 INFO - 2015-11-12 10:21:02,504 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352462500__endTimestamp 10:21:02 INFO - 2015-11-12 10:21:02,504 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:3.92 (3.6%) stddev-sans-first:4.15 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 109.0 110.0 109.0 101.0 109.0 115.0 108.0 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.00 stddev:16.54 (11.1%) stddev-sans-first:17.33 10:21:02 INFO - 2015-11-12 10:21:02,505 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 147.0 163.0 124.0 148.0 158.0 128.0 162.0 124.0 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 160.0 159.0 161.0 161.0 162.0 159.0 161.0 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.00 stddev:14.19 (19.4%) stddev-sans-first:14.72 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 84.0 95.0 72.0 73.0 72.0 114.0 88.0 72.0 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.00 stddev:22.94 (25.5%) stddev-sans-first:23.72 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 146.0 90.0 90.0 91.0 134.0 90.0 91.0 132.0 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.94 (0.9%) stddev-sans-first:0.93 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 111.0 110.0 112.0 109.0 109.0 10:21:02 INFO - 2015-11-12 10:21:02,506 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 147.0 145.0 146.0 146.0 145.0 146.0 144.0 146.0 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:3.13 (5.2%) stddev-sans-first:3.32 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 60.0 59.0 60.0 59.0 63.0 68.0 58.0 57.0 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 66.0 67.0 68.0 67.0 67.0 66.0 67.0 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,507 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.75 (2.1%) stddev-sans-first:0.50 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: Values: 90.0 84.0 85.0 84.0 84.0 85.0 85.0 85.0 85.0 85.0 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:123.50 stddev:5.72 (4.6%) stddev-sans-first:5.40 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: Values: 114.0 124.0 119.0 115.0 131.0 115.0 128.0 124.0 123.0 121.0 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:144.50 stddev:7.57 (5.2%) stddev-sans-first:7.57 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: Values: 137.0 160.0 144.0 152.0 145.0 135.0 145.0 144.0 144.0 136.0 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 65.0 65.0 64.0 65.0 66.0 63.0 66.0 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:21:02 INFO - 2015-11-12 10:21:02,509 DEBUG : BROWSER_OUTPUT: 10:21:03 INFO - 2015-11-12 10:21:03,325 INFO : Browser exited with error code: 0 10:21:03 INFO - 2015-11-12 10:21:03,372 INFO : Completed test kraken (00:00:58) 10:21:03 INFO - 2015-11-12 10:21:03,372 INFO : Starting test v8_7 10:21:03 INFO - 2015-11-12 10:21:03,372 DEBUG : operating with platform_type : linux_ 10:21:03 INFO - 2015-11-12 10:21:03,372 INFO : Initialising browser for v8_7 test... 10:21:03 INFO - 2015-11-12 10:21:03,378 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWTBNr/profile http://localhost:37959/getInfo.html 10:21:07 INFO - 2015-11-12 10:21:07,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:21:07 INFO - 2015-11-12 10:21:07,052 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:21:07 INFO - 2015-11-12 10:21:07,052 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:21:07 INFO - 2015-11-12 10:21:07,052 DEBUG : BROWSER_OUTPUT: __metrics 10:21:07 INFO - 2015-11-12 10:21:07,168 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:08 INFO - 2015-11-12 10:21:08,199 INFO : Browser initialized. 10:21:08 INFO - 2015-11-12 10:21:08,200 INFO : Running cycle 1/1 for v8_7 test... 10:21:08 INFO - 2015-11-12 10:21:08,200 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOWTBNr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:21:19 INFO - 2015-11-12 10:21:19,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 141520896 10:21:19 INFO - 2015-11-12 10:21:19,963 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37959/tests/v8_7/run.html (next: http://localhost:37959/tests/v8_7/run.html) 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 605413376 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:21:41 INFO - 2015-11-12 10:21:41,638 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |0;Richards;170.64846416382252 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.040616773223 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.2058906825262 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1974.3589743589744 10:21:41 INFO - 2015-11-12 10:21:41,639 DEBUG : BROWSER_OUTPUT: |5;Earley;766.8711656441718 10:21:41 INFO - 2015-11-12 10:21:41,640 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 10:21:41 INFO - 2015-11-12 10:21:41,640 DEBUG : BROWSER_OUTPUT: |7;RegExp;25400 10:21:41 INFO - 2015-11-12 10:21:41,640 DEBUG : BROWSER_OUTPUT: |8;Splay;625.2330640149161 10:21:41 INFO - 2015-11-12 10:21:41,640 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 10:21:41 INFO - 2015-11-12 10:21:41,640 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:21:41 INFO - 2015-11-12 10:21:41,641 DEBUG : BROWSER_OUTPUT: __startTimestamp1447352501637__endTimestamp 10:21:41 INFO - 2015-11-12 10:21:41,641 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,641 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:21:41 INFO - 2015-11-12 10:21:41,641 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:21:41 INFO - 2015-11-12 10:21:41,642 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,642 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.65 Median:170.65 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: Values: 170.6 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: Values: 188.0 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.21 Median:283.21 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: Values: 283.2 10:21:41 INFO - 2015-11-12 10:21:41,643 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: Values: 5040.2 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: Values: 1974.4 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,644 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:766.87 Median:766.87 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: Values: 766.9 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: Values: 12108.4 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25400.00 Median:25400.00 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: Values: 25400.0 10:21:41 INFO - 2015-11-12 10:21:41,645 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:625.23 Median:625.23 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: Values: 625.2 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: Values: 4826.9 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:21:41 INFO - 2015-11-12 10:21:41,646 DEBUG : BROWSER_OUTPUT: 10:21:42 INFO - 2015-11-12 10:21:42,491 INFO : Browser exited with error code: 0 10:21:42 INFO - 2015-11-12 10:21:42,505 INFO : Completed test v8_7 (00:00:39) 10:21:42 INFO - 2015-11-12 10:21:42,613 INFO : Completed test suite (00:20:09) 10:21:42 INFO - 2015-11-12 10:21:42,614 DEBUG : Working with test: dromaeo_css 10:21:42 INFO - 2015-11-12 10:21:42,614 DEBUG : Generating results file: dromaeo_css 10:21:42 INFO - 2015-11-12 10:21:42,615 DEBUG : Working with test: kraken 10:21:42 INFO - 2015-11-12 10:21:42,615 DEBUG : Generating results file: kraken 10:21:42 INFO - 2015-11-12 10:21:42,615 INFO : javascript benchmark 10:21:42 INFO - 2015-11-12 10:21:42,615 DEBUG : Working with test: v8_7 10:21:42 INFO - 2015-11-12 10:21:42,615 DEBUG : Generating results file: v8_7 10:21:42 INFO - 2015-11-12 10:21:42,616 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - 2015-11-12 10:21:42,784 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 10:21:42 INFO - 2015-11-12 10:21:42,784 DEBUG : process_Request line: dromaeo_css 6721.03 graph.html#tests=[[72,64,35]] 10:21:42 INFO - 2015-11-12 10:21:42,784 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - 2015-11-12 10:21:42,899 DEBUG : process_Request line: kraken 1491.80 graph.html#tests=[[232,64,35]] 10:21:42 INFO - 2015-11-12 10:21:42,899 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:42 INFO - 2015-11-12 10:21:42,926 DEBUG : process_Request line: v8_7 19883.45 graph.html#tests=[[230,64,35]] 10:21:42 INFO - 2015-11-12 10:21:42,927 INFO : javascript benchmark 10:21:42 INFO - 2015-11-12 10:21:42,931 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [348.11404974340303, 349.74468637894336, 352.66672994020627, 353.3692359138937, 357.61020487668435, 14449.060811047275, 14564.0, 17547.912260438712, 18026.278948842046, 18999.0, 11766.117541184403, 12082.939585302061, 16260.105694186816, 16695.165241737894, 16771.748423773624, 4597.563231493003, 4702.811887524512, 4706.0, 4709.64677649176, 4712.481627021042, 3630.0743310455928, 3699.3896007158787, 4676.3453116563705, 4718.57532822046, 5025.0, 5043.974780126095, 5064.442911279756, 5093.0, 5101.464346243647, 5115.335006449156, 4971.900561988758, 5046.520580544842, 5081.771320290577, 5087.771050302746, 5095.566876815476, 4354.216241076605, 4400.4939431965095, 4400.9559904401185, 4401.075774087413, 4401.317795741633, 14451.349689264009, 14618.049826761333, 14885.553433396906, 14890.181040042793, 14897.47858824936, 1958.1482055305846, 2003.0, 2012.7383440152832, 2050.0979568989596, 2083.677030060343, 10032.097111259949, 10188.388696678223, 10324.122449591794, 10468.633597824115, 10501.894981050169, 1590.506942847721, 1733.0, 1752.2377765671847, 1765.0645158066245, 1773.8314860088271, 63084.0, 64882.484988776014, 65106.348936510505, 65274.67362663204, 65559.3444065558, 7067.787966361017, 7107.538010029331, 7141.428685705131, 7170.569765814068, 7217.675204615805, 8646.697365592174, 8649.437786543855, 8714.259287960595, 8719.782005449788, 8723.171298726611, 5579.38626751057, 5619.381867994517, 5620.9437905621235, 5647.350554686182, 5685.147227915763, 5687.886242275132, 5699.202111704365, 5815.9709201453725, 5827.621204621686, 5847.853803654858, 3293.489509126089, 3347.581552305962, 3350.0, 3367.343368043208, 3375.341808347349, 1132.592266783957, 1162.593092417647, 1166.055495049013, 1177.5760726138583, 1194.1342526668095, 482.9227323628203, 494.94308154561963, 497.5124378109473, 510.01312460389266, 518.7380372911731, 12243.08176886737, 12331.594850367375, 12429.813552796715, 12610.81083783744, 12670.303133327756, 444.7153821554208, 503.08187557707333, 504.7299694663337, 522.7464679630376, 530.6656806212139, 6521.0, 6592.80221593353, 6714.865702685919, 6726.293739157318, 6750.189977202767, 570228.0, 572409.0, 573798.1310093423, 574784.0, 579695.0, 77037.61481192558, 78088.60955695185, 79243.60378198072, 80033.59983200047, 80522.58432247041, 566.6401834834827, 579.5161040531203, 586.1588620329841, 589.3428826858108, 590.1207201269991, 11366.829497557708, 11577.247478913843, 11861.466234019663, 11924.76150477003, 11928.343941083323, 36843.26313473662, 36942.44586331261, 37162.442563362114, 37614.81192594129, 37819.0, 49941.0, 51048.48951510586, 51214.74392628013, 52023.0, 52464.65494830803, 6669.46644268467, 6871.381575658214, 6926.272741362286, 7013.544119632412, 7015.088038554955, 12185.939070304947, 12441.129120961446, 12584.370781460708, 12648.620541383772, 12650.0, 10738.46307684597, 10855.511501982588, 11157.21899467062, 11170.441477926233, 11192.552297907992, 10551.261411701107, 10733.677989660322, 10863.022327990519, 10910.127189824636, 10954.945225273823, 11398.487068081791, 11444.542218311175, 11617.941910290732, 11708.0, 11716.824247636121, 7009.369156775914, 7047.08387909589, 7090.503664743418, 7092.25531319204, 7094.716211351488, 10582.629607963685, 11000.559977601126, 11131.666050018512, 11340.0, 11357.716057098309], "dojo.html": [3196.71229589337, 3296.752743544235, 3348.4140275451805, 3353.6814002669753, 3359.8152101634414, 5347.866303342418, 5423.267858839055, 5434.103372943459, 5469.726513674315, 5473.91789123163, 5473.67157970522, 5480.177973303997, 5523.475269849368, 5525.0883604205355, 5547.389787123413, 4973.801047958095, 4987.476314986929, 5101.770420331075, 5178.637495375326, 5223.294855194557, 4900.9754951225195, 5158.3552055993005, 5182.248573956774, 5201.947980520203, 5229.921551176735, 4949.282354058641, 5017.52333528316, 5026.045051440215, 5029.019341228462, 5076.923846142311, 5039.09296326661, 5053.519915608012, 5053.545180933734, 5054.82308119214, 5080.77136528857, 4852.247901575226, 5051.974740126276, 5065.822696205652, 5072.771725272371, 5087.23691446286, 5232.241325007891, 5293.311869456985, 5329.626926115174, 5347.679139251619, 5378.865528361783, 5962.791302304398, 5986.311574168983, 5986.880262394728, 5992.640441573476, 5999.910001349983, 5832.941670583325, 5948.940510594925, 5993.520518358521, 5994.700264986734, 6024.126501657235, 5539.335279766414, 5623.606347555714, 5625.0, 5632.971835140839, 5677.687727175004, 6158.0, 6159.784407545714, 6173.9073913891325, 6175.876482470326, 6175.907361389583, 5701.116326969326, 5819.476247137778, 5853.853653658607, 5913.733881975321, 5959.433853783884, 6018.789342372996, 6021.367756385516, 6029.366916473795, 6031.60794548353, 6074.483668888106, 5988.461038506468, 5991.7902873399225, 5993.460588547052, 5994.490468310155, 5998.520118390518, 5709.800156994485, 5819.301683797887, 5868.941310586925, 5983.670898100646, 5984.0, 4615.699979501322, 4637.46669133054, 4660.533946605312, 4662.0, 4675.018246168274, 4108.897277568025, 4120.196561670446, 4120.567340429272, 4126.339785634284, 4165.125323682, 5567.610267281251, 5648.0, 5693.17448969897, 5705.914411283834, 5776.5089967352405, 5989.64062156272, 6079.452849243589, 6088.726007329681, 6092.786752463642, 6092.878142437126, 5763.221965034667, 5763.827085187451, 5768.596198266081, 5771.365149833515, 5780.53755699543, 5113.1052065888325, 5148.794048238028, 5181.3782346118705, 5216.061109000417, 5248.9737551312, 6312.305646378894, 6361.713722882574, 6364.745410183541, 6366.363363663597, 6370.554061215763, 5774.653520788766, 6064.545159112996, 6074.392560744067, 6078.209832721895, 6079.270487541523, 6145.66198859067, 6209.906851397323, 6345.682715864281, 6367.681615919093, 6369.617822930453, 5932.0, 5937.168796368425, 5943.661127377125, 5948.2862056553495, 6005.879882402415, 5794.4205579443405, 5902.881942361215, 6009.7295621698, 6015.939840601538, 6019.067044608093, 5735.71321433935, 5824.650520968756, 5824.9806283901, 5833.241678581757, 5858.150568167677, 5762.0, 5797.971010144923, 5819.76720931158, 5823.70881455934, 5826.883462330645, 5556.499915007668, 5604.8879022418505, 5686.516646085129, 5739.139129130664, 5739.9139012914, 5853.882922341614, 5915.852103697442, 5927.199828023334, 5928.140419639214, 5937.762489500372, 5766.336871259691, 5784.1034639630925, 5789.2763404574425, 5796.333421656394, 5840.795572154954], "mootools.html": [1479.0534058202745, 1658.9253483593236, 1727.3695101288026, 1738.5132162994357, 1755.7278621813616, 6342.809715708525, 7182.353588177063, 7422.443316751252, 7449.739259125919, 7490.0, 7189.209186989427, 7366.815829604263, 7367.594782286972, 7384.22465641108, 7388.519746216505, 2226.1206823304783, 2229.1752051740878, 2251.549690061994, 2252.538229662915, 2253.763354847734, 2246.4159318577126, 2253.4704344479114, 2289.1301305503885, 2296.5292115116363, 2300.217925905192, 2200.8239340852692, 2213.2032468311395, 2214.446388402899, 2221.4113259986116, 2251.628481300592, 2211.281333566581, 2225.9888700556394, 2230.542738738563, 2237.7650346713604, 2241.237979087102, 2226.1206823304865, 2241.9887900560557, 2246.70792796937, 2246.9213577524706, 2251.594712951668, 6198.752049917998, 6400.359964003563, 7274.927250727478, 7312.670929808171, 7332.340089391927, 4179.791010449496, 4315.805788739514, 4337.501187363462, 4341.913161736779, 4362.2366085935155, 2910.8544572771275, 2924.7952643314975, 2989.8505074746176, 2990.0, 3055.572219889217, 973.8928717841031, 978.5792109392958, 996.1632228927735, 1004.1213937804421, 1006.4112494190907, 9405.341626086176, 9445.0, 9448.433094014312, 9480.905190948071, 9485.857712134324, 3866.3620502617314, 3909.3158697227873, 3958.6239307265764, 3965.2466031453932, 3968.206358728208, 8427.367947403969, 8447.704330348408, 8452.239298463168, 8462.492250464991, 8475.0, 4283.5502272260965, 4300.6989510734575, 4304.117655880599, 4305.56944305567, 4308.655307575386, 3903.902402439962, 3926.2147570486018, 3927.136030073379, 3929.03738584043, 3932.528096628423, 3491.720662347006, 3503.8773642922374, 3534.823258837048, 3553.911152221215, 3562.5012498250267, 1117.6144230240554, 1127.9661610151709, 1133.0482394788417, 1133.240728711765, 1137.141458199071, 1060.1995493402585, 1085.9511321990528, 1237.9876201238053, 1286.0547497589264, 1286.2861112082696, 6873.931260687329, 6908.792736217922, 6911.0, 6923.792286231421, 6938.687759050855, 1128.2497139402205, 1131.4964840645998, 1135.8523391958993, 1141.1099342512853, 1156.1964434717959, 5296.417394086648, 5510.283663123849, 5552.7223638817895, 5562.16567514876, 5572.498475137257, 8136.982877140357, 8392.916070839336, 8660.437071590326, 8796.47221166732, 8805.559722013873, 7740.8838867417035, 7777.844443111106, 7793.493422927491, 7820.882686759704, 7861.842763144705, 6516.674166291667, 6758.76344327956, 6814.352636499525, 6816.352446517573, 6821.283765204681, 6869.416099631588, 6886.345797149263, 6956.2695916928, 6965.582065076112, 6981.720731170696, 7585.924140758742, 7783.883241751265, 7828.765137045898, 7865.921340786747, 7885.881711774443, 7982.800429989296, 8092.6762929482165, 8093.109757926505, 8093.35253179756, 8220.794480138044, 6976.686049127903, 7190.676419561028, 7198.74804381865, 7204.747833825791, 7209.783706488814, 7296.124465064227, 7329.780106596811, 7366.631668416665, 7374.188839227788, 7379.704811807467, 6586.407223349922, 6828.214755303204, 6861.588304701734, 6910.585364878123, 7007.824804379931, 6774.3225677431865, 6794.626295553792, 6824.829379265359, 6829.317068293131, 6892.896606551006, 6370.840728981812, 6466.935330646634, 6493.350664933658, 6667.49993750461, 6685.197776266879, 6095.969520152371, 6296.275928268308, 6308.495320374451, 6318.241810982711, 6322.178116844781, 6093.878122437438, 6351.555391122577, 6377.553571250153, 6391.009393544008, 6396.168498095218], "ext.html": [572.9427057294268, 590.6279044202157, 597.2534332084894, 610.7984365159498, 623.5292354272524, 32522.83738581307, 33061.504077438825, 42099.78950105249, 42574.0, 42724.14551708972, 44040.0, 44443.0, 44503.1099378013, 44555.10889782211, 44652.3302150468, 7591.354734847545, 8654.480731156134, 8813.38306318558, 8821.117888211193, 8844.646214151426, 7742.729004484844, 10455.0, 10509.316894401878, 10584.259101862834, 10671.35971841692, 10273.589056437771, 10364.948175259151, 10379.792404151913, 10384.221183411237, 10384.584616615326, 7936.285734283913, 8096.919030809676, 10295.63965261216, 10386.0, 10522.894771052344, 10113.443760593165, 10155.339902906288, 10162.39025658463, 10221.488925553767, 10236.539355728935, 40623.39064914029, 41067.0, 41130.0, 41138.588614113774, 41145.06259248879, 2862.261126742388, 2987.2041106482707, 2998.040626999361, 3026.273694313371, 3066.3254084101463, 30638.69361306403, 30788.384232315228, 30892.134506279614, 30970.225744356347, 31197.688023119932, 3301.1912081540177, 3336.132605522582, 3342.8328583570724, 3381.323735252959, 3437.604675462329, 281888.0, 284776.0, 285547.0, 285756.0, 285833.0, 53839.730801345744, 55099.17351239654, 63296.0, 63709.0, 68352.3164768356, 64443.355566444676, 64520.677396612715, 64825.35174648193, 64836.67581662061, 64914.35085649083, 15484.612884677974, 15660.451884183998, 15698.68602627941, 15705.842941570667, 15706.214689265491, 11285.153613479022, 11327.490262938187, 11355.148363872742, 11366.829497557543, 11399.943000284946, 20195.192192312436, 20273.391798246077, 20370.796292037187, 20376.388708338774, 20433.795662043485, 7758.573278469738, 7878.881816772753, 7910.683572657144, 7933.0, 8018.558979256197, 875.8117004843862, 962.4033099478369, 1053.0995998421392, 1068.1668298727006, 1127.937963412004, 26293.0, 27097.1870843875, 27418.862905685743, 27641.170764877086, 28028.159155225378, 1047.266494945532, 1088.9727756806144, 1109.1071687291808, 1124.1175677093606, 1131.8924702153283, 14288.785668214985, 14386.424543018371, 14475.65859427019, 14509.274536273144, 14672.339744711513, 344715.0, 349012.0, 350510.0, 351948.0, 353385.0, 46973.29540056902, 53694.0, 54166.729166353914, 54167.0, 54207.45792542024, 1226.6871947653292, 1261.1802328486374, 1321.062045947388, 1337.3179678364104, 1337.5987203838808, 26766.464670706868, 27313.453730924874, 27853.86073069622, 28905.132846014654, 29432.705672942997, 44863.32705009493, 45162.548374515834, 45915.54084459246, 45983.3102503456, 46159.3076103852, 434429.0, 442890.0, 445705.0, 446821.0, 447528.0, 31435.371292573564, 31825.68174318227, 31920.5211921826, 32044.19889502781, 32075.67924320727, 44438.3334249993, 44951.32573011342, 45057.32414013858, 45357.0, 45928.77035614801, 36242.0, 36966.445503316936, 37821.62178378181, 37853.242935141694, 38647.0, 37115.8144209288, 37456.625433746405, 38547.614523854405, 38616.0, 38770.4184437228, 36647.81676091602, 37499.0, 37610.0, 37662.0, 37675.43486847754, 32434.675653243165, 34036.0, 34100.14749631279, 34473.0, 34597.30805383928, 25335.0, 25519.617205741557, 25734.613980790677, 25912.352191194615, 26128.477430451665], "prototype.html": [308.30938697318015, 332.40997229916894, 332.50456819339195, 334.4297971957812, 336.11433871747954, 5672.801451949183, 5768.163616275638, 5776.104703770911, 5801.158831969362, 5828.0, 5592.916106258399, 5702.8289151325525, 5717.2281741964825, 5717.256756621644, 5727.198192253088, 4431.401760762288, 4431.734095954237, 4435.024294655179, 4437.334399840018, 4443.577860103301, 4283.250431174532, 4347.804348804296, 4365.301551751721, 4407.735535867842, 4422.579854913778, 4388.758618275993, 4417.73493590384, 4422.933655995163, 4428.047969686517, 4428.623566996809, 4377.606015458592, 4405.273129933557, 4422.800973956164, 4424.269995450747, 4426.535213802553, 3873.573906870242, 3904.3752999520225, 3911.5306163260307, 3918.0596656802445, 3920.2159568086495, 5354.464553544653, 5450.972745136249, 5460.153676180198, 5527.695976721278, 5538.196961440569, 5187.662801917863, 5189.558887494568, 5190.0, 5190.247414124969, 5193.9740301298625, 6049.334573196945, 6060.030395136801, 6086.2087928569, 6100.23747031621, 6104.938950610526, 4177.4569305990335, 4227.387028880826, 4262.573742625744, 4335.653147748204, 4338.457692788402, 6256.249250090018, 6259.561830671855, 6277.591956522811, 6278.372162783685, 6281.780137695158, 4411.426514553087, 4422.778861056934, 4423.60187583119, 4423.867283981485, 4426.313921342197, 4401.977990110093, 4473.217186992263, 4475.843345482893, 4477.753723545171, 4479.776011199427, 5162.148245539444, 5163.66436181647, 5165.74171291434, 5168.379794424618, 5170.741462926839, 6141.07883817431, 6142.969285153546, 6149.877002459926, 6153.107799369066, 6164.106204600308, 1583.6753465539537, 1618.287953300544, 1618.336482042357, 1620.335662378419, 1620.813606435275, 1061.741835924432, 1078.1321036565482, 1080.4273734920505, 1096.736783172033, 1107.341132026443, 5999.100134979701, 6001.339852616209, 6002.249718785152, 6002.54980876436, 6012.188354572077, 6300.338464461165, 6310.085037669604, 6310.873782524323, 6313.77901773445, 6317.305096439388, 5988.37122102173, 5991.310999235056, 5993.700314984233, 5999.820005399845, 6003.279606447254, 3440.7935523868646, 3498.2653642734804, 3507.824608769551, 3512.877049303262, 3521.29574085184, 6518.641474718936, 6573.816712991707, 6577.276499585042, 6580.670966451658, 6581.2760596334365, 6523.478121750249, 6523.836904077436, 6538.051982462516, 6539.215294164731, 6552.770653027121, 6501.024846273002, 6574.276829548746, 6583.012548117821, 6588.439982601437, 6589.80230593083, 6286.214223222098, 6303.338149494237, 6345.46063584582, 6382.266039405527, 6384.553081284265, 6032.4570788629235, 6108.541859360655, 6153.907691384722, 6238.812835614939, 6242.813865365566, 6511.73953041873, 6554.082428459924, 6566.343365663395, 6567.737290508326, 6590.8352291193105, 4427.3358996149545, 4505.954940450684, 4507.098580284022, 4509.849988252974, 4510.939929116721, 6151.169592105188, 6295.464885484785, 6322.589031712924, 6326.4622507087415, 6354.26925903527, 6125.173101631401, 6134.0, 6144.016957286813, 6151.907721384094, 6155.569110162246, 6126.203593532812, 6127.356627554221, 6131.63210207389, 6132.41742034506, 6133.141360209485, 5916.852078698067, 6018.247719035121, 6036.0644100164545, 6040.969795150996, 6044.214252147192, 6174.938250617436, 6176.011838105882, 6178.227721534809, 6178.6292822429, 6187.969060154851, 6008.54935879802, 6024.0, 6027.57806953509, 6030.698465076816, 6036.8188954331445], "yui.html": [688.6453476459623, 715.3490323805335, 738.5125816960807, 751.5528260684897, 786.8859015442757, 14321.140731556101, 14617.634559136, 14644.194569298685, 14716.852831471682, 14738.63153421165, 13986.860131398684, 14048.0, 14055.297235138254, 14060.367283472242, 14066.578002659911, 670.795407400745, 677.7560078371782, 808.8099296665279, 824.9935079203362, 825.0429501777938, 810.6797814863125, 825.3273582030625, 829.5105887526358, 829.8589239829213, 830.3440282177073, 858.8067684770939, 869.7695110795644, 869.8738682890977, 870.2428886868433, 871.2898987325341, 706.7279097547456, 715.7673756029285, 842.9747107586783, 855.1363123245504, 863.1842908451484, 625.3590070178059, 627.4854619212248, 628.4972022382121, 628.5066223014957, 629.0281515059245, 12077.15459917806, 12331.383430828513, 12411.627651170389, 12481.56314528987, 12607.306598137098, 9652.806943861153, 9753.0, 9821.263405244636, 10662.680119596425, 11016.669499915015, 9189.540522973824, 9297.125394419683, 9501.857472137923, 9749.853752193723, 9884.604615815359, 3077.692230776927, 3114.470540008204, 3163.2882601414726, 3192.632847222576, 3233.304839459504, 47930.0, 48162.51837481651, 48638.513614863754, 48717.75641121772, 48876.0, 7633.923660763321, 7700.383969282444, 7769.805754856174, 7965.681372745141, 8042.919570804334, 12230.388480575935, 12318.199317044364, 12323.568675096329, 12396.81404778929, 12399.0, 6450.032495125769, 6674.0, 6675.566088204251, 6867.931320686729, 6990.510664253454, 4457.732536047847, 4481.887952801206, 4533.546645335506, 4564.84023059198, 4583.495815460296, 2783.178962206154, 2786.484500367398, 2794.0779542750843, 2802.9859850701023, 2809.269589906639, 425.84882366759354, 426.7162337045892, 433.5014733056947, 440.65408654206294, 443.4191209515545, 599.5383554662885, 640.225327353907, 649.1885143570537, 657.1916542652564, 690.848013437043, 7774.727884524014, 8486.363522735695, 8913.197812196804, 9158.86261706075, 9450.90549094514, 527.3539913605879, 572.5562688916124, 655.4003087175181, 659.4592434203906, 669.7689297192461, 3938.133610605662, 3949.0, 4027.496562929634, 4045.3527435610163, 4169.124483858363, 60688.0, 61221.38778612246, 61592.38407615866, 62061.689691551255, 62231.377686223466, 53109.46890531122, 53197.0, 53266.467335326925, 54480.18279725807, 54679.72660136674, 47197.8200544996, 47211.29183062257, 47876.52123478721, 48464.0, 49262.26106608404, 8901.51041692713, 9043.773905652411, 9076.137766912132, 9114.589843457194, 9273.119053689888, 37920.81039594785, 38579.80710096432, 38876.63931762375, 39462.80268598639, 39602.801985989885, 50222.0, 50525.0, 50816.745916270185, 51423.0, 51836.0, 8109.8378032440205, 8133.715319963773, 8163.061247956323, 8178.386621003568, 8199.836003280021, 12401.25592464455, 12511.499540018298, 12742.426590803621, 12780.233186008869, 12955.870441295467, 10696.14430845515, 10842.620508282173, 11056.889431105586, 11310.434478275889, 11320.150988675718, 11492.310461372344, 11500.884991149982, 12098.576549820715, 12455.937720311704, 12534.811977820158, 11491.367974761468, 11688.94155529217, 11741.29552226869, 11763.411829408666, 11768.646940591796, 10184.541695623566, 10380.636677716244, 10411.975358854277, 10564.0, 10607.363558186533, 9293.86059209126, 9337.813243735223, 9558.56986435598, 10076.294659373774, 10497.47512624381]}, "summary": {"lowerIsBetter": false, "suite": 6721.031929044794, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7168.7388972594235, "unit": "ms", "value": 7168.7388972594235}, "dojo.html": {"lowerIsBetter": false, "filtered": 5516.135764756019, "unit": "ms", "value": 5516.135764756019}, "mootools.html": {"lowerIsBetter": false, "filtered": 4292.461680110781, "unit": "ms", "value": 4292.461680110781}, "ext.html": {"lowerIsBetter": false, "filtered": 19149.23600717826, "unit": "ms", "value": 19149.23600717826}, "prototype.html": {"lowerIsBetter": false, "filtered": 4654.087010581544, "unit": "ms", "value": 4654.087010581544}, "yui.html": {"lowerIsBetter": false, "filtered": 6092.641356211335, "unit": "ms", "value": 6092.641356211335}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447351292, "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": "20151112083105", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 162.0, 161.0, 160.0, 159.0, 161.0, 161.0, 162.0, 159.0, 161.0], "ai-astar": [108.0, 111.0, 103.0, 109.0, 110.0, 109.0, 101.0, 109.0, 115.0, 108.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 112.0, 109.0, 109.0], "audio-beat-detection": [150.0, 122.0, 147.0, 163.0, 124.0, 148.0, 158.0, 128.0, 162.0, 124.0], "json-stringify-tinderbox": [67.0, 66.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 67.0], "stanford-crypto-pbkdf2": [137.0, 160.0, 144.0, 152.0, 145.0, 135.0, 145.0, 144.0, 144.0, 136.0], "json-parse-financial": [60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 63.0, 68.0, 58.0, 57.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 66.0, 65.0, 65.0, 64.0, 65.0, 66.0, 63.0, 66.0], "audio-fft": [73.0, 71.0, 84.0, 95.0, 72.0, 73.0, 72.0, 114.0, 88.0, 72.0], "imaging-darkroom": [145.0, 144.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 144.0, 146.0], "stanford-crypto-ccm": [114.0, 124.0, 119.0, 115.0, 131.0, 115.0, 128.0, 124.0, 123.0, 121.0], "audio-oscillator": [90.0, 91.0, 146.0, 90.0, 90.0, 91.0, 134.0, 90.0, 91.0, 132.0], "stanford-crypto-aes": [90.0, 84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1491.8000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.4, "unit": "ms", "value": 81.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 144.2, "unit": "ms", "value": 144.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 142.6, "unit": "ms", "value": 142.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.4, "unit": "ms", "value": 121.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.3, "unit": "ms", "value": 60.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.5, "unit": "ms", "value": 104.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.3, "unit": "ms", "value": 108.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.6, "unit": "ms", "value": 160.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.4, "unit": "ms", "value": 65.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.2, "unit": "ms", "value": 85.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447351292, "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": "20151112083105", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.040616773223], "Encrypt": [283.2058906825262], "NavierStokes": [4826.923076923077], "Decrypt": [5040.201005025126], "Splay": [625.2330640149161], "Richards": [170.64846416382252], "RegExp": [25400.0], "Earley": [766.8711656441718], "Boyer": [12108.43373493976], "RayTrace": [1974.3589743589744]}, "summary": {"lowerIsBetter": false, "suite": 19883.445478673835, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 351.6155239999999, "unit": "score", "value": 351.6155239999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 939.8851109999996, "unit": "score", "value": 939.8851109999996}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 130.33699701789263, "unit": "score", "value": 130.33699701789263}, "RegExp": {"lowerIsBetter": false, "filtered": 35.86555118110237, "unit": "score", "value": 35.86555118110237}, "Richards": {"lowerIsBetter": false, "filtered": 206.86972000000003, "unit": "score", "value": 206.86972000000003}, "Earley": {"lowerIsBetter": false, "filtered": 869.067752, "unit": "score", "value": 869.067752}, "Boyer": {"lowerIsBetter": false, "filtered": 55.0412228855721, "unit": "score", "value": 55.0412228855721}, "RayTrace": {"lowerIsBetter": false, "filtered": 374.7996233766234, "unit": "score", "value": 374.7996233766234}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-061"}, "testrun": {"date": 1447351292, "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": "20151112083105", "branch": "Fx-Team", "revision": "73119a9a7da215431a8b4c8b31a28cb8dd78d3bb"}}] 10:21:42 INFO - RETURN: dromaeo_css: 6721.03 10:21:42 INFO - RETURN: kraken: 1491.80 10:21:42 INFO - RETURN: v8_7: 19883.45 10:21:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19883.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1491.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6721.03"}}} 10:21:43 INFO - Return code: 0 10:21:43 INFO - # TBPL SUCCESS # 10:21:43 INFO - Running post-action listener: _resource_record_post_action 10:21:43 INFO - Running post-run listener: _resource_record_post_run 10:21:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506793984; Read time: 8; Write time: 431560 10:21:44 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231608320; Read time: 0; Write time: 264564 10:21:44 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 270585856; Read time: 0; Write time: 137060 10:21:44 INFO - Running post-run listener: _upload_blobber_files 10:21:44 INFO - Blob upload gear active. 10:21:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:21:44 INFO - Copying logs to upload dir... 10:21:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.765561 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2015-11-12 10:21:43.810530) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:21:43.814710) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009967 build_url: 'https://queue.taskcluster.net/v1/task/niRvHwMkQIuTQVp24uVq_A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 10:21:43.866433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:21:43.866756) ========= 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=5804b9f07a53938c557deee7000001c5-1447347951.934441-1986817930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 10:21:43.916933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 10:21:43.917250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 10:21:43.917538) ========= ========= Total master_lag: 0.59 =========