builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1447731990.2 results: success (0) buildid: 20151116173018 builduid: 0a200015d033447e9211e525a73952c1 revision: 31c31342f1ea35b6396e99def49076df4f4fd201 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.202761) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.203225) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.203525) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.242632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.243007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.269203) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.269666) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.320390) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.320653) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.321046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.321321) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 19:46:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-16 19:46:30 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.554478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.554776) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015351 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.610810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:30.611125) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31c31342f1ea35b6396e99def49076df4f4fd201 --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 31c31342f1ea35b6396e99def49076df4f4fd201 --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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 19:46:30,736 truncating revision to first 12 chars 2015-11-16 19:46:30,736 Setting DEBUG logging. 2015-11-16 19:46:30,736 attempt 1/10 2015-11-16 19:46:30,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31c31342f1ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 19:46:31,003 unpacking tar archive at: fx-team-31c31342f1ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559356 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:31.183010) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:31.183390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:31.202306) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:31.202643) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 19:46:31.203088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 19:46:31.203390) ========= /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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:46:31 INFO - MultiFileLogger online at 20151116 19:46:31 in /builds/slave/test-pgo 19:46:31 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 19:46:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:46:31 INFO - {'append_to_log': False, 19:46:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:46:31 INFO - 'blob_upload_branch': 'Fx-Team', 19:46:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:46:31 INFO - 'branch': 'Fx-Team', 19:46:31 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:31 INFO - 'config_files': ('talos/linux_config.py',), 19:46:31 INFO - 'default_actions': ('clobber', 19:46:31 INFO - 'read-buildbot-config', 19:46:31 INFO - 'download-and-extract', 19:46:31 INFO - 'populate-webroot', 19:46:31 INFO - 'create-virtualenv', 19:46:31 INFO - 'install', 19:46:31 INFO - 'run-tests'), 19:46:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:31 INFO - 'download_minidump_stackwalk': True, 19:46:31 INFO - 'download_symbols': 'ondemand', 19:46:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:31 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:31 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:31 INFO - 'installer_path': 'installer.exe', 19:46:31 INFO - 'log_level': 'info', 19:46:31 INFO - 'log_name': 'talos', 19:46:31 INFO - 'log_to_console': True, 19:46:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:46:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:46:31 INFO - 'opt_config_files': (), 19:46:31 INFO - 'pip_index': False, 19:46:31 INFO - 'sps_profile': False, 19:46:31 INFO - 'sps_profile_interval': 0, 19:46:31 INFO - 'suite': 'dromaeojs', 19:46:31 INFO - 'system_bits': '64', 19:46:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:31 INFO - 'title': 'talos-linux64-ix-045', 19:46:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:31 INFO - 'use_talos_json': True, 19:46:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:46:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:31 INFO - 'work_dir': 'build'} 19:46:31 INFO - ##### 19:46:31 INFO - ##### Running clobber step. 19:46:31 INFO - ##### 19:46:31 INFO - Running pre-action listener: _resource_record_pre_action 19:46:31 INFO - Running main action method: clobber 19:46:31 INFO - rmtree: /builds/slave/test-pgo/build 19:46:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:46:31 INFO - Running post-action listener: _resource_record_post_action 19:46:31 INFO - ##### 19:46:31 INFO - ##### Running read-buildbot-config step. 19:46:31 INFO - ##### 19:46:31 INFO - Running pre-action listener: _resource_record_pre_action 19:46:31 INFO - Running main action method: read_buildbot_config 19:46:31 INFO - Using buildbot properties: 19:46:31 INFO - { 19:46:31 INFO - "properties": { 19:46:31 INFO - "buildnumber": 786, 19:46:31 INFO - "product": "firefox", 19:46:31 INFO - "script_repo_revision": "production", 19:46:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:46:31 INFO - "repository": "", 19:46:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:46:31 INFO - "buildid": "20151116173018", 19:46:31 INFO - "slavename": "talos-linux64-ix-045", 19:46:31 INFO - "pgo_build": "True", 19:46:31 INFO - "basedir": "/builds/slave/test-pgo", 19:46:31 INFO - "project": "", 19:46:31 INFO - "platform": "ubuntu64_hw", 19:46:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:46:31 INFO - "slavebuilddir": "test", 19:46:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:46:31 INFO - "branch": "fx-team", 19:46:31 INFO - "repo_path": "integration/fx-team", 19:46:31 INFO - "stage_platform": "linux64-pgo", 19:46:31 INFO - "builduid": "0a200015d033447e9211e525a73952c1", 19:46:31 INFO - "revision": "31c31342f1ea35b6396e99def49076df4f4fd201" 19:46:31 INFO - }, 19:46:31 INFO - "sourcestamp": { 19:46:31 INFO - "repository": "", 19:46:31 INFO - "hasPatch": false, 19:46:31 INFO - "project": "", 19:46:31 INFO - "branch": "fx-team-linux64-pgo-talos", 19:46:31 INFO - "changes": [ 19:46:31 INFO - { 19:46:31 INFO - "category": null, 19:46:31 INFO - "files": [ 19:46:31 INFO - { 19:46:31 INFO - "url": null, 19:46:31 INFO - "name": "https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:46:31 INFO - } 19:46:31 INFO - ], 19:46:31 INFO - "repository": "", 19:46:31 INFO - "rev": "31c31342f1ea35b6396e99def49076df4f4fd201", 19:46:31 INFO - "who": "sendchange", 19:46:31 INFO - "when": 1447731972, 19:46:31 INFO - "number": 6669834, 19:46:31 INFO - "comments": "", 19:46:31 INFO - "project": "", 19:46:31 INFO - "at": "Mon 16 Nov 2015 19:46:12", 19:46:31 INFO - "branch": "fx-team-linux64-pgo-talos", 19:46:31 INFO - "revlink": "", 19:46:31 INFO - "properties": [ 19:46:31 INFO - [ 19:46:31 INFO - "buildid", 19:46:31 INFO - "20151116173018", 19:46:31 INFO - "Change" 19:46:31 INFO - ], 19:46:31 INFO - [ 19:46:31 INFO - "builduid", 19:46:31 INFO - "0a200015d033447e9211e525a73952c1", 19:46:31 INFO - "Change" 19:46:31 INFO - ], 19:46:31 INFO - [ 19:46:31 INFO - "pgo_build", 19:46:31 INFO - "True", 19:46:31 INFO - "Change" 19:46:31 INFO - ] 19:46:31 INFO - ], 19:46:31 INFO - "revision": "31c31342f1ea35b6396e99def49076df4f4fd201" 19:46:31 INFO - } 19:46:31 INFO - ], 19:46:31 INFO - "revision": "31c31342f1ea35b6396e99def49076df4f4fd201" 19:46:31 INFO - } 19:46:31 INFO - } 19:46:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:46:31 INFO - Running post-action listener: _resource_record_post_action 19:46:31 INFO - ##### 19:46:31 INFO - ##### Running download-and-extract step. 19:46:31 INFO - ##### 19:46:31 INFO - Running pre-action listener: _resource_record_pre_action 19:46:31 INFO - Running main action method: download_and_extract 19:46:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:31 INFO - https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/test_packages.json 19:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/test_packages.json 19:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:46:35 INFO - Downloaded 1302 bytes. 19:46:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:46:35 INFO - Using the following test package requirements: 19:46:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:46:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'jsshell-linux-x86_64.zip'], 19:46:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:46:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:46:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:46:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:46:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:46:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:46:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:46:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:46:35 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')]} 19:46:35 INFO - https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:37 INFO - Downloaded 22458940 bytes. 19:46:37 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 19:46:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:37 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 19:46:38 INFO - Return code: 0 19:46:38 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 19:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:38 INFO - https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:39 INFO - Downloaded 22458940 bytes. 19:46:39 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 19:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:46:39 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 19:46:40 INFO - Return code: 0 19:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:40 INFO - https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:41 INFO - Downloaded 11131693 bytes. 19:46:41 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 19:46:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:46:41 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 19:46:41 INFO - Return code: 0 19:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:41 INFO - https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/j-LCU8AISaKQoc3M4uqr3g/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 19:46:43 INFO - Downloaded 57170662 bytes. 19:46:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:46:43 INFO - mkdir: /builds/slave/test-pgo/properties 19:46:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:46:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:46:43 INFO - Contents: 19:46:43 INFO - build_url:https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:46:43 INFO - Running post-action listener: _resource_record_post_action 19:46:43 INFO - Running post-action listener: set_extra_try_arguments 19:46:43 INFO - ##### 19:46:43 INFO - ##### Running populate-webroot step. 19:46:43 INFO - ##### 19:46:43 INFO - Running pre-action listener: _resource_record_pre_action 19:46:43 INFO - Running main action method: populate_webroot 19:46:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:43 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:46:43 INFO - '../fennec_ids.txt'], 19:46:43 INFO - 'tests': ['tcheck2']}, 19:46:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:43 INFO - '--tppagecycles', 19:46:43 INFO - '7'], 19:46:43 INFO - 'tests': ['tsvgm']}}, 19:46:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:46:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:46:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'tests': ['damp', 'tps']}, 19:46:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['damp', 'tps']}, 19:46:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:46:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:43 INFO - 'other': {'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'other_l64': {'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'other_nol64': {'tests': ['a11yr', 19:46:43 INFO - 'ts_paint', 19:46:43 INFO - 'tpaint', 19:46:43 INFO - 'sessionrestore', 19:46:43 INFO - 'sessionrestore_no_auto_restore']}, 19:46:43 INFO - 'svgr': {'tests': ['tsvgx', 19:46:43 INFO - 'tsvgr_opacity', 19:46:43 INFO - 'tart', 19:46:43 INFO - 'tscrollx', 19:46:43 INFO - 'cart']}, 19:46:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['tsvgx', 19:46:43 INFO - 'tsvgr_opacity', 19:46:43 INFO - 'tart', 19:46:43 INFO - 'tscrollx', 19:46:43 INFO - 'cart']}, 19:46:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'tests': ['tp5o']}, 19:46:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'talos_options': ['--e10s'], 19:46:43 INFO - 'tests': ['tp5o']}, 19:46:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'talos_options': ['--xperf_path', 19:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:43 INFO - 'tests': ['tp5n']}, 19:46:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:43 INFO - 'talos_options': ['--e10s', 19:46:43 INFO - '--xperf_path', 19:46:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:43 INFO - 'tests': ['tp5n']}}, 19:46:43 INFO - 'talos.zip': {'path': '', 19:46:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:43 INFO - Running post-action listener: _resource_record_post_action 19:46:43 INFO - ##### 19:46:43 INFO - ##### Running create-virtualenv step. 19:46:43 INFO - ##### 19:46:43 INFO - Running pre-action listener: _resource_record_pre_action 19:46:43 INFO - Running main action method: create_virtualenv 19:46:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:46:43 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 19:46:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:46:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:43 INFO - Using real prefix '/usr' 19:46:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:46:44 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:45 INFO - Installing pip.................done. 19:46:46 INFO - Return code: 0 19:46:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:46:46 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')]} 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 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')]} 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:46 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 19:46:46 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 19:46:46 INFO - Using env: {'DISPLAY': ':0', 19:46:46 INFO - 'HOME': '/home/cltbld', 19:46:46 INFO - 'LANG': 'en_US.UTF-8', 19:46:46 INFO - 'LANGUAGE': 'en_US:en', 19:46:46 INFO - 'LOGNAME': 'cltbld', 19:46:46 INFO - 'MAIL': '/var/mail/cltbld', 19:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:46 INFO - 'MOZ_NO_REMOTE': '1', 19:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:46 INFO - 'NO_EM_RESTART': '1', 19:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:46 INFO - 'SHELL': '/bin/bash', 19:46:46 INFO - 'SHLVL': '1', 19:46:46 INFO - 'TERM': 'linux', 19:46:46 INFO - 'TMOUT': '86400', 19:46:46 INFO - 'USER': 'cltbld', 19:46:46 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:46 INFO - '_': '/tools/buildbot/bin/python'} 19:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:46 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 19:46:46 INFO - Cleaning up... 19:46:46 INFO - Return code: 0 19:46:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:46:46 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')]} 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 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')]} 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:46 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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:46 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 19:46:46 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 19:46:46 INFO - Using env: {'DISPLAY': ':0', 19:46:46 INFO - 'HOME': '/home/cltbld', 19:46:46 INFO - 'LANG': 'en_US.UTF-8', 19:46:46 INFO - 'LANGUAGE': 'en_US:en', 19:46:46 INFO - 'LOGNAME': 'cltbld', 19:46:46 INFO - 'MAIL': '/var/mail/cltbld', 19:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:46 INFO - 'MOZ_NO_REMOTE': '1', 19:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:46 INFO - 'NO_EM_RESTART': '1', 19:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:46 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:46 INFO - 'SHELL': '/bin/bash', 19:46:46 INFO - 'SHLVL': '1', 19:46:46 INFO - 'TERM': 'linux', 19:46:46 INFO - 'TMOUT': '86400', 19:46:46 INFO - 'USER': 'cltbld', 19:46:46 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:46 INFO - '_': '/tools/buildbot/bin/python'} 19:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:46 INFO - Downloading/unpacking psutil>=0.7.1 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:48 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:46:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:46:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:48 INFO - Installing collected packages: psutil 19:46:48 INFO - Running setup.py install for psutil 19:46:48 INFO - building 'psutil._psutil_linux' extension 19:46:48 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 19:46:48 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 19:46:48 INFO - building 'psutil._psutil_posix' extension 19:46:48 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 19:46:48 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 19:46:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:48 INFO - Successfully installed psutil 19:46:48 INFO - Cleaning up... 19:46:48 INFO - Return code: 0 19:46:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:48 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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:48 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 19:46:48 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 19:46:48 INFO - Using env: {'DISPLAY': ':0', 19:46:48 INFO - 'HOME': '/home/cltbld', 19:46:48 INFO - 'LANG': 'en_US.UTF-8', 19:46:48 INFO - 'LANGUAGE': 'en_US:en', 19:46:48 INFO - 'LOGNAME': 'cltbld', 19:46:48 INFO - 'MAIL': '/var/mail/cltbld', 19:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:48 INFO - 'MOZ_NO_REMOTE': '1', 19:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:48 INFO - 'NO_EM_RESTART': '1', 19:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:48 INFO - 'SHELL': '/bin/bash', 19:46:48 INFO - 'SHLVL': '1', 19:46:48 INFO - 'TERM': 'linux', 19:46:48 INFO - 'TMOUT': '86400', 19:46:48 INFO - 'USER': 'cltbld', 19:46:48 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:48 INFO - '_': '/tools/buildbot/bin/python'} 19:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:48 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 19:46:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:46:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:46:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:46:50 INFO - Installing collected packages: mozsystemmonitor 19:46:50 INFO - Running setup.py install for mozsystemmonitor 19:46:50 INFO - Successfully installed mozsystemmonitor 19:46:50 INFO - Cleaning up... 19:46:50 INFO - Return code: 0 19:46:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:50 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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:50 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 19:46:50 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 19:46:50 INFO - Using env: {'DISPLAY': ':0', 19:46:50 INFO - 'HOME': '/home/cltbld', 19:46:50 INFO - 'LANG': 'en_US.UTF-8', 19:46:50 INFO - 'LANGUAGE': 'en_US:en', 19:46:50 INFO - 'LOGNAME': 'cltbld', 19:46:50 INFO - 'MAIL': '/var/mail/cltbld', 19:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:50 INFO - 'MOZ_NO_REMOTE': '1', 19:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:50 INFO - 'NO_EM_RESTART': '1', 19:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:50 INFO - 'SHELL': '/bin/bash', 19:46:50 INFO - 'SHLVL': '1', 19:46:50 INFO - 'TERM': 'linux', 19:46:50 INFO - 'TMOUT': '86400', 19:46:50 INFO - 'USER': 'cltbld', 19:46:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:50 INFO - '_': '/tools/buildbot/bin/python'} 19:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:51 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 19:46:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:46:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:52 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 19:46:52 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 19:46:52 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 19:46:52 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 19:46:52 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 19:46:52 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 19:46:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:46:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:46:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:53 INFO - Downloading docopt-0.6.1.tar.gz 19:46:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:46:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:53 INFO - Running setup.py install for blobuploader 19:46:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:46:53 INFO - Running setup.py install for requests 19:46:53 INFO - Running setup.py install for docopt 19:46:53 INFO - Successfully installed blobuploader requests docopt 19:46:53 INFO - Cleaning up... 19:46:54 INFO - Return code: 0 19:46:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:54 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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:54 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 19:46:54 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 19:46:54 INFO - Using env: {'DISPLAY': ':0', 19:46:54 INFO - 'HOME': '/home/cltbld', 19:46:54 INFO - 'LANG': 'en_US.UTF-8', 19:46:54 INFO - 'LANGUAGE': 'en_US:en', 19:46:54 INFO - 'LOGNAME': 'cltbld', 19:46:54 INFO - 'MAIL': '/var/mail/cltbld', 19:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:54 INFO - 'MOZ_NO_REMOTE': '1', 19:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:54 INFO - 'NO_EM_RESTART': '1', 19:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:54 INFO - 'SHELL': '/bin/bash', 19:46:54 INFO - 'SHLVL': '1', 19:46:54 INFO - 'TERM': 'linux', 19:46:54 INFO - 'TMOUT': '86400', 19:46:54 INFO - 'USER': 'cltbld', 19:46:54 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:54 INFO - '_': '/tools/buildbot/bin/python'} 19:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:54 INFO - Running setup.py (path:/tmp/pip-DJKzbB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:54 INFO - Running setup.py (path:/tmp/pip-DmGxlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:54 INFO - Running setup.py (path:/tmp/pip-CuPTlw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:54 INFO - Running setup.py (path:/tmp/pip-TVQ7DV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:54 INFO - Running setup.py (path:/tmp/pip-f1djIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:54 INFO - Running setup.py (path:/tmp/pip-460VDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:54 INFO - Running setup.py (path:/tmp/pip-A4Zfi2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:54 INFO - Running setup.py (path:/tmp/pip-LUhmfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:54 INFO - Running setup.py (path:/tmp/pip-s75_oT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:54 INFO - Running setup.py (path:/tmp/pip-2JtuMR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:54 INFO - Running setup.py (path:/tmp/pip-bHkjDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:55 INFO - Running setup.py (path:/tmp/pip-xYznFz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:55 INFO - Running setup.py (path:/tmp/pip-ggDzKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:55 INFO - Running setup.py (path:/tmp/pip-R7cyVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:55 INFO - Running setup.py (path:/tmp/pip-Kt_R8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:55 INFO - Running setup.py (path:/tmp/pip-wmPlXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:55 INFO - Running setup.py (path:/tmp/pip-FbKqo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:55 INFO - Running setup.py install for manifestparser 19:46:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:46:55 INFO - Running setup.py install for mozcrash 19:46:55 INFO - Running setup.py install for mozdebug 19:46:55 INFO - Running setup.py install for mozdevice 19:46:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:46:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:46:55 INFO - Running setup.py install for mozfile 19:46:55 INFO - Running setup.py install for mozhttpd 19:46:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozinfo 19:46:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozInstall 19:46:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozleak 19:46:56 INFO - Running setup.py install for mozlog 19:46:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for moznetwork 19:46:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozprocess 19:46:56 INFO - Running setup.py install for mozprofile 19:46:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozrunner 19:46:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:46:56 INFO - Running setup.py install for mozscreenshot 19:46:57 INFO - Running setup.py install for moztest 19:46:57 INFO - Running setup.py install for mozversion 19:46:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:46:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:57 INFO - Cleaning up... 19:46:57 INFO - Return code: 0 19:46:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:46: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')]} 19:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:46:57 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 19:46:57 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 19:46:57 INFO - Using env: {'DISPLAY': ':0', 19:46:57 INFO - 'HOME': '/home/cltbld', 19:46:57 INFO - 'LANG': 'en_US.UTF-8', 19:46:57 INFO - 'LANGUAGE': 'en_US:en', 19:46:57 INFO - 'LOGNAME': 'cltbld', 19:46:57 INFO - 'MAIL': '/var/mail/cltbld', 19:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:57 INFO - 'MOZ_NO_REMOTE': '1', 19:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:57 INFO - 'NO_EM_RESTART': '1', 19:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:57 INFO - 'SHELL': '/bin/bash', 19:46:57 INFO - 'SHLVL': '1', 19:46:57 INFO - 'TERM': 'linux', 19:46:57 INFO - 'TMOUT': '86400', 19:46:57 INFO - 'USER': 'cltbld', 19:46:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:57 INFO - '_': '/tools/buildbot/bin/python'} 19:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:57 INFO - Running setup.py (path:/tmp/pip-cBGl3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:57 INFO - Running setup.py (path:/tmp/pip-I87eex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:57 INFO - Running setup.py (path:/tmp/pip-NeJsBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:57 INFO - Running setup.py (path:/tmp/pip-hrNmVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:57 INFO - Running setup.py (path:/tmp/pip-YJXNY5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:57 INFO - Running setup.py (path:/tmp/pip-s9C4_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:57 INFO - Running setup.py (path:/tmp/pip-THci1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:46:57 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)) 19:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:57 INFO - Running setup.py (path:/tmp/pip-xyZNkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:58 INFO - Running setup.py (path:/tmp/pip-FiCPW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:58 INFO - Running setup.py (path:/tmp/pip-1ZeE6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:58 INFO - Running setup.py (path:/tmp/pip-ma_zBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:58 INFO - Running setup.py (path:/tmp/pip-EGKEhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:58 INFO - Running setup.py (path:/tmp/pip-DKPvq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:58 INFO - Running setup.py (path:/tmp/pip-KbPvza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:58 INFO - Running setup.py (path:/tmp/pip-ZXLGlq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:58 INFO - Running setup.py (path:/tmp/pip-z5_2hX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:46:58 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)) 19:46:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:58 INFO - Running setup.py (path:/tmp/pip-yNsYuM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:46:58 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)) 19:46:58 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)) 19:46:58 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)) 19:46:58 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)) 19:46:58 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)) 19:46:58 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)) 19:46:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:00 INFO - Downloading blessings-1.5.1.tar.gz 19:47:00 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 19:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:47:00 INFO - Installing collected packages: blessings 19:47:00 INFO - Running setup.py install for blessings 19:47:00 INFO - Successfully installed blessings 19:47:00 INFO - Cleaning up... 19:47:00 INFO - Return code: 0 19:47:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:47:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:00 INFO - Reading from file tmpfile_stdout 19:47:00 INFO - Current package versions: 19:47:00 INFO - argparse == 1.2.1 19:47:00 INFO - blessings == 1.5.1 19:47:00 INFO - blobuploader == 1.2.4 19:47:00 INFO - docopt == 0.6.1 19:47:00 INFO - manifestparser == 1.1 19:47:00 INFO - mozInstall == 1.12 19:47:00 INFO - mozcrash == 0.16 19:47:00 INFO - mozdebug == 0.1 19:47:00 INFO - mozdevice == 0.47 19:47:00 INFO - mozfile == 1.2 19:47:00 INFO - mozhttpd == 0.7 19:47:00 INFO - mozinfo == 0.9 19:47:00 INFO - mozleak == 0.1 19:47:00 INFO - mozlog == 3.0 19:47:00 INFO - moznetwork == 0.27 19:47:00 INFO - mozprocess == 0.22 19:47:00 INFO - mozprofile == 0.27 19:47:00 INFO - mozrunner == 6.11 19:47:00 INFO - mozscreenshot == 0.1 19:47:00 INFO - mozsystemmonitor == 0.0 19:47:00 INFO - moztest == 0.7 19:47:00 INFO - mozversion == 1.4 19:47:00 INFO - psutil == 3.1.1 19:47:00 INFO - requests == 1.2.3 19:47:00 INFO - wsgiref == 0.1.2 19:47:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fa56bb64c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185d3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, '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': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', '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 19:47:00 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 19:47:00 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 19:47:00 INFO - Using env: {'DISPLAY': ':0', 19:47:00 INFO - 'HOME': '/home/cltbld', 19:47:00 INFO - 'LANG': 'en_US.UTF-8', 19:47:00 INFO - 'LANGUAGE': 'en_US:en', 19:47:00 INFO - 'LOGNAME': 'cltbld', 19:47:00 INFO - 'MAIL': '/var/mail/cltbld', 19:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:00 INFO - 'MOZ_NO_REMOTE': '1', 19:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:00 INFO - 'NO_EM_RESTART': '1', 19:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:00 INFO - 'SHELL': '/bin/bash', 19:47:00 INFO - 'SHLVL': '1', 19:47:00 INFO - 'TERM': 'linux', 19:47:00 INFO - 'TMOUT': '86400', 19:47:00 INFO - 'USER': 'cltbld', 19:47:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:00 INFO - '_': '/tools/buildbot/bin/python'} 19:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 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)) 19:47:01 INFO - Cleaning up... 19:47:01 INFO - Return code: 0 19:47:01 INFO - Running post-action listener: _resource_record_post_action 19:47:01 INFO - Running post-action listener: _start_resource_monitoring 19:47:01 INFO - Starting resource monitoring. 19:47:01 INFO - ##### 19:47:01 INFO - ##### Running install step. 19:47:01 INFO - ##### 19:47:01 INFO - Running pre-action listener: _resource_record_pre_action 19:47:01 INFO - Running main action method: install 19:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:47:01 INFO - Reading from file tmpfile_stdout 19:47:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:47:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:47:01 INFO - Reading from file tmpfile_stdout 19:47:01 INFO - Output received: 19:47:01 INFO - Usage: mozinstall [options] installer 19:47:01 INFO - Options: 19:47:01 INFO - -h, --help show this help message and exit 19:47:01 INFO - -d DEST, --destination=DEST 19:47:01 INFO - Directory to install application into. [default: 19:47:01 INFO - "/builds/slave/test-pgo"] 19:47:01 INFO - --app=APP Application being installed. [default: firefox] 19:47:01 INFO - mkdir: /builds/slave/test-pgo/build/application 19:47:01 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'] 19:47:01 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 19:47:15 INFO - Reading from file tmpfile_stdout 19:47:15 INFO - Output received: 19:47:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:47:15 INFO - Running post-action listener: _resource_record_post_action 19:47:15 INFO - ##### 19:47:15 INFO - ##### Running run-tests step. 19:47:15 INFO - ##### 19:47:15 INFO - Running pre-action listener: _resource_record_pre_action 19:47:15 INFO - Running main action method: run_tests 19:47:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:47:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:47:15 INFO - Python 2.7.3 19:47:15 INFO - Return code: 0 19:47:15 INFO - grabbing minidump binary from tooltool 19:47:15 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')]} 19:47:15 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 0x18e68c0>, '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 0x1893420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18938b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:47:15 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 19:47:15 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 19:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:15 INFO - Return code: 0 19:47:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:47:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:47:15 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/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:47:15 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/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 19:47:15 INFO - Using env: {'DISPLAY': ':0', 19:47:15 INFO - 'HOME': '/home/cltbld', 19:47:15 INFO - 'LANG': 'en_US.UTF-8', 19:47:15 INFO - 'LANGUAGE': 'en_US:en', 19:47:15 INFO - 'LOGNAME': 'cltbld', 19:47:15 INFO - 'MAIL': '/var/mail/cltbld', 19:47:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:15 INFO - 'MOZ_NO_REMOTE': '1', 19:47:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:15 INFO - 'NO_EM_RESTART': '1', 19:47:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:47:15 INFO - 'PWD': '/builds/slave/test-pgo', 19:47:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:47:15 INFO - 'SHELL': '/bin/bash', 19:47:15 INFO - 'SHLVL': '1', 19:47:15 INFO - 'TERM': 'linux', 19:47:15 INFO - 'TMOUT': '86400', 19:47:15 INFO - 'USER': 'cltbld', 19:47:15 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564', 19:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:15 INFO - '_': '/tools/buildbot/bin/python'} 19:47:15 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/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 19:47:16 INFO - mozversion INFO | application_buildid: 20151116173018 19:47:16 INFO - mozversion INFO | application_changeset: 31c31342f1ea35b6396e99def49076df4f4fd201 19:47:16 INFO - mozversion INFO | application_display_name: Nightly 19:47:16 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:16 INFO - mozversion INFO | application_name: Firefox 19:47:16 INFO - mozversion INFO | application_remotingname: firefox 19:47:16 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:47:16 INFO - mozversion INFO | application_vendor: Mozilla 19:47:16 INFO - mozversion INFO | application_version: 45.0a1 19:47:16 INFO - mozversion INFO | platform_buildid: 20151116173018 19:47:16 INFO - mozversion INFO | platform_changeset: 31c31342f1ea35b6396e99def49076df4f4fd201 19:47:16 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:47:16 INFO - mozversion INFO | platform_version: 45.0a1 19:47:16 INFO - 2015-11-16 19:47:16,002 DEBUG : using testdate: 1447732036 19:47:16 INFO - 2015-11-16 19:47:16,002 DEBUG : actual date: 1447732036 19:47:16 INFO - 2015-11-16 19:47:16,011 INFO : starting webserver on 'localhost:47700' 19:47:16 INFO - 2015-11-16 19:47:16,012 INFO : Starting test suite talos-linux64-ix-045 19:47:16 INFO - 2015-11-16 19:47:16,012 INFO : Starting test dromaeo_css 19:47:16 INFO - 2015-11-16 19:47:16,012 DEBUG : operating with platform_type : linux_ 19:47:16 INFO - 2015-11-16 19:47:16,013 INFO : Initialising browser for dromaeo_css test... 19:47:16 INFO - 2015-11-16 19:47:16,027 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl8h8g3/profile http://localhost:47700/getInfo.html 19:47:20 INFO - 2015-11-16 19:47:20,677 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:47:20 INFO - 2015-11-16 19:47:20,677 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:47:20 INFO - 2015-11-16 19:47:20,677 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:47:20 INFO - 2015-11-16 19:47:20,677 DEBUG : BROWSER_OUTPUT: __metrics 19:47:20 INFO - 2015-11-16 19:47:20,822 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:21 INFO - 2015-11-16 19:47:21,997 INFO : Browser initialized. 19:47:21 INFO - 2015-11-16 19:47:21,998 INFO : Running cycle 1/1 for dromaeo_css test... 19:47:21 INFO - 2015-11-16 19:47:21,998 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl8h8g3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:47:33 INFO - 2015-11-16 19:47:33,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 19:47:33 INFO - 2015-11-16 19:47:33,716 DEBUG : BROWSER_OUTPUT: 19:48:25 INFO - 2015-11-16 19:48:25,087 DEBUG : BROWSER_OUTPUT: 1447732105079 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] 19:50:33 INFO - 2015-11-16 19:50:33,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47700/tests/dromaeo/cssquery-ext.html) 19:50:35 INFO - 2015-11-16 19:50:35,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 266518528 19:50:35 INFO - 2015-11-16 19:50:35,200 DEBUG : BROWSER_OUTPUT: 19:53:37 INFO - 2015-11-16 19:53:37,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-ext.html (next: http://localhost:47700/tests/dromaeo/cssquery-jquery.html) 19:53:38 INFO - 2015-11-16 19:53:38,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 230449152 19:53:38 INFO - 2015-11-16 19:53:38,258 DEBUG : BROWSER_OUTPUT: 19:56:40 INFO - 2015-11-16 19:56:40,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47700/tests/dromaeo/cssquery-mootools.html) 19:56:40 INFO - 2015-11-16 19:56:40,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 214114304 19:56:40 INFO - 2015-11-16 19:56:40,830 DEBUG : BROWSER_OUTPUT: 19:59:42 INFO - 2015-11-16 19:59:42,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47700/tests/dromaeo/cssquery-prototype.html) 19:59:43 INFO - 2015-11-16 19:59:43,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 203452416 19:59:43 INFO - 2015-11-16 19:59:43,357 DEBUG : BROWSER_OUTPUT: 20:02:45 INFO - 2015-11-16 20:02:45,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47700/tests/dromaeo/cssquery-yui.html) 20:02:46 INFO - 2015-11-16 20:02:46,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 207671296 20:02:46 INFO - 2015-11-16 20:02:46,451 DEBUG : BROWSER_OUTPUT: 20:05:48 INFO - 2015-11-16 20:05:48,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/dromaeo/cssquery-yui.html (next: http://localhost:47700/tests/dromaeo/cssquery-dojo.html) 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 291074048 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:05:49 INFO - 2015-11-16 20:05:49,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:05:49 INFO - 2015-11-16 20:05:49,133 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3123.344097739475;3204.375146846363;3239.708426241638;3242.902712918612;3267.656896025918;5147.459516750743;5256.132738098218;5314.335708036496;5341.439148889364;5354.089804733195;5298.390685071218;5334.226537152111;5361.249425080492;5382.59630527711;5383.596230282735;4784.6650734448685;4852.636052296074;4880.658353915227;4885.267209918505;4944.604431645478;4962.0820148272505;5049.722265275408;5051.267566202899;5074.695518268897;5114.872128196787;4711.7879695413785;4803.135435621587;4986.775595098229;5001.599872010249;5054.646174767768;4889.633277504201;4899.020195960822;4900;4912.066707325596;4918.286848406961;4754.738489383082;4906.55840974314;4914.189158788796;4921.8523444296725;4922.75386230687;5222.712750798704;5227.294315267428;5239.816606418757;5243.973780131075;5261.237120617528;5796.275465566804;5797.971010144923;5805.564582656318;5805.622634528742;5808.273965754281;5665.1502274658715;5819.098039803837;5831.416858314177;5836.270466191726;5836.533077353844;5374.785008599691;5444.50999410055;5444.945550544523;5448.482394172547;5495.642783219078;5871.3541510433815;5874.236349274567;5893.911591326134;5918.141869428909;5930.7924222652;5528.75120619573;5551.805686800943;5710.371859095496;5724.771009159587;5729.828105156852;5844.8538786529825;5850.912236316459;5858.794942177004;5885.440883116097;5894.646321220741;5801.82594522165;5815.505682016991;5823.79616713413;5830.883382332329;5837;5641.9435805641415;5651.237082993825;5769.336526299529;5782.421757824184;5814.738336774855;4484.506704262529;4485.215087359699;4486.147631949919;4505.594496495266;4527.61515271199;4006.8397264109108;4032.4354590357375;4037.253108174997;4060.837566497366;4061.248668996245;5177.7152256625495;5296.152615581488;5319.601029922771;5430.538404235605;5443.047466693313;5742.196092547047;5748.109043098327;5758.62568933018;5763.711814409263;5820.185174075633;5389.083855744533;5391.191321301836;5399.7030163340605;5400.594955378362;5401.351837779492;4921.212605983025;4959.280904268933;5016.44819069902;5060.367454068241;5063.468335824686;5927.170196172626;5939.940600594025;5940.495057920125;5943.673097979653;6008.03871380577;5717.17101020358;5719.48524632785;5734.856628584319;5736.942630573808;5751.511121554715;5764.308283005898;5903.793367232126;5916.378780228014;5916.911246331222;5933.376995415592;5757.8560535986935;5774.971125144348;5784.045632470596;5786.363500015079;5787.536997040311;5846.444587764156;5848.736806843787;5870.853228669317;5871.970640146772;5874.94125058744;5374.355077390738;5478.808241711521;5481.698506582016;5559;5673.177389278614;5706.80026199081;5710.2862142232225;5712.171735098304;5716.456936591017;5722.62802917809;5571.721413929368;5621.409751975983;5624;5628.943710563006;5634.464725851038;5415.404305526467;5475.5072043516275;5570.916436253378;5585.3297604287745;5699.658020518782;5565.944340556543;5566.443355664401;5582.358028826737;5582.944170558242;5584.078627026658 20:05:49 INFO - 2015-11-16 20:05:49,134 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.9452851979062;578.6296770067156;580.4195804195804;580.7676929228305;582.9245042895856;31976;33308.83345583272;41009.58990410095;41039;41113.794431027876;44463.110737785304;45225.77387113068;45287.32069018959;45293.77353113238;45308;7682.807929801744;8802.95598522008;8915.153060459246;8975.95512022439;8977.640894364251;7744.070711514626;10695.518701658406;10894.618688345909;10981.12151027916;10984.121270298398;10611.893881061207;10691.679249622524;10735.892641073606;10738.73153171173;10751.462426878665;7663.846723065508;7777.572233527154;10577.259591828575;10697.411642359628;10740.838887416696;10396.220283478693;10536.420496872668;10536.473176341153;10536.578536858517;10539;40376;40384.79807600973;40523.7973810132;40830.183396332206;41061.794691026356;3372.5109859070544;3390.677885600864;3393.7624366294367;3406.5230867678547;3419.743519236042;30874.228144296347;31135.688643113506;31261.374772504423;31330;31403.84298078518;3352.5186320366133;3492.7904325740537;3525.1539630488755;3532.8160458225543;3639.3813051781262;278921;279725;279807.99999999796;280300;280669;53442;54857.177142342895;63258.683706582095;63680;68640.31359686439;63942;64001.71996560136;64317.35682643114;64319;64345;16046.117463539384;16106.597335066717;16240.918795405947;16246.212916579167;16256.837431625769;11932.522699092113;12011.519539218509;12105.273683579013;12121.696957575954;12132.939335303443;20533.486662833548;20849.89575052115;21005.579888402146;21028.579428411347;21060.89469552673;7783.610819459004;8069.305445856436;8090.514569125754;8135.210253744167;8163.346932245406;907.5734404829719;913.6710784117712;1003.82934901067;1004.5178314409125;1113.560143743233;28583;28875;29073;29154.708452915624;29401.264968375963;994.8310734886624;1029.2692188546066;1051.3849398102043;1105.9336439813476;1146.1690274550883;14923.552293431214;15465.381384744709;15672.921635391978;15938.920305398631;16179.514614561582;331372;332615;334911;335355;335879;48656.513434865905;48702.26946595804;48859;49089.263661045115;49128.26307605389;1354.8441929178073;1363.9454421823214;1364.2292104960666;1365.6312795545148;1373.7527245095978;26780.59829102604;27728.168154955383;28501;29166.708332916398;29380.85309573524;44250.55749442464;45137.548624513336;47285.52714472811;50906.745466272434;51727.74136129295;221115;222521;223533;223869;224476;28642.560403137548;30017.849910750305;30398;30446.695533044385;30518;33428.665713342554;37832.62167378291;41670;42003.36994945017;42772.57227427811;37506.6249337514;38509.4223586652;39304.606953930095;39439.80280098581;40031.59968400279;38128.61871381251;38586.421203681406;38813.41779873361;39064;39216.21567568689;36036.81981590075;36315.45526817047;36343;37849;38124.42813357857;31917.68082319147;33760.66239337673;33913.3217335647;34079.48880766741;34194.14514637154;25229.747702522738;25240.242792716246;25346.74653253444;25371.238862834143;25524.9790008405 20:05:49 INFO - 2015-11-16 20:05:49,135 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.25597337737184;346.5858299332298;347.3487211478478;348.30339321357286;348.362496631165;14425;14657.486987955397;17754;18537.721934170982;19736.407907762754;12084.2145260558;12478.688032799184;17678.292868285287;17954.64090718185;17982.730259046126;4432.202203603342;4561.1789877821975;4561.543845615445;4566.1780879441685;4572.177008138534;3507.5089487471773;3574.696150827183;4506.4817545982305;4894.265860120975;5048.6465947383695;4944.579710724593;4986.152354099811;4986.800527978877;4986.950130498685;5007.84976450707;4846.39420072491;4936.308916751657;4947.455779864212;4948.356713627206;4955.256711493269;4275.508316543606;4280.5291417944;4292.29177185764;4296.419983302246;4296.699231053827;13847.930760346133;13960;14197.148171109766;14204.431822727078;14208.92895535526;1956.8211316866295;1987.2547794577033;2003.9499012524657;2112.5563631637374;2140.090461553849;9894.802103957953;9992;10006;10199.18406527476;10285.125764310043;1662.0609355714105;1706.13840010795;1706.4880535839322;1721.1308289313943;1725.215027162638;58795.41204587942;59856;61311.38688613101;61475;63012.219266844135;6891.862162756717;6898.413634841095;7156.60638664868;7168.677409516585;7233.31283528064;8599;8610.78473038179;8611.268042216356;8617.09520500351;8629.913700863037;5708.20085188074;5759.625624334405;5792.102224155263;5792.594518383673;5847.093700476348;5969.194158788508;5999.910001349983;6034.24571928509;6049;6072.605280656743;3336.9666303336658;3382.3573521030926;3393.830308484566;3402.3705614461405;3406.744494162948;1141.2524796258465;1175.61204802415;1178.1693905796392;1201.2401831317163;1230.2126638951079;464.1969392950215;485.6988667026466;498.8827625508003;500.2346409992717;506.2962482149741;10696;12067.275963442222;12166.209196402206;12374.81437778434;12400.875991239973;499.43563772937074;507.18596652373145;510.45891355163644;520.232656831171;538.727942389091;6387.648679322589;6397.648129352837;6520.315366886503;6794.76218332356;6843.486738494633;510630.4468477634;537903;538784.4276351006;539570.5107372268;558550;74948;76469.23530764622;77517.61241193871;78070.60964695254;78974.21025789669;553.7950958145512;568.0541897740299;572.6964708704394;572.7880684146892;574.3280361976498;10740.30188037775;11299.661010169708;11317.830232546354;11346.94326528362;11437.485313161094;32032.35935281328;33048.50427243545;33080.50379244265;33378.16554586155;33419.66580334165;40344.94825776157;41414.58585414228;42077.36883946804;42446.1510769789;42654.78672606617;6646.2356828965285;6845.897311540231;6856.5200435969;6883;6885.414739747178;12169.148159629096;12308.876911230773;12313.815292770794;12658.936705316415;12753.808692869428;10531.526081326205;10886.67339979802;11196.272242304223;11198.776024479628;11237.831432528683;10547.630832920811;10711.785764284827;10738;10770.192235582206;11018.50416731265;9223.677171298972;9545.188658964065;9568.90431095708;10230.28388012832;10546.156307495536;6463.192100987377;6526.086347911201;6744.595324280559;6770.356816102462;6866.073080134118;10728.141748659933;10799.437591615866;10993.61522346714;11261.549538018387;11341.603043893425 20:05:49 INFO - 2015-11-16 20:05:49,135 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1277.0422183362477;1691.687037897989;1726.805409991515;1758.3230456274339;1772.7163653815385;6833.384995350418;7543.132539757929;7629.6948122075055;7629.809254768634;7657.961710191441;7532.359749421305;7657.27255910689;7659.808504787383;7660.578668173248;7665.501742386741;1972.4082775167465;2021.29254760834;2025.574629327843;2209.4586826227596;2240.395093324801;2028.381343690174;2191.835612329082;2253.7070180876462;2255.729312482496;2260.5704916065893;2149.967750483744;2178.1396348442354;2178.3900507857825;2207.75714671386;2213.5462230242842;1848.8428483578912;1875.6154988227381;2201.350601572532;2226.231949977255;2231.3194475684827;2208.8122509586706;2257.3002369265582;2258.299927022612;2259.49161438675;2259.9774002260096;7496.400287976949;7627.122880868716;7632.198619144965;7639.388848892076;7655.885161722578;4607.539246075399;4668.813247470097;4675.766211689402;4709;4711.905761884777;2901.608282881805;2987.327851233477;2994.5657879607334;2995.925101872449;3009.217603423104;959.7024922274118;982.3516479123743;989.4459102902398;1016.0296916444778;1050.76883085721;10051.39691618498;10053.849192262122;10069.647562335356;10076.546555405024;10169.898301017043;4102.774347410861;4145.54399016108;4216.388623649554;4225.5985681360835;4255.1915136124035;8694.478331300143;8705.912940870638;8706;8707.695230666895;8725.563721813884;4631.490536041033;4644.883877903079;4645.3032045193495;4647.047355292157;4652.813887444464;4172.123853990696;4191.476065491814;4203.07532342884;4204.600562946515;4217.7891105444605;3611.422172452395;3637.7635453695425;3644.4351125575577;3658.689011434005;3684.3184010958057;1167.3696204049718;1177.0877569883237;1185.8814118588073;1186.8635106962638;1190.6844686158174;1275.3304515129446;1341.7249463859885;1342.939567719455;1373.5535950815824;1375.3054707372912;7358.96320518394;7376.815579610553;7385.150707668687;7402.9629851850395;7403.925960740431;1195.6413076077315;1201.6995751062234;1217.4704003758393;1228.8648248692637;1263.7977923532192;5468.945310546844;5484.8354549363585;5668.319801623831;6044.607100538451;6171.197744293213;8453.535055572003;8927.24118449939;9021.819563608691;9065.365424420228;9096.8635470468;8434;8480.660773569112;8482.109378515168;8495.065542790288;8496.787580310542;7193.5324203926575;7282.4902256841515;7312.744053958086;7350.705971761176;7355.338019578264;7012.088428504262;7083.079199704005;7105.893411598933;7106.218315985134;7118;7687.423443241891;7782.727604533814;7949.483283586548;8072.636731346986;8130.227628375294;8006.399520036137;8237.299829514559;8330.166983301622;8335.24982751531;8351.624176911931;6727.125473688389;6736.4947628929;6779.559328643622;6802.795916122524;6827.21487028998;7225.205227425085;7296.087989001375;7297.197308295977;7300.780976570712;7308.269173082649;6536.182977127859;6695.832604184934;6848.212455567674;6964.373206411447;7013;6669.266380698023;6678.799636010927;6735.057092007025;6891.035255064396;6913.446924246149;6806.387425131762;6846.281140480377;6853.109095817512;6861.485388595976;6862.142232220973;6335.873282534231;6382.138411314599;6431.517636177212;6442.162518872517;6446.323136070645;6489.059086432535;6547.247066587403;6552.312007239362;6552.705128269335;6565.638889861103 20:05:49 INFO - 2015-11-16 20:05:49,137 DEBUG : BROWSER_OUTPUT: |4;prototype.html;317.8379026696385;320.5768385730835;322.93854261600046;326.4597091813049;330.2042078590596;5950.166976623276;6069.878602427949;6082.939170608298;6120.602160859541;6126.479249263813;5872.207252020976;5994.790182343619;6005.789797357093;6033.849153771158;6045.939540604592;4616.653750968674;4643.2802915548145;4648.395708557883;4654.2785868190485;4660.370849935266;4449.5995360417555;4548.340490628873;4556.088782243548;4566.885827854314;4646.4191976003;4458.086092351076;4519.932201016987;4539.773011349419;4539.773011349436;4556.954430455686;4538.205813982539;4541.43232095988;4552.339910712928;4552.749598772066;4574;3971.8808435746687;3973.145773658677;3974.205158968218;3976.483057202574;3977.7016723745833;5598.24423702799;5698.51562617178;5703.5152012079025;5725.912076705413;5760.855978600526;5299.814506492293;5301.787928482856;5304.416514183436;5305.840824775263;5312.362516498007;6112.083187521863;6464.385883341122;6469.644169570672;6470.158879345702;6471.805845824586;4240.830366785325;4273.209456250604;4334.068175342285;4343.435353404037;4350.6736994725525;6552.9344706553275;6637.93362066378;6652.401283884474;6652.501062420338;6658.533902626818;4392.890177745582;4393.890152746143;4395.626371758436;4398.318260669537;4404;4362.607365337135;4448.510663826976;4451.243288640939;4494.820207191741;4516.977415112903;5271.288376069181;5284.207368894697;5286.3392075990505;5289.6032797539565;5292.973535132377;6485.3514648534765;6492.480601551864;6494;6496.967515162394;6499.480041596661;1582.8654564362157;1595.9840401595836;1596.1779683463026;1597.2013993003497;1597.5846279967293;1042.8852826189113;1046.0899017854363;1050.2858056521486;1051.2693677893944;1076.7523469602036;6135.938640613626;6139.26328840542;6143.354947730513;6144.600600960924;6150.261968563801;6613.603183808987;6636.336366363422;6640.734370625218;6652.368025037614;6653.933460665428;6041.848953776191;6177.413145751147;6182.969085154636;6186.81439556814;6190.350013248634;3584.713222942158;3601.8019008954757;3604.6034936157002;3605;3608.530890984155;6922.896156557656;6925.75759848413;6925.930740692528;6931.618760968095;6940.340667636567;6643.900341494881;6820.931790682129;6821.1814582250445;6831.248562658104;6832.385085342343;6886.139232595926;6891.483138764513;6899.48253880961;6912.101426814583;6917;6433.806985790434;6612.437942774725;6613.603183808795;6620.933790662224;6624.635645039569;6493.090967264681;6541.542092053701;6630.602163870183;6655.134832471747;6655.866882662416;6882.449404047564;6892.965535172292;6894.517383783087;6897;7000.334968178015;4355.324924636687;4416.034864485273;4424.911501769882;4427.867163985085;4494.303382975644;6669.733210671713;6678.131842860591;6678.432333251728;6686.197656281277;6692.732290708317;6468.223813142453;6514.283428822731;6518.185226846645;6519.348065193442;6521.543491955707;6286.874262514815;6487.286398496256;6501.51238657112;6504.772332968512;6529.8694026120165;6392.264889537577;6393.456556192776;6396.200474940632;6398.936010639834;6402.679866006774;6497.545171837926;6522.249941256627;6532.902006469812;6538.574992625464;6548.116004339544;6196.752129914933;6346.048092786119;6346.524010699124;6348.71430785625;6362.077498762561 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.3525826755919;734.2217249715302;743.3829921165429;769.8160497695031;804.4811096842536;14225.715485690293;14447.133172009686;14550.19973901435;14583.197924114156;14614.123152610837;14543.490977815778;14989.550313490585;15051.849481505182;15057.924710376432;15088.54734357971;681.8261343357437;689.1144878830704;825.7646570727329;840.0129847429276;840.920112589303;809.1423091522975;825.3603457320564;832.8209434971479;832.9333653307751;833.3374966901298;857.9871301930476;865.2774932930979;868.7567481105269;870.0429527519709;871.2768402226137;695.6904177640952;702.8769965256085;842.4860834890711;842.5408152556871;856.4732689396039;627.2598333965918;627.5952010952956;628.5286035473395;628.6416742456802;628.8836565235446;13274.070815042951;13334.133281336683;13347.265900375476;13369.264690442022;13500.932495337558;10240;10390.48047597617;10671.626493072705;10768.569257229701;10911.454427278604;9860.211183105333;10086.193104551618;10124.29129960903;10227.693169204937;10423.791524169474;3328.866845326184;3341.816200108993;3342.398368293706;3375.7805742626897;3386.373520898642;47712.5228747715;47935;48184.518154818354;48253.51746482525;48398;6966.12923384577;7356.558606483628;7367.300106489874;7503.699852005859;7653.387728981668;11590.942045289888;11617.477213525412;11620.128490363088;11626.1861669684;11641.126915481373;6439.5170362223025;6680.532362734659;6810.148731408574;6925.134358205224;6979.8604027919155;4099.672026237894;4263.957360426356;4265.4241677373775;4316.482022157361;4380.255356589388;2796.7902407319534;2817.3097591089904;2819.6898341182455;2820.901268455594;2822.534281843514;406.42693801739404;418.24089277960405;422.6618705035959;424.27025516112235;434.7782630858222;545.7598656591088;570.8829689913558;630.2751835389247;692.2661978303015;734.9669264883094;8347.749567512985;8482.872756908651;8546.957265213634;8651.307895368356;9333.813323733488;715.2418436457372;717.8026042838261;718.8110369716735;732.1068296678044;735.4557627355719;4004.619561141687;4207.221663992172;4256.61690447855;4288.1638080573985;4341.088371442032;59099.704501478074;60134.09798853021;60352.698236509415;60450;60616;53312.73343633257;53734.00033814409;54155.72922135364;54321.72839135779;54502.182467263025;47867;48262.27606585904;48543.27185092226;48762.75618621955;49078;8209.917900820916;8363.247307742333;8439.873401898854;8447.239748422671;8562.272206862486;36613.450798238584;36903.63096369002;37039.44440833336;37052;38679;43388;43596.34605480857;44803.551964479935;45066.77466612646;46422.53577464317;8147.714829980922;8406.28546573548;8483.363747718822;8649.264812491008;8656.540774501173;12172.147949643795;12262.141650084408;12452.750944980868;12538.435770390171;12575.371231438208;11473.254238474472;11720.238184517979;11892.821607676065;12037.819432708691;12349.135560510678;10627.09669678086;10789.352638841694;11070.723231919266;11290.966428485797;11298.548058077586;10709.303895246783;11000.284981476178;11168.441577921234;11213.71965700864;11891.67622562445;9598;9786.41281523111;9882.654107106217;9916.900830991597;10038.092762375125;9264;9342.53287335617;9399.765005874908;9764;9779.804403912025 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1087 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: __startTimestamp1447733149129__endTimestamp 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:05:49 INFO - 2015-11-16 20:05:49,138 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5361.72 Median:5559.00 stddev:587.81 (10.6%) stddev-sans-first:562.78 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: Values: 3123.3 3204.4 3239.7 3242.9 3267.7 5147.5 5256.1 5314.3 5341.4 5354.1 5298.4 5334.2 5361.2 5382.6 5383.6 4784.7 4852.6 4880.7 4885.3 4944.6 4962.1 5049.7 5051.3 5074.7 5114.9 4711.8 4803.1 4986.8 5001.6 5054.6 4889.6 4899.0 4900.0 4912.1 4918.3 4754.7 4906.6 4914.2 4921.9 4922.8 5222.7 5227.3 5239.8 5244.0 5261.2 5796.3 5798.0 5805.6 5805.6 5808.3 5665.2 5819.1 5831.4 5836.3 5836.5 5374.8 5444.5 5444.9 5448.5 5495.6 5871.4 5874.2 5893.9 5918.1 5930.8 5528.8 5551.8 5710.4 5724.8 5729.8 5844.9 5850.9 5858.8 5885.4 5894.6 5801.8 5815.5 5823.8 5830.9 5837.0 5641.9 5651.2 5769.3 5782.4 5814.7 4484.5 4485.2 4486.1 4505.6 4527.6 4006.8 4032.4 4037.3 4060.8 4061.2 5177.7 5296.2 5319.6 5430.5 5443.0 5742.2 5748.1 5758.6 5763.7 5820.2 5389.1 5391.2 5399.7 5400.6 5401.4 4921.2 4959.3 5016.4 5060.4 5063.5 5927.2 5939.9 5940.5 5943.7 6008.0 5717.2 5719.5 5734.9 5736.9 5751.5 5764.3 5903.8 5916.4 5916.9 5933.4 5757.9 5775.0 5784.0 5786.4 5787.5 5846.4 5848.7 5870.9 5872.0 5874.9 5374.4 5478.8 5481.7 5559.0 5673.2 5706.8 5710.3 5712.2 5716.5 5722.6 5571.7 5621.4 5624.0 5628.9 5634.5 5415.4 5475.5 5570.9 5585.3 5699.7 5565.9 5566.4 5582.4 5582.9 5584.1 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45754.72 Median:169131.76 stddev:73787.28 (43.6%) stddev-sans-first:73916.30 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: Values: 575.9 578.6 580.4 580.8 582.9 31976.0 33308.8 41009.6 41039.0 41113.8 44463.1 45225.8 45287.3 45293.8 45308.0 7682.8 8803.0 8915.2 8976.0 8977.6 7744.1 10695.5 10894.6 10981.1 10984.1 10611.9 10691.7 10735.9 10738.7 10751.5 7663.8 7777.6 10577.3 10697.4 10740.8 10396.2 10536.4 10536.5 10536.6 10539.0 40376.0 40384.8 40523.8 40830.2 41061.8 3372.5 3390.7 3393.8 3406.5 3419.7 30874.2 31135.7 31261.4 31330.0 31403.8 3352.5 3492.8 3525.2 3532.8 3639.4 278921.0 279725.0 279808.0 280300.0 280669.0 53442.0 54857.2 63258.7 63680.0 68640.3 63942.0 64001.7 64317.4 64319.0 64345.0 16046.1 16106.6 16240.9 16246.2 16256.8 11932.5 12011.5 12105.3 12121.7 12132.9 20533.5 20849.9 21005.6 21028.6 21060.9 7783.6 8069.3 8090.5 8135.2 8163.3 907.6 913.7 1003.8 1004.5 1113.6 28583.0 28875.0 29073.0 29154.7 29401.3 994.8 1029.3 1051.4 1105.9 1146.2 14923.6 15465.4 15672.9 15938.9 16179.5 331372.0 332615.0 334911.0 335355.0 335879.0 48656.5 48702.3 48859.0 49089.3 49128.3 1354.8 1363.9 1364.2 1365.6 1373.8 26780.6 27728.2 28501.0 29166.7 29380.9 44250.6 45137.5 47285.5 50906.7 51727.7 221115.0 222521.0 223533.0 223869.0 224476.0 28642.6 30017.8 30398.0 30446.7 30518.0 33428.7 37832.6 41670.0 42003.4 42772.6 37506.6 38509.4 39304.6 39439.8 40031.6 38128.6 38586.4 38813.4 39064.0 39216.2 36036.8 36315.5 36343.0 37849.0 38124.4 31917.7 33760.7 33913.3 34079.5 34194.1 25229.7 25240.2 25346.7 25371.2 25525.0 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,139 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26829.12 Median:4296.56 stddev:88037.69 (2049.0%) stddev-sans-first:88262.20 20:05:49 INFO - 2015-11-16 20:05:49,140 DEBUG : BROWSER_OUTPUT: Values: 345.3 346.6 347.3 348.3 348.4 14425.0 14657.5 17754.0 18537.7 19736.4 12084.2 12478.7 17678.3 17954.6 17982.7 4432.2 4561.2 4561.5 4566.2 4572.2 3507.5 3574.7 4506.5 4894.3 5048.6 4944.6 4986.2 4986.8 4987.0 5007.8 4846.4 4936.3 4947.5 4948.4 4955.3 4275.5 4280.5 4292.3 4296.4 4296.7 13847.9 13960.0 14197.1 14204.4 14208.9 1956.8 1987.3 2003.9 2112.6 2140.1 9894.8 9992.0 10006.0 10199.2 10285.1 1662.1 1706.1 1706.5 1721.1 1725.2 58795.4 59856.0 61311.4 61475.0 63012.2 6891.9 6898.4 7156.6 7168.7 7233.3 8599.0 8610.8 8611.3 8617.1 8629.9 5708.2 5759.6 5792.1 5792.6 5847.1 5969.2 5999.9 6034.2 6049.0 6072.6 3337.0 3382.4 3393.8 3402.4 3406.7 1141.3 1175.6 1178.2 1201.2 1230.2 464.2 485.7 498.9 500.2 506.3 10696.0 12067.3 12166.2 12374.8 12400.9 499.4 507.2 510.5 520.2 538.7 6387.6 6397.6 6520.3 6794.8 6843.5 510630.4 537903.0 538784.4 539570.5 558550.0 74948.0 76469.2 77517.6 78070.6 78974.2 553.8 568.1 572.7 572.8 574.3 10740.3 11299.7 11317.8 11346.9 11437.5 32032.4 33048.5 33080.5 33378.2 33419.7 40344.9 41414.6 42077.4 42446.2 42654.8 6646.2 6845.9 6856.5 6883.0 6885.4 12169.1 12308.9 12313.8 12658.9 12753.8 10531.5 10886.7 11196.3 11198.8 11237.8 10547.6 10711.8 10738.0 10770.2 11018.5 9223.7 9545.2 9568.9 10230.3 10546.2 6463.2 6526.1 6744.6 6770.4 6866.1 10728.1 10799.4 10993.6 11261.5 11341.6 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5321.35 Median:6444.24 stddev:2686.78 (41.7%) stddev-sans-first:2677.12 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: Values: 1277.0 1691.7 1726.8 1758.3 1772.7 6833.4 7543.1 7629.7 7629.8 7658.0 7532.4 7657.3 7659.8 7660.6 7665.5 1972.4 2021.3 2025.6 2209.5 2240.4 2028.4 2191.8 2253.7 2255.7 2260.6 2150.0 2178.1 2178.4 2207.8 2213.5 1848.8 1875.6 2201.4 2226.2 2231.3 2208.8 2257.3 2258.3 2259.5 2260.0 7496.4 7627.1 7632.2 7639.4 7655.9 4607.5 4668.8 4675.8 4709.0 4711.9 2901.6 2987.3 2994.6 2995.9 3009.2 959.7 982.4 989.4 1016.0 1050.8 10051.4 10053.8 10069.6 10076.5 10169.9 4102.8 4145.5 4216.4 4225.6 4255.2 8694.5 8705.9 8706.0 8707.7 8725.6 4631.5 4644.9 4645.3 4647.0 4652.8 4172.1 4191.5 4203.1 4204.6 4217.8 3611.4 3637.8 3644.4 3658.7 3684.3 1167.4 1177.1 1185.9 1186.9 1190.7 1275.3 1341.7 1342.9 1373.6 1375.3 7359.0 7376.8 7385.2 7403.0 7403.9 1195.6 1201.7 1217.5 1228.9 1263.8 5468.9 5484.8 5668.3 6044.6 6171.2 8453.5 8927.2 9021.8 9065.4 9096.9 8434.0 8480.7 8482.1 8495.1 8496.8 7193.5 7282.5 7312.7 7350.7 7355.3 7012.1 7083.1 7105.9 7106.2 7118.0 7687.4 7782.7 7949.5 8072.6 8130.2 8006.4 8237.3 8330.2 8335.2 8351.6 6727.1 6736.5 6779.6 6802.8 6827.2 7225.2 7296.1 7297.2 7300.8 7308.3 6536.2 6695.8 6848.2 6964.4 7013.0 6669.3 6678.8 6735.1 6891.0 6913.4 6806.4 6846.3 6853.1 6861.5 6862.1 6335.9 6382.1 6431.5 6442.2 6446.3 6489.1 6547.2 6552.3 6552.7 6565.6 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5356.04 Median:6123.54 stddev:1648.32 (26.9%) stddev-sans-first:1608.98 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: Values: 317.8 320.6 322.9 326.5 330.2 5950.2 6069.9 6082.9 6120.6 6126.5 5872.2 5994.8 6005.8 6033.8 6045.9 4616.7 4643.3 4648.4 4654.3 4660.4 4449.6 4548.3 4556.1 4566.9 4646.4 4458.1 4519.9 4539.8 4539.8 4557.0 4538.2 4541.4 4552.3 4552.7 4574.0 3971.9 3973.1 3974.2 3976.5 3977.7 5598.2 5698.5 5703.5 5725.9 5760.9 5299.8 5301.8 5304.4 5305.8 5312.4 6112.1 6464.4 6469.6 6470.2 6471.8 4240.8 4273.2 4334.1 4343.4 4350.7 6552.9 6637.9 6652.4 6652.5 6658.5 4392.9 4393.9 4395.6 4398.3 4404.0 4362.6 4448.5 4451.2 4494.8 4517.0 5271.3 5284.2 5286.3 5289.6 5293.0 6485.4 6492.5 6494.0 6497.0 6499.5 1582.9 1596.0 1596.2 1597.2 1597.6 1042.9 1046.1 1050.3 1051.3 1076.8 6135.9 6139.3 6143.4 6144.6 6150.3 6613.6 6636.3 6640.7 6652.4 6653.9 6041.8 6177.4 6183.0 6186.8 6190.4 3584.7 3601.8 3604.6 3605.0 3608.5 6922.9 6925.8 6925.9 6931.6 6940.3 6643.9 6820.9 6821.2 6831.2 6832.4 6886.1 6891.5 6899.5 6912.1 6917.0 6433.8 6612.4 6613.6 6620.9 6624.6 6493.1 6541.5 6630.6 6655.1 6655.9 6882.4 6893.0 6894.5 6897.0 7000.3 4355.3 4416.0 4424.9 4427.9 4494.3 6669.7 6678.1 6678.4 6686.2 6692.7 6468.2 6514.3 6518.2 6519.3 6521.5 6286.9 6487.3 6501.5 6504.8 6529.9 6392.3 6393.5 6396.2 6398.9 6402.7 6497.5 6522.2 6532.9 6538.6 6548.1 6196.8 6346.0 6346.5 6348.7 6362.1 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,141 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13733.93 Median:48330.14 stddev:16597.53 (34.3%) stddev-sans-first:16615.32 20:05:49 INFO - 2015-11-16 20:05:49,143 DEBUG : BROWSER_OUTPUT: Values: 719.4 734.2 743.4 769.8 804.5 14225.7 14447.1 14550.2 14583.2 14614.1 14543.5 14989.6 15051.8 15057.9 15088.5 681.8 689.1 825.8 840.0 840.9 809.1 825.4 832.8 832.9 833.3 858.0 865.3 868.8 870.0 871.3 695.7 702.9 842.5 842.5 856.5 627.3 627.6 628.5 628.6 628.9 13274.1 13334.1 13347.3 13369.3 13500.9 10240.0 10390.5 10671.6 10768.6 10911.5 9860.2 10086.2 10124.3 10227.7 10423.8 3328.9 3341.8 3342.4 3375.8 3386.4 47712.5 47935.0 48184.5 48253.5 48398.0 6966.1 7356.6 7367.3 7503.7 7653.4 11590.9 11617.5 11620.1 11626.2 11641.1 6439.5 6680.5 6810.1 6925.1 6979.9 4099.7 4264.0 4265.4 4316.5 4380.3 2796.8 2817.3 2819.7 2820.9 2822.5 406.4 418.2 422.7 424.3 434.8 545.8 570.9 630.3 692.3 735.0 8347.7 8482.9 8547.0 8651.3 9333.8 715.2 717.8 718.8 732.1 735.5 4004.6 4207.2 4256.6 4288.2 4341.1 59099.7 60134.1 60352.7 60450.0 60616.0 53312.7 53734.0 54155.7 54321.7 54502.2 47867.0 48262.3 48543.3 48762.8 49078.0 8209.9 8363.2 8439.9 8447.2 8562.3 36613.5 36903.6 37039.4 37052.0 38679.0 43388.0 43596.3 44803.6 45066.8 46422.5 8147.7 8406.3 8483.4 8649.3 8656.5 12172.1 12262.1 12452.8 12538.4 12575.4 11473.3 11720.2 11892.8 12037.8 12349.1 10627.1 10789.4 11070.7 11291.0 11298.5 10709.3 11000.3 11168.4 11213.7 11891.7 9598.0 9786.4 9882.7 9916.9 10038.1 9264.0 9342.5 9399.8 9764.0 9779.8 20:05:49 INFO - 2015-11-16 20:05:49,143 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:05:49 INFO - 2015-11-16 20:05:49,143 DEBUG : BROWSER_OUTPUT: 20:05:49 INFO - 2015-11-16 20:05:49,805 INFO : Browser exited with error code: 0 20:05:49 INFO - 2015-11-16 20:05:49,824 INFO : Completed test dromaeo_css (00:18:33) 20:05:49 INFO - 2015-11-16 20:05:49,824 INFO : Starting test kraken 20:05:49 INFO - 2015-11-16 20:05:49,824 DEBUG : operating with platform_type : linux_ 20:05:49 INFO - 2015-11-16 20:05:49,824 INFO : Initialising browser for kraken test... 20:05:49 INFO - 2015-11-16 20:05:49,830 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcjPcTI/profile http://localhost:47700/getInfo.html 20:05:53 INFO - 2015-11-16 20:05:53,565 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:05:53 INFO - 2015-11-16 20:05:53,566 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:05:53 INFO - 2015-11-16 20:05:53,566 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:05:53 INFO - 2015-11-16 20:05:53,566 DEBUG : BROWSER_OUTPUT: __metrics 20:05:53 INFO - 2015-11-16 20:05:53,682 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:54 INFO - 2015-11-16 20:05:54,867 INFO : Browser initialized. 20:05:54 INFO - 2015-11-16 20:05:54,867 INFO : Running cycle 1/1 for kraken test... 20:05:54 INFO - 2015-11-16 20:05:54,867 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcjPcTI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:06:06 INFO - 2015-11-16 20:06:06,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 141963264 20:06:06 INFO - 2015-11-16 20:06:06,659 DEBUG : BROWSER_OUTPUT: 20:06:09 INFO - 2015-11-16 20:06:09,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47700/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:09 INFO - 2015-11-16 20:06:09,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 178556928 20:06:09 INFO - 2015-11-16 20:06:09,720 DEBUG : BROWSER_OUTPUT: 20:06:12 INFO - 2015-11-16 20:06:12,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47700/tests/kraken/driver.html?testName=audio-dft) 20:06:12 INFO - 2015-11-16 20:06:12,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 169017344 20:06:12 INFO - 2015-11-16 20:06:12,851 DEBUG : BROWSER_OUTPUT: 20:06:15 INFO - 2015-11-16 20:06:15,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47700/tests/kraken/driver.html?testName=audio-fft) 20:06:16 INFO - 2015-11-16 20:06:16,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 151531520 20:06:16 INFO - 2015-11-16 20:06:16,312 DEBUG : BROWSER_OUTPUT: 20:06:18 INFO - 2015-11-16 20:06:18,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47700/tests/kraken/driver.html?testName=audio-oscillator) 20:06:18 INFO - 2015-11-16 20:06:18,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 154525696 20:06:18 INFO - 2015-11-16 20:06:18,836 DEBUG : BROWSER_OUTPUT: 20:06:21 INFO - 2015-11-16 20:06:21,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:21 INFO - 2015-11-16 20:06:21,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 155992064 20:06:21 INFO - 2015-11-16 20:06:21,571 DEBUG : BROWSER_OUTPUT: 20:06:24 INFO - 2015-11-16 20:06:24,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47700/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:25 INFO - 2015-11-16 20:06:25,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 155086848 20:06:25 INFO - 2015-11-16 20:06:25,037 DEBUG : BROWSER_OUTPUT: 20:06:28 INFO - 2015-11-16 20:06:28,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47700/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:28 INFO - 2015-11-16 20:06:28,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 157319168 20:06:28 INFO - 2015-11-16 20:06:28,973 DEBUG : BROWSER_OUTPUT: 20:06:31 INFO - 2015-11-16 20:06:31,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47700/tests/kraken/driver.html?testName=json-parse-financial) 20:06:32 INFO - 2015-11-16 20:06:32,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 155906048 20:06:32 INFO - 2015-11-16 20:06:32,287 DEBUG : BROWSER_OUTPUT: 20:06:33 INFO - 2015-11-16 20:06:33,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:34 INFO - 2015-11-16 20:06:34,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 166567936 20:06:34 INFO - 2015-11-16 20:06:34,425 DEBUG : BROWSER_OUTPUT: 20:06:36 INFO - 2015-11-16 20:06:36,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:36 INFO - 2015-11-16 20:06:36,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 165908480 20:06:36 INFO - 2015-11-16 20:06:36,820 DEBUG : BROWSER_OUTPUT: 20:06:38 INFO - 2015-11-16 20:06:38,893 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:39 INFO - 2015-11-16 20:06:39,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 170590208 20:06:39 INFO - 2015-11-16 20:06:39,466 DEBUG : BROWSER_OUTPUT: 20:06:41 INFO - 2015-11-16 20:06:41,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:42 INFO - 2015-11-16 20:06:42,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 179933184 20:06:42 INFO - 2015-11-16 20:06:42,434 DEBUG : BROWSER_OUTPUT: 20:06:44 INFO - 2015-11-16 20:06:44,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:45 INFO - 2015-11-16 20:06:45,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 178233344 20:06:45 INFO - 2015-11-16 20:06:45,516 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47700/tests/kraken/driver.html?testName=ai-astar) 20:06:47 INFO - 2015-11-16 20:06:47,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 237285376 20:06:47 INFO - 2015-11-16 20:06:47,427 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,428 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:06:47 INFO - 2015-11-16 20:06:47,428 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:06:47 INFO - 2015-11-16 20:06:47,428 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:06:47 INFO - 2015-11-16 20:06:47,429 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:06:47 INFO - 2015-11-16 20:06:47,429 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;103;110;111;111;98;109;116;110 20:06:47 INFO - 2015-11-16 20:06:47,429 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;146;160;127;145;149;124;162;124 20:06:47 INFO - 2015-11-16 20:06:47,429 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;160;161;160;161;165;160;161 20:06:47 INFO - 2015-11-16 20:06:47,429 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;70;83;92;72;71;72;100;92;72 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;146;91;91;90;144;92;91;133 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;146;145;146;145;146;144 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;95 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;57;57;58;58;59;65;55;57 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;70;69;69;69;68;70 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;91;85;84;85;86;86;85;86;85 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;121;118;117;122;117;125;120;117;116 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;140;148;148;150;139;149;150;149;139 20:06:47 INFO - 2015-11-16 20:06:47,430 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;65;66;66;66;66;71;65 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,916 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: __startTimestamp1447733207427__endTimestamp 20:06:47 INFO - 2015-11-16 20:06:47,431 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,432 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:06:47 INFO - 2015-11-16 20:06:47,432 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.93 (4.5%) stddev-sans-first:5.20 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 103.0 110.0 111.0 111.0 98.0 109.0 116.0 110.0 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.50 stddev:15.36 (10.4%) stddev-sans-first:15.93 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 146.0 160.0 127.0 145.0 149.0 124.0 162.0 124.0 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.51 (0.9%) stddev-sans-first:1.58 20:06:47 INFO - 2015-11-16 20:06:47,433 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 160.0 161.0 160.0 161.0 165.0 160.0 161.0 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.00 stddev:11.30 (15.7%) stddev-sans-first:11.56 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 83.0 92.0 72.0 71.0 72.0 100.0 92.0 72.0 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:91.00 stddev:24.38 (26.8%) stddev-sans-first:25.25 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 146.0 91.0 91.0 90.0 144.0 92.0 91.0 133.0 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:06:47 INFO - 2015-11-16 20:06:47,434 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 20:06:47 INFO - 2015-11-16 20:06:47,435 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,435 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 20:06:47 INFO - 2015-11-16 20:06:47,435 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 146.0 144.0 20:06:47 INFO - 2015-11-16 20:06:47,435 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,435 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:2.63 (4.5%) stddev-sans-first:2.78 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 57.0 57.0 58.0 58.0 59.0 65.0 55.0 57.0 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,436 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 70.0 69.0 69.0 69.0 68.0 70.0 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:2.03 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: Values: 84.0 91.0 85.0 84.0 85.0 86.0 86.0 85.0 86.0 85.0 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:119.00 stddev:2.85 (2.4%) stddev-sans-first:2.99 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: Values: 118.0 121.0 118.0 117.0 122.0 117.0 125.0 120.0 117.0 116.0 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,437 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:148.50 stddev:4.85 (3.3%) stddev-sans-first:4.89 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 148.0 148.0 150.0 139.0 149.0 150.0 149.0 139.0 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.81 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 65.0 66.0 66.0 66.0 66.0 71.0 65.0 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:06:47 INFO - 2015-11-16 20:06:47,438 DEBUG : BROWSER_OUTPUT: 20:06:48 INFO - 2015-11-16 20:06:48,250 INFO : Browser exited with error code: 0 20:06:48 INFO - 2015-11-16 20:06:48,297 INFO : Completed test kraken (00:00:58) 20:06:48 INFO - 2015-11-16 20:06:48,297 INFO : Starting test v8_7 20:06:48 INFO - 2015-11-16 20:06:48,297 DEBUG : operating with platform_type : linux_ 20:06:48 INFO - 2015-11-16 20:06:48,297 INFO : Initialising browser for v8_7 test... 20:06:48 INFO - 2015-11-16 20:06:48,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpID3HXG/profile http://localhost:47700/getInfo.html 20:06:52 INFO - 2015-11-16 20:06:52,180 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:06:52 INFO - 2015-11-16 20:06:52,180 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:06:52 INFO - 2015-11-16 20:06:52,180 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:06:52 INFO - 2015-11-16 20:06:52,181 DEBUG : BROWSER_OUTPUT: __metrics 20:06:52 INFO - 2015-11-16 20:06:52,329 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:53 INFO - 2015-11-16 20:06:53,472 INFO : Browser initialized. 20:06:53 INFO - 2015-11-16 20:06:53,473 INFO : Running cycle 1/1 for v8_7 test... 20:06:53 INFO - 2015-11-16 20:06:53,473 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpID3HXG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:07:05 INFO - 2015-11-16 20:07:05,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 141131776 20:07:05 INFO - 2015-11-16 20:07:05,276 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47700/tests/v8_7/run.html (next: http://localhost:47700/tests/v8_7/run.html) 20:07:26 INFO - 2015-11-16 20:07:26,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 609968128 20:07:26 INFO - 2015-11-16 20:07:26,945 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3986928104575 20:07:26 INFO - 2015-11-16 20:07:26,946 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.05019305019306 20:07:26 INFO - 2015-11-16 20:07:26,947 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4950213371266 20:07:26 INFO - 2015-11-16 20:07:26,947 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 20:07:26 INFO - 2015-11-16 20:07:26,947 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1955.078125 20:07:26 INFO - 2015-11-16 20:07:26,947 DEBUG : BROWSER_OUTPUT: |5;Earley;803.8585209003215 20:07:26 INFO - 2015-11-16 20:07:26,947 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: |8;Splay;634.1154090044388 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: __startTimestamp1447733246943__endTimestamp 20:07:26 INFO - 2015-11-16 20:07:26,948 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.40 Median:163.40 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: Values: 163.4 20:07:26 INFO - 2015-11-16 20:07:26,949 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.05 Median:193.05 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: Values: 193.1 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.50 Median:284.50 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: Values: 284.5 20:07:26 INFO - 2015-11-16 20:07:26,950 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: Values: 5035.2 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1955.08 Median:1955.08 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: Values: 1955.1 20:07:26 INFO - 2015-11-16 20:07:26,951 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: Values: 803.9 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: Values: 12072.3 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,952 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: Values: 25500.0 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.12 Median:634.12 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: Values: 634.1 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:07:26 INFO - 2015-11-16 20:07:26,953 DEBUG : BROWSER_OUTPUT: Values: 4830.9 20:07:26 INFO - 2015-11-16 20:07:26,954 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:07:26 INFO - 2015-11-16 20:07:26,954 DEBUG : BROWSER_OUTPUT: 20:07:27 INFO - 2015-11-16 20:07:27,765 INFO : Browser exited with error code: 0 20:07:27 INFO - 2015-11-16 20:07:27,784 INFO : Completed test v8_7 (00:00:39) 20:07:27 INFO - 2015-11-16 20:07:27,937 INFO : Completed test suite (00:20:11) 20:07:27 INFO - 2015-11-16 20:07:27,937 DEBUG : Working with test: dromaeo_css 20:07:27 INFO - 2015-11-16 20:07:27,937 DEBUG : Generating results file: dromaeo_css 20:07:27 INFO - 2015-11-16 20:07:27,938 DEBUG : Working with test: kraken 20:07:27 INFO - 2015-11-16 20:07:27,939 DEBUG : Generating results file: kraken 20:07:27 INFO - 2015-11-16 20:07:27,939 INFO : javascript benchmark 20:07:27 INFO - 2015-11-16 20:07:27,939 DEBUG : Working with test: v8_7 20:07:27 INFO - 2015-11-16 20:07:27,939 DEBUG : Generating results file: v8_7 20:07:27 INFO - 2015-11-16 20:07:27,940 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:28 INFO - 2015-11-16 20:07:28,001 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:07:28 INFO - 2015-11-16 20:07:28,001 DEBUG : process_Request line: dromaeo_css 6707.21 graph.html#tests=[[72,64,35]] 20:07:28 INFO - 2015-11-16 20:07:28,001 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:28 INFO - 2015-11-16 20:07:28,030 DEBUG : process_Request line: kraken 1489.90 graph.html#tests=[[232,64,35]] 20:07:28 INFO - 2015-11-16 20:07:28,030 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:07:28 INFO - 2015-11-16 20:07:28,067 DEBUG : process_Request line: v8_7 19804.59 graph.html#tests=[[230,64,35]] 20:07:28 INFO - 2015-11-16 20:07:28,068 INFO : javascript benchmark 20:07:28 INFO - 2015-11-16 20:07:28,072 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [345.25597337737184, 346.5858299332298, 347.3487211478478, 348.30339321357286, 348.362496631165, 14425.0, 14657.486987955397, 17754.0, 18537.721934170982, 19736.407907762754, 12084.2145260558, 12478.688032799184, 17678.292868285287, 17954.64090718185, 17982.730259046126, 4432.202203603342, 4561.1789877821975, 4561.543845615445, 4566.1780879441685, 4572.177008138534, 3507.5089487471773, 3574.696150827183, 4506.4817545982305, 4894.265860120975, 5048.6465947383695, 4944.579710724593, 4986.152354099811, 4986.800527978877, 4986.950130498685, 5007.84976450707, 4846.39420072491, 4936.308916751657, 4947.455779864212, 4948.356713627206, 4955.256711493269, 4275.508316543606, 4280.5291417944, 4292.29177185764, 4296.419983302246, 4296.699231053827, 13847.930760346133, 13960.0, 14197.148171109766, 14204.431822727078, 14208.92895535526, 1956.8211316866295, 1987.2547794577033, 2003.9499012524657, 2112.5563631637374, 2140.090461553849, 9894.802103957953, 9992.0, 10006.0, 10199.18406527476, 10285.125764310043, 1662.0609355714105, 1706.13840010795, 1706.4880535839322, 1721.1308289313943, 1725.215027162638, 58795.41204587942, 59856.0, 61311.38688613101, 61475.0, 63012.219266844135, 6891.862162756717, 6898.413634841095, 7156.60638664868, 7168.677409516585, 7233.31283528064, 8599.0, 8610.78473038179, 8611.268042216356, 8617.09520500351, 8629.913700863037, 5708.20085188074, 5759.625624334405, 5792.102224155263, 5792.594518383673, 5847.093700476348, 5969.194158788508, 5999.910001349983, 6034.24571928509, 6049.0, 6072.605280656743, 3336.9666303336658, 3382.3573521030926, 3393.830308484566, 3402.3705614461405, 3406.744494162948, 1141.2524796258465, 1175.61204802415, 1178.1693905796392, 1201.2401831317163, 1230.2126638951079, 464.1969392950215, 485.6988667026466, 498.8827625508003, 500.2346409992717, 506.2962482149741, 10696.0, 12067.275963442222, 12166.209196402206, 12374.81437778434, 12400.875991239973, 499.43563772937074, 507.18596652373145, 510.45891355163644, 520.232656831171, 538.727942389091, 6387.648679322589, 6397.648129352837, 6520.315366886503, 6794.76218332356, 6843.486738494633, 510630.4468477634, 537903.0, 538784.4276351006, 539570.5107372268, 558550.0, 74948.0, 76469.23530764622, 77517.61241193871, 78070.60964695254, 78974.21025789669, 553.7950958145512, 568.0541897740299, 572.6964708704394, 572.7880684146892, 574.3280361976498, 10740.30188037775, 11299.661010169708, 11317.830232546354, 11346.94326528362, 11437.485313161094, 32032.35935281328, 33048.50427243545, 33080.50379244265, 33378.16554586155, 33419.66580334165, 40344.94825776157, 41414.58585414228, 42077.36883946804, 42446.1510769789, 42654.78672606617, 6646.2356828965285, 6845.897311540231, 6856.5200435969, 6883.0, 6885.414739747178, 12169.148159629096, 12308.876911230773, 12313.815292770794, 12658.936705316415, 12753.808692869428, 10531.526081326205, 10886.67339979802, 11196.272242304223, 11198.776024479628, 11237.831432528683, 10547.630832920811, 10711.785764284827, 10738.0, 10770.192235582206, 11018.50416731265, 9223.677171298972, 9545.188658964065, 9568.90431095708, 10230.28388012832, 10546.156307495536, 6463.192100987377, 6526.086347911201, 6744.595324280559, 6770.356816102462, 6866.073080134118, 10728.141748659933, 10799.437591615866, 10993.61522346714, 11261.549538018387, 11341.603043893425], "dojo.html": [3123.344097739475, 3204.375146846363, 3239.708426241638, 3242.902712918612, 3267.656896025918, 5147.459516750743, 5256.132738098218, 5314.335708036496, 5341.439148889364, 5354.089804733195, 5298.390685071218, 5334.226537152111, 5361.249425080492, 5382.59630527711, 5383.596230282735, 4784.6650734448685, 4852.636052296074, 4880.658353915227, 4885.267209918505, 4944.604431645478, 4962.0820148272505, 5049.722265275408, 5051.267566202899, 5074.695518268897, 5114.872128196787, 4711.7879695413785, 4803.135435621587, 4986.775595098229, 5001.599872010249, 5054.646174767768, 4889.633277504201, 4899.020195960822, 4900.0, 4912.066707325596, 4918.286848406961, 4754.738489383082, 4906.55840974314, 4914.189158788796, 4921.8523444296725, 4922.75386230687, 5222.712750798704, 5227.294315267428, 5239.816606418757, 5243.973780131075, 5261.237120617528, 5796.275465566804, 5797.971010144923, 5805.564582656318, 5805.622634528742, 5808.273965754281, 5665.1502274658715, 5819.098039803837, 5831.416858314177, 5836.270466191726, 5836.533077353844, 5374.785008599691, 5444.50999410055, 5444.945550544523, 5448.482394172547, 5495.642783219078, 5871.3541510433815, 5874.236349274567, 5893.911591326134, 5918.141869428909, 5930.7924222652, 5528.75120619573, 5551.805686800943, 5710.371859095496, 5724.771009159587, 5729.828105156852, 5844.8538786529825, 5850.912236316459, 5858.794942177004, 5885.440883116097, 5894.646321220741, 5801.82594522165, 5815.505682016991, 5823.79616713413, 5830.883382332329, 5837.0, 5641.9435805641415, 5651.237082993825, 5769.336526299529, 5782.421757824184, 5814.738336774855, 4484.506704262529, 4485.215087359699, 4486.147631949919, 4505.594496495266, 4527.61515271199, 4006.8397264109108, 4032.4354590357375, 4037.253108174997, 4060.837566497366, 4061.248668996245, 5177.7152256625495, 5296.152615581488, 5319.601029922771, 5430.538404235605, 5443.047466693313, 5742.196092547047, 5748.109043098327, 5758.62568933018, 5763.711814409263, 5820.185174075633, 5389.083855744533, 5391.191321301836, 5399.7030163340605, 5400.594955378362, 5401.351837779492, 4921.212605983025, 4959.280904268933, 5016.44819069902, 5060.367454068241, 5063.468335824686, 5927.170196172626, 5939.940600594025, 5940.495057920125, 5943.673097979653, 6008.03871380577, 5717.17101020358, 5719.48524632785, 5734.856628584319, 5736.942630573808, 5751.511121554715, 5764.308283005898, 5903.793367232126, 5916.378780228014, 5916.911246331222, 5933.376995415592, 5757.8560535986935, 5774.971125144348, 5784.045632470596, 5786.363500015079, 5787.536997040311, 5846.444587764156, 5848.736806843787, 5870.853228669317, 5871.970640146772, 5874.94125058744, 5374.355077390738, 5478.808241711521, 5481.698506582016, 5559.0, 5673.177389278614, 5706.80026199081, 5710.2862142232225, 5712.171735098304, 5716.456936591017, 5722.62802917809, 5571.721413929368, 5621.409751975983, 5624.0, 5628.943710563006, 5634.464725851038, 5415.404305526467, 5475.5072043516275, 5570.916436253378, 5585.3297604287745, 5699.658020518782, 5565.944340556543, 5566.443355664401, 5582.358028826737, 5582.944170558242, 5584.078627026658], "mootools.html": [1277.0422183362477, 1691.687037897989, 1726.805409991515, 1758.3230456274339, 1772.7163653815385, 6833.384995350418, 7543.132539757929, 7629.6948122075055, 7629.809254768634, 7657.961710191441, 7532.359749421305, 7657.27255910689, 7659.808504787383, 7660.578668173248, 7665.501742386741, 1972.4082775167465, 2021.29254760834, 2025.574629327843, 2209.4586826227596, 2240.395093324801, 2028.381343690174, 2191.835612329082, 2253.7070180876462, 2255.729312482496, 2260.5704916065893, 2149.967750483744, 2178.1396348442354, 2178.3900507857825, 2207.75714671386, 2213.5462230242842, 1848.8428483578912, 1875.6154988227381, 2201.350601572532, 2226.231949977255, 2231.3194475684827, 2208.8122509586706, 2257.3002369265582, 2258.299927022612, 2259.49161438675, 2259.9774002260096, 7496.400287976949, 7627.122880868716, 7632.198619144965, 7639.388848892076, 7655.885161722578, 4607.539246075399, 4668.813247470097, 4675.766211689402, 4709.0, 4711.905761884777, 2901.608282881805, 2987.327851233477, 2994.5657879607334, 2995.925101872449, 3009.217603423104, 959.7024922274118, 982.3516479123743, 989.4459102902398, 1016.0296916444778, 1050.76883085721, 10051.39691618498, 10053.849192262122, 10069.647562335356, 10076.546555405024, 10169.898301017043, 4102.774347410861, 4145.54399016108, 4216.388623649554, 4225.5985681360835, 4255.1915136124035, 8694.478331300143, 8705.912940870638, 8706.0, 8707.695230666895, 8725.563721813884, 4631.490536041033, 4644.883877903079, 4645.3032045193495, 4647.047355292157, 4652.813887444464, 4172.123853990696, 4191.476065491814, 4203.07532342884, 4204.600562946515, 4217.7891105444605, 3611.422172452395, 3637.7635453695425, 3644.4351125575577, 3658.689011434005, 3684.3184010958057, 1167.3696204049718, 1177.0877569883237, 1185.8814118588073, 1186.8635106962638, 1190.6844686158174, 1275.3304515129446, 1341.7249463859885, 1342.939567719455, 1373.5535950815824, 1375.3054707372912, 7358.96320518394, 7376.815579610553, 7385.150707668687, 7402.9629851850395, 7403.925960740431, 1195.6413076077315, 1201.6995751062234, 1217.4704003758393, 1228.8648248692637, 1263.7977923532192, 5468.945310546844, 5484.8354549363585, 5668.319801623831, 6044.607100538451, 6171.197744293213, 8453.535055572003, 8927.24118449939, 9021.819563608691, 9065.365424420228, 9096.8635470468, 8434.0, 8480.660773569112, 8482.109378515168, 8495.065542790288, 8496.787580310542, 7193.5324203926575, 7282.4902256841515, 7312.744053958086, 7350.705971761176, 7355.338019578264, 7012.088428504262, 7083.079199704005, 7105.893411598933, 7106.218315985134, 7118.0, 7687.423443241891, 7782.727604533814, 7949.483283586548, 8072.636731346986, 8130.227628375294, 8006.399520036137, 8237.299829514559, 8330.166983301622, 8335.24982751531, 8351.624176911931, 6727.125473688389, 6736.4947628929, 6779.559328643622, 6802.795916122524, 6827.21487028998, 7225.205227425085, 7296.087989001375, 7297.197308295977, 7300.780976570712, 7308.269173082649, 6536.182977127859, 6695.832604184934, 6848.212455567674, 6964.373206411447, 7013.0, 6669.266380698023, 6678.799636010927, 6735.057092007025, 6891.035255064396, 6913.446924246149, 6806.387425131762, 6846.281140480377, 6853.109095817512, 6861.485388595976, 6862.142232220973, 6335.873282534231, 6382.138411314599, 6431.517636177212, 6442.162518872517, 6446.323136070645, 6489.059086432535, 6547.247066587403, 6552.312007239362, 6552.705128269335, 6565.638889861103], "ext.html": [575.9452851979062, 578.6296770067156, 580.4195804195804, 580.7676929228305, 582.9245042895856, 31976.0, 33308.83345583272, 41009.58990410095, 41039.0, 41113.794431027876, 44463.110737785304, 45225.77387113068, 45287.32069018959, 45293.77353113238, 45308.0, 7682.807929801744, 8802.95598522008, 8915.153060459246, 8975.95512022439, 8977.640894364251, 7744.070711514626, 10695.518701658406, 10894.618688345909, 10981.12151027916, 10984.121270298398, 10611.893881061207, 10691.679249622524, 10735.892641073606, 10738.73153171173, 10751.462426878665, 7663.846723065508, 7777.572233527154, 10577.259591828575, 10697.411642359628, 10740.838887416696, 10396.220283478693, 10536.420496872668, 10536.473176341153, 10536.578536858517, 10539.0, 40376.0, 40384.79807600973, 40523.7973810132, 40830.183396332206, 41061.794691026356, 3372.5109859070544, 3390.677885600864, 3393.7624366294367, 3406.5230867678547, 3419.743519236042, 30874.228144296347, 31135.688643113506, 31261.374772504423, 31330.0, 31403.84298078518, 3352.5186320366133, 3492.7904325740537, 3525.1539630488755, 3532.8160458225543, 3639.3813051781262, 278921.0, 279725.0, 279807.99999999796, 280300.0, 280669.0, 53442.0, 54857.177142342895, 63258.683706582095, 63680.0, 68640.31359686439, 63942.0, 64001.71996560136, 64317.35682643114, 64319.0, 64345.0, 16046.117463539384, 16106.597335066717, 16240.918795405947, 16246.212916579167, 16256.837431625769, 11932.522699092113, 12011.519539218509, 12105.273683579013, 12121.696957575954, 12132.939335303443, 20533.486662833548, 20849.89575052115, 21005.579888402146, 21028.579428411347, 21060.89469552673, 7783.610819459004, 8069.305445856436, 8090.514569125754, 8135.210253744167, 8163.346932245406, 907.5734404829719, 913.6710784117712, 1003.82934901067, 1004.5178314409125, 1113.560143743233, 28583.0, 28875.0, 29073.0, 29154.708452915624, 29401.264968375963, 994.8310734886624, 1029.2692188546066, 1051.3849398102043, 1105.9336439813476, 1146.1690274550883, 14923.552293431214, 15465.381384744709, 15672.921635391978, 15938.920305398631, 16179.514614561582, 331372.0, 332615.0, 334911.0, 335355.0, 335879.0, 48656.513434865905, 48702.26946595804, 48859.0, 49089.263661045115, 49128.26307605389, 1354.8441929178073, 1363.9454421823214, 1364.2292104960666, 1365.6312795545148, 1373.7527245095978, 26780.59829102604, 27728.168154955383, 28501.0, 29166.708332916398, 29380.85309573524, 44250.55749442464, 45137.548624513336, 47285.52714472811, 50906.745466272434, 51727.74136129295, 221115.0, 222521.0, 223533.0, 223869.0, 224476.0, 28642.560403137548, 30017.849910750305, 30398.0, 30446.695533044385, 30518.0, 33428.665713342554, 37832.62167378291, 41670.0, 42003.36994945017, 42772.57227427811, 37506.6249337514, 38509.4223586652, 39304.606953930095, 39439.80280098581, 40031.59968400279, 38128.61871381251, 38586.421203681406, 38813.41779873361, 39064.0, 39216.21567568689, 36036.81981590075, 36315.45526817047, 36343.0, 37849.0, 38124.42813357857, 31917.68082319147, 33760.66239337673, 33913.3217335647, 34079.48880766741, 34194.14514637154, 25229.747702522738, 25240.242792716246, 25346.74653253444, 25371.238862834143, 25524.9790008405], "prototype.html": [317.8379026696385, 320.5768385730835, 322.93854261600046, 326.4597091813049, 330.2042078590596, 5950.166976623276, 6069.878602427949, 6082.939170608298, 6120.602160859541, 6126.479249263813, 5872.207252020976, 5994.790182343619, 6005.789797357093, 6033.849153771158, 6045.939540604592, 4616.653750968674, 4643.2802915548145, 4648.395708557883, 4654.2785868190485, 4660.370849935266, 4449.5995360417555, 4548.340490628873, 4556.088782243548, 4566.885827854314, 4646.4191976003, 4458.086092351076, 4519.932201016987, 4539.773011349419, 4539.773011349436, 4556.954430455686, 4538.205813982539, 4541.43232095988, 4552.339910712928, 4552.749598772066, 4574.0, 3971.8808435746687, 3973.145773658677, 3974.205158968218, 3976.483057202574, 3977.7016723745833, 5598.24423702799, 5698.51562617178, 5703.5152012079025, 5725.912076705413, 5760.855978600526, 5299.814506492293, 5301.787928482856, 5304.416514183436, 5305.840824775263, 5312.362516498007, 6112.083187521863, 6464.385883341122, 6469.644169570672, 6470.158879345702, 6471.805845824586, 4240.830366785325, 4273.209456250604, 4334.068175342285, 4343.435353404037, 4350.6736994725525, 6552.9344706553275, 6637.93362066378, 6652.401283884474, 6652.501062420338, 6658.533902626818, 4392.890177745582, 4393.890152746143, 4395.626371758436, 4398.318260669537, 4404.0, 4362.607365337135, 4448.510663826976, 4451.243288640939, 4494.820207191741, 4516.977415112903, 5271.288376069181, 5284.207368894697, 5286.3392075990505, 5289.6032797539565, 5292.973535132377, 6485.3514648534765, 6492.480601551864, 6494.0, 6496.967515162394, 6499.480041596661, 1582.8654564362157, 1595.9840401595836, 1596.1779683463026, 1597.2013993003497, 1597.5846279967293, 1042.8852826189113, 1046.0899017854363, 1050.2858056521486, 1051.2693677893944, 1076.7523469602036, 6135.938640613626, 6139.26328840542, 6143.354947730513, 6144.600600960924, 6150.261968563801, 6613.603183808987, 6636.336366363422, 6640.734370625218, 6652.368025037614, 6653.933460665428, 6041.848953776191, 6177.413145751147, 6182.969085154636, 6186.81439556814, 6190.350013248634, 3584.713222942158, 3601.8019008954757, 3604.6034936157002, 3605.0, 3608.530890984155, 6922.896156557656, 6925.75759848413, 6925.930740692528, 6931.618760968095, 6940.340667636567, 6643.900341494881, 6820.931790682129, 6821.1814582250445, 6831.248562658104, 6832.385085342343, 6886.139232595926, 6891.483138764513, 6899.48253880961, 6912.101426814583, 6917.0, 6433.806985790434, 6612.437942774725, 6613.603183808795, 6620.933790662224, 6624.635645039569, 6493.090967264681, 6541.542092053701, 6630.602163870183, 6655.134832471747, 6655.866882662416, 6882.449404047564, 6892.965535172292, 6894.517383783087, 6897.0, 7000.334968178015, 4355.324924636687, 4416.034864485273, 4424.911501769882, 4427.867163985085, 4494.303382975644, 6669.733210671713, 6678.131842860591, 6678.432333251728, 6686.197656281277, 6692.732290708317, 6468.223813142453, 6514.283428822731, 6518.185226846645, 6519.348065193442, 6521.543491955707, 6286.874262514815, 6487.286398496256, 6501.51238657112, 6504.772332968512, 6529.8694026120165, 6392.264889537577, 6393.456556192776, 6396.200474940632, 6398.936010639834, 6402.679866006774, 6497.545171837926, 6522.249941256627, 6532.902006469812, 6538.574992625464, 6548.116004339544, 6196.752129914933, 6346.048092786119, 6346.524010699124, 6348.71430785625, 6362.077498762561], "yui.html": [719.3525826755919, 734.2217249715302, 743.3829921165429, 769.8160497695031, 804.4811096842536, 14225.715485690293, 14447.133172009686, 14550.19973901435, 14583.197924114156, 14614.123152610837, 14543.490977815778, 14989.550313490585, 15051.849481505182, 15057.924710376432, 15088.54734357971, 681.8261343357437, 689.1144878830704, 825.7646570727329, 840.0129847429276, 840.920112589303, 809.1423091522975, 825.3603457320564, 832.8209434971479, 832.9333653307751, 833.3374966901298, 857.9871301930476, 865.2774932930979, 868.7567481105269, 870.0429527519709, 871.2768402226137, 695.6904177640952, 702.8769965256085, 842.4860834890711, 842.5408152556871, 856.4732689396039, 627.2598333965918, 627.5952010952956, 628.5286035473395, 628.6416742456802, 628.8836565235446, 13274.070815042951, 13334.133281336683, 13347.265900375476, 13369.264690442022, 13500.932495337558, 10240.0, 10390.48047597617, 10671.626493072705, 10768.569257229701, 10911.454427278604, 9860.211183105333, 10086.193104551618, 10124.29129960903, 10227.693169204937, 10423.791524169474, 3328.866845326184, 3341.816200108993, 3342.398368293706, 3375.7805742626897, 3386.373520898642, 47712.5228747715, 47935.0, 48184.518154818354, 48253.51746482525, 48398.0, 6966.12923384577, 7356.558606483628, 7367.300106489874, 7503.699852005859, 7653.387728981668, 11590.942045289888, 11617.477213525412, 11620.128490363088, 11626.1861669684, 11641.126915481373, 6439.5170362223025, 6680.532362734659, 6810.148731408574, 6925.134358205224, 6979.8604027919155, 4099.672026237894, 4263.957360426356, 4265.4241677373775, 4316.482022157361, 4380.255356589388, 2796.7902407319534, 2817.3097591089904, 2819.6898341182455, 2820.901268455594, 2822.534281843514, 406.42693801739404, 418.24089277960405, 422.6618705035959, 424.27025516112235, 434.7782630858222, 545.7598656591088, 570.8829689913558, 630.2751835389247, 692.2661978303015, 734.9669264883094, 8347.749567512985, 8482.872756908651, 8546.957265213634, 8651.307895368356, 9333.813323733488, 715.2418436457372, 717.8026042838261, 718.8110369716735, 732.1068296678044, 735.4557627355719, 4004.619561141687, 4207.221663992172, 4256.61690447855, 4288.1638080573985, 4341.088371442032, 59099.704501478074, 60134.09798853021, 60352.698236509415, 60450.0, 60616.0, 53312.73343633257, 53734.00033814409, 54155.72922135364, 54321.72839135779, 54502.182467263025, 47867.0, 48262.27606585904, 48543.27185092226, 48762.75618621955, 49078.0, 8209.917900820916, 8363.247307742333, 8439.873401898854, 8447.239748422671, 8562.272206862486, 36613.450798238584, 36903.63096369002, 37039.44440833336, 37052.0, 38679.0, 43388.0, 43596.34605480857, 44803.551964479935, 45066.77466612646, 46422.53577464317, 8147.714829980922, 8406.28546573548, 8483.363747718822, 8649.264812491008, 8656.540774501173, 12172.147949643795, 12262.141650084408, 12452.750944980868, 12538.435770390171, 12575.371231438208, 11473.254238474472, 11720.238184517979, 11892.821607676065, 12037.819432708691, 12349.135560510678, 10627.09669678086, 10789.352638841694, 11070.723231919266, 11290.966428485797, 11298.548058077586, 10709.303895246783, 11000.284981476178, 11168.441577921234, 11213.71965700864, 11891.67622562445, 9598.0, 9786.41281523111, 9882.654107106217, 9916.900830991597, 10038.092762375125, 9264.0, 9342.53287335617, 9399.765005874908, 9764.0, 9779.804403912025]}, "summary": {"lowerIsBetter": false, "suite": 6707.2126870444745, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6995.131469529303, "unit": "ms", "value": 6995.131469529303}, "dojo.html": {"lowerIsBetter": false, "filtered": 5324.097674981799, "unit": "ms", "value": 5324.097674981799}, "mootools.html": {"lowerIsBetter": false, "filtered": 4417.518089064676, "unit": "ms", "value": 4417.518089064676}, "ext.html": {"lowerIsBetter": false, "filtered": 18915.21218913023, "unit": "ms", "value": 18915.21218913023}, "prototype.html": {"lowerIsBetter": false, "filtered": 4812.666390278185, "unit": "ms", "value": 4812.666390278185}, "yui.html": {"lowerIsBetter": false, "filtered": 6078.510307822256, "unit": "ms", "value": 6078.510307822256}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447732036, "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": "20151116173018", "branch": "Fx-Team", "revision": "31c31342f1ea35b6396e99def49076df4f4fd201"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 160.0, 161.0, 160.0, 161.0, 165.0, 160.0, 161.0], "ai-astar": [107.0, 110.0, 103.0, 110.0, 111.0, 111.0, 98.0, 109.0, 116.0, 110.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "audio-beat-detection": [150.0, 122.0, 146.0, 160.0, 127.0, 145.0, 149.0, 124.0, 162.0, 124.0], "json-stringify-tinderbox": [68.0, 68.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 70.0], "stanford-crypto-pbkdf2": [141.0, 140.0, 148.0, 148.0, 150.0, 139.0, 149.0, 150.0, 149.0, 139.0], "json-parse-financial": [58.0, 59.0, 57.0, 57.0, 58.0, 58.0, 59.0, 65.0, 55.0, 57.0], "stanford-crypto-sha256-iterative": [66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 71.0, 65.0], "audio-fft": [71.0, 70.0, 83.0, 92.0, 72.0, 71.0, 72.0, 100.0, 92.0, 72.0], "imaging-darkroom": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 144.0], "stanford-crypto-ccm": [118.0, 121.0, 118.0, 117.0, 122.0, 117.0, 125.0, 120.0, 117.0, 116.0], "audio-oscillator": [91.0, 91.0, 146.0, 91.0, 91.0, 90.0, 144.0, 92.0, 91.0, 133.0], "stanford-crypto-aes": [84.0, 91.0, 85.0, 84.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0], "imaging-desaturate": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.8999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.5, "unit": "ms", "value": 79.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 140.9, "unit": "ms", "value": 140.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 119.1, "unit": "ms", "value": 119.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.3, "unit": "ms", "value": 58.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 106.0, "unit": "ms", "value": 106.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.5, "unit": "ms", "value": 108.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.4, "unit": "ms", "value": 161.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.5, "unit": "ms", "value": 66.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.8, "unit": "ms", "value": 68.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.1, "unit": "ms", "value": 109.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447732036, "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": "20151116173018", "branch": "Fx-Team", "revision": "31c31342f1ea35b6396e99def49076df4f4fd201"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.05019305019306], "Encrypt": [284.4950213371266], "NavierStokes": [4830.917874396136], "Decrypt": [5035.175879396985], "Splay": [634.1154090044388], "Richards": [163.3986928104575], "RegExp": [25500.0], "Earley": [803.8585209003215], "Boyer": [12072.289156626506], "RayTrace": [1955.078125]}, "summary": {"lowerIsBetter": false, "suite": 19804.59312142859, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 342.49123999999995, "unit": "score", "value": 342.49123999999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 935.6262149999995, "unit": "score", "value": 935.6262149999995}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.864290419161705, "unit": "score", "value": 52.864290419161705}, "Splay": {"lowerIsBetter": false, "filtered": 128.51130700000002, "unit": "score", "value": 128.51130700000002}, "RegExp": {"lowerIsBetter": false, "filtered": 35.72490196078431, "unit": "score", "value": 35.72490196078431}, "Richards": {"lowerIsBetter": false, "filtered": 216.04823999999994, "unit": "score", "value": 216.04823999999994}, "Earley": {"lowerIsBetter": false, "filtered": 829.0799720000001, "unit": "score", "value": 829.0799720000001}, "Boyer": {"lowerIsBetter": false, "filtered": 55.20601696606782, "unit": "score", "value": 55.20601696606782}, "RayTrace": {"lowerIsBetter": false, "filtered": 378.49587212787225, "unit": "score", "value": 378.49587212787225}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-045"}, "testrun": {"date": 1447732036, "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": "20151116173018", "branch": "Fx-Team", "revision": "31c31342f1ea35b6396e99def49076df4f4fd201"}}] 20:07:28 INFO - RETURN: dromaeo_css: 6707.21 20:07:28 INFO - RETURN: kraken: 1489.90 20:07:28 INFO - RETURN: v8_7: 19804.59 20:07:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19804.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1489.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6707.21"}}} 20:07:28 INFO - Return code: 0 20:07:28 INFO - # TBPL SUCCESS # 20:07:28 INFO - Running post-action listener: _resource_record_post_action 20:07:28 INFO - Running post-run listener: _resource_record_post_run 20:07:29 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510111744; Read time: 12; Write time: 457640 20:07:29 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 172150784; Read time: 0; Write time: 262940 20:07:29 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 333320192; Read time: 0; Write time: 194376 20:07:29 INFO - Running post-run listener: _upload_blobber_files 20:07:29 INFO - Blob upload gear active. 20:07:29 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:07:29 INFO - Copying logs to upload dir... 20:07:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.973128 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2015-11-16 20:07:29.198941) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:29.202439) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009955 build_url: 'https://queue.taskcluster.net/v1/task/j-LCU8AISaKQoc3M4uqr3g/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-16 20:07:29.254403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:29.254821) ========= 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=61fa6ed41387771909ec0f71000001b3-1447729918.86642-834121564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 20:07:29.305081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:07:29.305430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 20:07:29.305778) ========= ========= Total master_lag: 0.26 =========