builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1447901403.22 results: success (0) buildid: 20151118173022 builduid: a330963ad7bf4bfb8b693490300a4d9e revision: 42a976b770f1b1e54133ee0383940013ded058eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.224941) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.225392) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.225769) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006731 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.252684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.252966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.271879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.272164) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.321036) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.321345) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.321751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.322025) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 18:50:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.1M=0s 2015-11-18 18:50:03 (55.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.518952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.519278) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016827 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.569605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:03.569971) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42a976b770f1b1e54133ee0383940013ded058eb --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 42a976b770f1b1e54133ee0383940013ded058eb --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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 18:50:04,106 truncating revision to first 12 chars 2015-11-18 18:50:04,106 Setting DEBUG logging. 2015-11-18 18:50:04,106 attempt 1/10 2015-11-18 18:50:04,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42a976b770f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 18:50:04,389 unpacking tar archive at: fx-team-42a976b770f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:04.167761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:04.168086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:04.177854) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:04.178155) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 18:50:04.178558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-18 18:50:04.178834) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:50:04 INFO - MultiFileLogger online at 20151118 18:50:04 in /builds/slave/test-pgo 18:50:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:50:04 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:50:04 INFO - {'append_to_log': False, 18:50:04 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:50:04 INFO - 'blob_upload_branch': 'Fx-Team', 18:50:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:50:04 INFO - 'branch': 'Fx-Team', 18:50:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:04 INFO - 'config_files': ('talos/linux_config.py',), 18:50:04 INFO - 'default_actions': ('clobber', 18:50:04 INFO - 'read-buildbot-config', 18:50:04 INFO - 'download-and-extract', 18:50:04 INFO - 'populate-webroot', 18:50:04 INFO - 'create-virtualenv', 18:50:04 INFO - 'install', 18:50:04 INFO - 'run-tests'), 18:50:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:04 INFO - 'download_minidump_stackwalk': True, 18:50:04 INFO - 'download_symbols': 'ondemand', 18:50:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:04 INFO - 'installer_path': 'installer.exe', 18:50:04 INFO - 'log_level': 'info', 18:50:04 INFO - 'log_name': 'talos', 18:50:04 INFO - 'log_to_console': True, 18:50:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:50:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:50:04 INFO - 'opt_config_files': (), 18:50:04 INFO - 'pip_index': False, 18:50:04 INFO - 'sps_profile': False, 18:50:04 INFO - 'sps_profile_interval': 0, 18:50:04 INFO - 'suite': 'dromaeojs-e10s', 18:50:04 INFO - 'system_bits': '64', 18:50:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:04 INFO - 'title': 'talos-linux64-ix-042', 18:50:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:04 INFO - 'use_talos_json': True, 18:50:04 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:50:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:04 INFO - 'work_dir': 'build'} 18:50:04 INFO - ##### 18:50:04 INFO - ##### Running clobber step. 18:50:04 INFO - ##### 18:50:04 INFO - Running pre-action listener: _resource_record_pre_action 18:50:04 INFO - Running main action method: clobber 18:50:04 INFO - rmtree: /builds/slave/test-pgo/build 18:50:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:50:05 INFO - Running post-action listener: _resource_record_post_action 18:50:05 INFO - ##### 18:50:05 INFO - ##### Running read-buildbot-config step. 18:50:05 INFO - ##### 18:50:05 INFO - Running pre-action listener: _resource_record_pre_action 18:50:05 INFO - Running main action method: read_buildbot_config 18:50:05 INFO - Using buildbot properties: 18:50:05 INFO - { 18:50:05 INFO - "properties": { 18:50:05 INFO - "buildnumber": 342, 18:50:05 INFO - "product": "firefox", 18:50:05 INFO - "script_repo_revision": "production", 18:50:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:50:05 INFO - "repository": "", 18:50:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:50:05 INFO - "buildid": "20151118173022", 18:50:05 INFO - "slavename": "talos-linux64-ix-042", 18:50:05 INFO - "pgo_build": "True", 18:50:05 INFO - "basedir": "/builds/slave/test-pgo", 18:50:05 INFO - "project": "", 18:50:05 INFO - "platform": "ubuntu64_hw", 18:50:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:50:05 INFO - "slavebuilddir": "test", 18:50:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:50:05 INFO - "branch": "fx-team", 18:50:05 INFO - "repo_path": "integration/fx-team", 18:50:05 INFO - "stage_platform": "linux64-pgo", 18:50:05 INFO - "builduid": "a330963ad7bf4bfb8b693490300a4d9e", 18:50:05 INFO - "revision": "42a976b770f1b1e54133ee0383940013ded058eb" 18:50:05 INFO - }, 18:50:05 INFO - "sourcestamp": { 18:50:05 INFO - "repository": "", 18:50:05 INFO - "hasPatch": false, 18:50:05 INFO - "project": "", 18:50:05 INFO - "branch": "fx-team-linux64-pgo-talos", 18:50:05 INFO - "changes": [ 18:50:05 INFO - { 18:50:05 INFO - "category": null, 18:50:05 INFO - "files": [ 18:50:05 INFO - { 18:50:05 INFO - "url": null, 18:50:05 INFO - "name": "https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:50:05 INFO - } 18:50:05 INFO - ], 18:50:05 INFO - "repository": "", 18:50:05 INFO - "rev": "42a976b770f1b1e54133ee0383940013ded058eb", 18:50:05 INFO - "who": "sendchange", 18:50:05 INFO - "when": 1447901346, 18:50:05 INFO - "number": 6680640, 18:50:05 INFO - "comments": "", 18:50:05 INFO - "project": "", 18:50:05 INFO - "at": "Wed 18 Nov 2015 18:49:06", 18:50:05 INFO - "branch": "fx-team-linux64-pgo-talos", 18:50:05 INFO - "revlink": "", 18:50:05 INFO - "properties": [ 18:50:05 INFO - [ 18:50:05 INFO - "buildid", 18:50:05 INFO - "20151118173022", 18:50:05 INFO - "Change" 18:50:05 INFO - ], 18:50:05 INFO - [ 18:50:05 INFO - "builduid", 18:50:05 INFO - "a330963ad7bf4bfb8b693490300a4d9e", 18:50:05 INFO - "Change" 18:50:05 INFO - ], 18:50:05 INFO - [ 18:50:05 INFO - "pgo_build", 18:50:05 INFO - "True", 18:50:05 INFO - "Change" 18:50:05 INFO - ] 18:50:05 INFO - ], 18:50:05 INFO - "revision": "42a976b770f1b1e54133ee0383940013ded058eb" 18:50:05 INFO - } 18:50:05 INFO - ], 18:50:05 INFO - "revision": "42a976b770f1b1e54133ee0383940013ded058eb" 18:50:05 INFO - } 18:50:05 INFO - } 18:50:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:50:05 INFO - Running post-action listener: _resource_record_post_action 18:50:05 INFO - ##### 18:50:05 INFO - ##### Running download-and-extract step. 18:50:05 INFO - ##### 18:50:05 INFO - Running pre-action listener: _resource_record_pre_action 18:50:05 INFO - Running main action method: download_and_extract 18:50:05 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:05 INFO - https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:50:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/test_packages.json 18:50:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/test_packages.json 18:50:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:50:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:50:06 INFO - Downloaded 1302 bytes. 18:50:06 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:50:06 INFO - Using the following test package requirements: 18:50:06 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:06 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:50:06 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'jsshell-linux-x86_64.zip'], 18:50:06 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:50:06 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:06 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:50:06 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:50:06 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:50:06 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:50:06 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:50:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:50:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:06 INFO - https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:50:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:07 INFO - Downloaded 22474645 bytes. 18:50:07 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 18:50:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:07 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 18:50:09 INFO - Return code: 0 18:50:09 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 18:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:09 INFO - https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:50:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:10 INFO - Downloaded 22474645 bytes. 18:50:10 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 18:50:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:50:10 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 18:50:11 INFO - Return code: 0 18:50:11 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')]} 18:50:11 INFO - https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:13 INFO - Downloaded 11130997 bytes. 18:50:13 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 18:50:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:50:13 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 18:50:13 INFO - Return code: 0 18:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:13 INFO - https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:50:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:50:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:50:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2lF4XA16R0aOTrI_Fna2_g/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 18:50:17 INFO - Downloaded 57205795 bytes. 18:50:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:50:17 INFO - mkdir: /builds/slave/test-pgo/properties 18:50:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:50:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:50:17 INFO - Contents: 18:50:17 INFO - build_url:https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:50:17 INFO - Running post-action listener: _resource_record_post_action 18:50:17 INFO - Running post-action listener: set_extra_try_arguments 18:50:17 INFO - ##### 18:50:17 INFO - ##### Running populate-webroot step. 18:50:17 INFO - ##### 18:50:17 INFO - Running pre-action listener: _resource_record_pre_action 18:50:17 INFO - Running main action method: populate_webroot 18:50:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:50:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:50:17 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:50:17 INFO - '../fennec_ids.txt'], 18:50:17 INFO - 'tests': ['tcheck2']}, 18:50:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:50:17 INFO - '--tppagecycles', 18:50:17 INFO - '7'], 18:50:17 INFO - 'tests': ['tsvgm']}}, 18:50:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:50:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:50:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:50:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:50:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:50:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'tests': ['damp', 'tps']}, 18:50:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['damp', 'tps']}, 18:50:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:50:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:50:17 INFO - 'other': {'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'other_l64': {'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'other_nol64': {'tests': ['a11yr', 18:50:17 INFO - 'ts_paint', 18:50:17 INFO - 'tpaint', 18:50:17 INFO - 'sessionrestore', 18:50:17 INFO - 'sessionrestore_no_auto_restore']}, 18:50:17 INFO - 'svgr': {'tests': ['tsvgx', 18:50:17 INFO - 'tsvgr_opacity', 18:50:17 INFO - 'tart', 18:50:17 INFO - 'tscrollx', 18:50:17 INFO - 'cart']}, 18:50:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['tsvgx', 18:50:17 INFO - 'tsvgr_opacity', 18:50:17 INFO - 'tart', 18:50:17 INFO - 'tscrollx', 18:50:17 INFO - 'cart']}, 18:50:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'tests': ['tp5o']}, 18:50:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'talos_options': ['--e10s'], 18:50:17 INFO - 'tests': ['tp5o']}, 18:50:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'talos_options': ['--xperf_path', 18:50:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:17 INFO - 'tests': ['tp5n']}, 18:50:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:50:17 INFO - 'talos_options': ['--e10s', 18:50:17 INFO - '--xperf_path', 18:50:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:50:17 INFO - 'tests': ['tp5n']}}, 18:50:17 INFO - 'talos.zip': {'path': '', 18:50:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:50:17 INFO - Running post-action listener: _resource_record_post_action 18:50:17 INFO - ##### 18:50:17 INFO - ##### Running create-virtualenv step. 18:50:17 INFO - ##### 18:50:17 INFO - Running pre-action listener: _resource_record_pre_action 18:50:17 INFO - Running main action method: create_virtualenv 18:50:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:50:17 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 18:50:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:50:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:50:17 INFO - Using real prefix '/usr' 18:50:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:50:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:20 INFO - Installing pip.................done. 18:50:20 INFO - Return code: 0 18:50:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:20 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:20 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 18:50:20 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 18:50:20 INFO - Using env: {'DISPLAY': ':0', 18:50:20 INFO - 'HOME': '/home/cltbld', 18:50:20 INFO - 'LANG': 'en_US.UTF-8', 18:50:20 INFO - 'LANGUAGE': 'en_US:en', 18:50:20 INFO - 'LOGNAME': 'cltbld', 18:50:20 INFO - 'MAIL': '/var/mail/cltbld', 18:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:20 INFO - 'MOZ_NO_REMOTE': '1', 18:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:20 INFO - 'NO_EM_RESTART': '1', 18:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:20 INFO - 'SHELL': '/bin/bash', 18:50:20 INFO - 'SHLVL': '1', 18:50:20 INFO - 'TERM': 'linux', 18:50:20 INFO - 'TMOUT': '86400', 18:50:20 INFO - 'USER': 'cltbld', 18:50:20 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:20 INFO - '_': '/tools/buildbot/bin/python'} 18:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:20 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 18:50:20 INFO - Cleaning up... 18:50:20 INFO - Return code: 0 18:50:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:20 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:20 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 18:50:20 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 18:50:20 INFO - Using env: {'DISPLAY': ':0', 18:50:20 INFO - 'HOME': '/home/cltbld', 18:50:20 INFO - 'LANG': 'en_US.UTF-8', 18:50:20 INFO - 'LANGUAGE': 'en_US:en', 18:50:20 INFO - 'LOGNAME': 'cltbld', 18:50:20 INFO - 'MAIL': '/var/mail/cltbld', 18:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:20 INFO - 'MOZ_NO_REMOTE': '1', 18:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:20 INFO - 'NO_EM_RESTART': '1', 18:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:20 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:20 INFO - 'SHELL': '/bin/bash', 18:50:20 INFO - 'SHLVL': '1', 18:50:20 INFO - 'TERM': 'linux', 18:50:20 INFO - 'TMOUT': '86400', 18:50:20 INFO - 'USER': 'cltbld', 18:50:20 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:20 INFO - '_': '/tools/buildbot/bin/python'} 18:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:20 INFO - Downloading/unpacking psutil>=0.7.1 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 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 18:50:20 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 18:50:22 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:50:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:50:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:22 INFO - Installing collected packages: psutil 18:50:22 INFO - Running setup.py install for psutil 18:50:22 INFO - building 'psutil._psutil_linux' extension 18:50:22 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 18:50:22 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 18:50:22 INFO - building 'psutil._psutil_posix' extension 18:50:22 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 18:50:22 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 18:50:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:22 INFO - Successfully installed psutil 18:50:22 INFO - Cleaning up... 18:50:22 INFO - Return code: 0 18:50:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:50:22 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')]} 18:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:22 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')]} 18:50:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:22 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:22 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 18:50:22 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 18:50:22 INFO - Using env: {'DISPLAY': ':0', 18:50:22 INFO - 'HOME': '/home/cltbld', 18:50:22 INFO - 'LANG': 'en_US.UTF-8', 18:50:22 INFO - 'LANGUAGE': 'en_US:en', 18:50:22 INFO - 'LOGNAME': 'cltbld', 18:50:22 INFO - 'MAIL': '/var/mail/cltbld', 18:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:22 INFO - 'MOZ_NO_REMOTE': '1', 18:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:22 INFO - 'NO_EM_RESTART': '1', 18:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:22 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:22 INFO - 'SHELL': '/bin/bash', 18:50:22 INFO - 'SHLVL': '1', 18:50:22 INFO - 'TERM': 'linux', 18:50:22 INFO - 'TMOUT': '86400', 18:50:22 INFO - 'USER': 'cltbld', 18:50:22 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:22 INFO - '_': '/tools/buildbot/bin/python'} 18:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:50:23 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 18:50:23 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 18:50:23 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 18:50:23 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 18:50:23 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 18:50:23 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 18:50:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:50:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:50:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:50:24 INFO - Installing collected packages: mozsystemmonitor 18:50:24 INFO - Running setup.py install for mozsystemmonitor 18:50:24 INFO - Successfully installed mozsystemmonitor 18:50:24 INFO - Cleaning up... 18:50:24 INFO - Return code: 0 18:50:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:50:24 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')]} 18:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:24 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')]} 18:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:24 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:24 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 18:50:24 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 18:50:24 INFO - Using env: {'DISPLAY': ':0', 18:50:24 INFO - 'HOME': '/home/cltbld', 18:50:24 INFO - 'LANG': 'en_US.UTF-8', 18:50:24 INFO - 'LANGUAGE': 'en_US:en', 18:50:24 INFO - 'LOGNAME': 'cltbld', 18:50:24 INFO - 'MAIL': '/var/mail/cltbld', 18:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:24 INFO - 'MOZ_NO_REMOTE': '1', 18:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:24 INFO - 'NO_EM_RESTART': '1', 18:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:24 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:24 INFO - 'SHELL': '/bin/bash', 18:50:24 INFO - 'SHLVL': '1', 18:50:24 INFO - 'TERM': 'linux', 18:50:24 INFO - 'TMOUT': '86400', 18:50:24 INFO - 'USER': 'cltbld', 18:50:24 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:24 INFO - '_': '/tools/buildbot/bin/python'} 18:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:25 INFO - Downloading/unpacking blobuploader==1.2.4 18:50:25 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 18:50:25 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 18:50:25 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 18:50:25 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 18:50:25 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 18:50:25 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 18:50:26 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:50:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:50:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:50:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:27 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 18:50:27 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 18:50:27 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 18:50:27 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 18:50:27 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 18:50:27 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 18:50:27 INFO - Downloading docopt-0.6.1.tar.gz 18:50:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:50:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:27 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:27 INFO - Running setup.py install for blobuploader 18:50:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:50:27 INFO - Running setup.py install for requests 18:50:27 INFO - Running setup.py install for docopt 18:50:28 INFO - Successfully installed blobuploader requests docopt 18:50:28 INFO - Cleaning up... 18:50:28 INFO - Return code: 0 18:50:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:28 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:28 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 18:50:28 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 18:50:28 INFO - Using env: {'DISPLAY': ':0', 18:50:28 INFO - 'HOME': '/home/cltbld', 18:50:28 INFO - 'LANG': 'en_US.UTF-8', 18:50:28 INFO - 'LANGUAGE': 'en_US:en', 18:50:28 INFO - 'LOGNAME': 'cltbld', 18:50:28 INFO - 'MAIL': '/var/mail/cltbld', 18:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:28 INFO - 'MOZ_NO_REMOTE': '1', 18:50:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:28 INFO - 'NO_EM_RESTART': '1', 18:50:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:28 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:28 INFO - 'SHELL': '/bin/bash', 18:50:28 INFO - 'SHLVL': '1', 18:50:28 INFO - 'TERM': 'linux', 18:50:28 INFO - 'TMOUT': '86400', 18:50:28 INFO - 'USER': 'cltbld', 18:50:28 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:28 INFO - '_': '/tools/buildbot/bin/python'} 18:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:50:28 INFO - Running setup.py (path:/tmp/pip-r3pm0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:50:28 INFO - Running setup.py (path:/tmp/pip-KX4W4n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:50:28 INFO - Running setup.py (path:/tmp/pip-UYSdP3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:50:28 INFO - Running setup.py (path:/tmp/pip-VF9Uxk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:50:28 INFO - Running setup.py (path:/tmp/pip-ipkUor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:50:28 INFO - Running setup.py (path:/tmp/pip-7o1TjT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:50:28 INFO - Running setup.py (path:/tmp/pip-LlLOBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:50:28 INFO - Running setup.py (path:/tmp/pip-wzkoDQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:50:28 INFO - Running setup.py (path:/tmp/pip-hmh0yq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:50:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:50:28 INFO - Running setup.py (path:/tmp/pip-waQMpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:50:29 INFO - Running setup.py (path:/tmp/pip-zH9D3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:50:29 INFO - Running setup.py (path:/tmp/pip-xPzsNS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:50:29 INFO - Running setup.py (path:/tmp/pip-OEwiDu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:50:29 INFO - Running setup.py (path:/tmp/pip-85qfNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:50:29 INFO - Running setup.py (path:/tmp/pip-2BkQvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:50:29 INFO - Running setup.py (path:/tmp/pip-TxOvKG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:50:29 INFO - Running setup.py (path:/tmp/pip-R5PGdC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:50:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:29 INFO - Running setup.py install for manifestparser 18:50:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:50:29 INFO - Running setup.py install for mozcrash 18:50:29 INFO - Running setup.py install for mozdebug 18:50:29 INFO - Running setup.py install for mozdevice 18:50:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:50:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:50:29 INFO - Running setup.py install for mozfile 18:50:30 INFO - Running setup.py install for mozhttpd 18:50:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for mozinfo 18:50:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for mozInstall 18:50:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for mozleak 18:50:30 INFO - Running setup.py install for mozlog 18:50:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for moznetwork 18:50:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for mozprocess 18:50:30 INFO - Running setup.py install for mozprofile 18:50:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:50:30 INFO - Running setup.py install for mozrunner 18:50:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:50:31 INFO - Running setup.py install for mozscreenshot 18:50:31 INFO - Running setup.py install for moztest 18:50:31 INFO - Running setup.py install for mozversion 18:50:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:50:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:31 INFO - Cleaning up... 18:50:31 INFO - Return code: 0 18:50:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:50: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')]} 18:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50: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')]} 18:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:31 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:31 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 18:50:31 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 18:50:31 INFO - Using env: {'DISPLAY': ':0', 18:50:31 INFO - 'HOME': '/home/cltbld', 18:50:31 INFO - 'LANG': 'en_US.UTF-8', 18:50:31 INFO - 'LANGUAGE': 'en_US:en', 18:50:31 INFO - 'LOGNAME': 'cltbld', 18:50:31 INFO - 'MAIL': '/var/mail/cltbld', 18:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:31 INFO - 'MOZ_NO_REMOTE': '1', 18:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:31 INFO - 'NO_EM_RESTART': '1', 18:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:31 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:31 INFO - 'SHELL': '/bin/bash', 18:50:31 INFO - 'SHLVL': '1', 18:50:31 INFO - 'TERM': 'linux', 18:50:31 INFO - 'TMOUT': '86400', 18:50:31 INFO - 'USER': 'cltbld', 18:50:31 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:31 INFO - '_': '/tools/buildbot/bin/python'} 18:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:50:31 INFO - Running setup.py (path:/tmp/pip-1WGsMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:50:31 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)) 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:50:31 INFO - Running setup.py (path:/tmp/pip-kV5KiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:50:31 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)) 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:50:31 INFO - Running setup.py (path:/tmp/pip-SSqwCr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:50:31 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)) 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:50:31 INFO - Running setup.py (path:/tmp/pip-kxcSwW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:50:31 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)) 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:50:31 INFO - Running setup.py (path:/tmp/pip-vsWX0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:50:31 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)) 18:50:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:50:31 INFO - Running setup.py (path:/tmp/pip-4WnlxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:50:32 INFO - Running setup.py (path:/tmp/pip-yIWfXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:50:32 INFO - Running setup.py (path:/tmp/pip-C45xhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:50:32 INFO - Running setup.py (path:/tmp/pip-8aVzLT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:50:32 INFO - Running setup.py (path:/tmp/pip-o0mUba-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:50:32 INFO - Running setup.py (path:/tmp/pip-o9hRLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:50:32 INFO - Running setup.py (path:/tmp/pip-LKHqI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:50:32 INFO - Running setup.py (path:/tmp/pip-VEFC45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:50:32 INFO - Running setup.py (path:/tmp/pip-I3LONN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:50:32 INFO - Running setup.py (path:/tmp/pip-Iucz2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:50:32 INFO - Running setup.py (path:/tmp/pip-9ShyW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:50:32 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)) 18:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:50:32 INFO - Running setup.py (path:/tmp/pip-IjjVlo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:50:32 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)) 18:50:32 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)) 18:50:32 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)) 18:50:32 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)) 18:50:32 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)) 18:50:32 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)) 18:50:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:32 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 18:50:32 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 18:50:32 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 18:50:32 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 18:50:32 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 18:50:32 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 18:50:34 INFO - Downloading blessings-1.5.1.tar.gz 18:50:34 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 18:50:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:34 INFO - Installing collected packages: blessings 18:50:34 INFO - Running setup.py install for blessings 18:50:34 INFO - Successfully installed blessings 18:50:34 INFO - Cleaning up... 18:50:34 INFO - Return code: 0 18:50:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:50:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:50:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:50:34 INFO - Reading from file tmpfile_stdout 18:50:34 INFO - Current package versions: 18:50:34 INFO - argparse == 1.2.1 18:50:34 INFO - blessings == 1.5.1 18:50:34 INFO - blobuploader == 1.2.4 18:50:34 INFO - docopt == 0.6.1 18:50:34 INFO - manifestparser == 1.1 18:50:34 INFO - mozInstall == 1.12 18:50:34 INFO - mozcrash == 0.16 18:50:34 INFO - mozdebug == 0.1 18:50:34 INFO - mozdevice == 0.47 18:50:34 INFO - mozfile == 1.2 18:50:34 INFO - mozhttpd == 0.7 18:50:34 INFO - mozinfo == 0.9 18:50:34 INFO - mozleak == 0.1 18:50:34 INFO - mozlog == 3.0 18:50:34 INFO - moznetwork == 0.27 18:50:34 INFO - mozprocess == 0.22 18:50:34 INFO - mozprofile == 0.27 18:50:34 INFO - mozrunner == 6.11 18:50:34 INFO - mozscreenshot == 0.1 18:50:34 INFO - mozsystemmonitor == 0.0 18:50:34 INFO - moztest == 0.7 18:50:34 INFO - mozversion == 1.4 18:50:34 INFO - psutil == 3.1.1 18:50:34 INFO - requests == 1.2.3 18:50:34 INFO - wsgiref == 0.1.2 18:50:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:50:34 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 0x7f9dd0272c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fd6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13af7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, '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': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', '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 18:50:34 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 18:50:34 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 18:50:34 INFO - Using env: {'DISPLAY': ':0', 18:50:34 INFO - 'HOME': '/home/cltbld', 18:50:34 INFO - 'LANG': 'en_US.UTF-8', 18:50:34 INFO - 'LANGUAGE': 'en_US:en', 18:50:34 INFO - 'LOGNAME': 'cltbld', 18:50:34 INFO - 'MAIL': '/var/mail/cltbld', 18:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:34 INFO - 'MOZ_NO_REMOTE': '1', 18:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:34 INFO - 'NO_EM_RESTART': '1', 18:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:34 INFO - 'SHELL': '/bin/bash', 18:50:34 INFO - 'SHLVL': '1', 18:50:34 INFO - 'TERM': 'linux', 18:50:34 INFO - 'TMOUT': '86400', 18:50:34 INFO - 'USER': 'cltbld', 18:50:34 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:34 INFO - '_': '/tools/buildbot/bin/python'} 18:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 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)) 18:50:35 INFO - Cleaning up... 18:50:35 INFO - Return code: 0 18:50:35 INFO - Running post-action listener: _resource_record_post_action 18:50:35 INFO - Running post-action listener: _start_resource_monitoring 18:50:35 INFO - Starting resource monitoring. 18:50:35 INFO - ##### 18:50:35 INFO - ##### Running install step. 18:50:35 INFO - ##### 18:50:35 INFO - Running pre-action listener: _resource_record_pre_action 18:50:35 INFO - Running main action method: install 18:50:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:50:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:50:35 INFO - Reading from file tmpfile_stdout 18:50:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:50:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:50:35 INFO - Reading from file tmpfile_stdout 18:50:35 INFO - Output received: 18:50:35 INFO - Usage: mozinstall [options] installer 18:50:35 INFO - Options: 18:50:35 INFO - -h, --help show this help message and exit 18:50:35 INFO - -d DEST, --destination=DEST 18:50:35 INFO - Directory to install application into. [default: 18:50:35 INFO - "/builds/slave/test-pgo"] 18:50:35 INFO - --app=APP Application being installed. [default: firefox] 18:50:35 INFO - mkdir: /builds/slave/test-pgo/build/application 18:50:35 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'] 18:50:35 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 18:50:49 INFO - Reading from file tmpfile_stdout 18:50:49 INFO - Output received: 18:50:49 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:50:49 INFO - Running post-action listener: _resource_record_post_action 18:50:49 INFO - ##### 18:50:49 INFO - ##### Running run-tests step. 18:50:49 INFO - ##### 18:50:49 INFO - Running pre-action listener: _resource_record_pre_action 18:50:49 INFO - Running main action method: run_tests 18:50:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:50:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:50:49 INFO - Python 2.7.3 18:50:49 INFO - Return code: 0 18:50:49 INFO - grabbing minidump binary from tooltool 18:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:50:49 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 0x13f3d70>, '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 0x13f4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:50:49 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 18:50:49 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 18:50:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:50:49 INFO - Return code: 0 18:50:49 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:50:49 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:50:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:50:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:50:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:50:49 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:50:49 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 18:50:49 INFO - Using env: {'DISPLAY': ':0', 18:50:49 INFO - 'HOME': '/home/cltbld', 18:50:49 INFO - 'LANG': 'en_US.UTF-8', 18:50:49 INFO - 'LANGUAGE': 'en_US:en', 18:50:49 INFO - 'LOGNAME': 'cltbld', 18:50:49 INFO - 'MAIL': '/var/mail/cltbld', 18:50:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:50:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:49 INFO - 'MOZ_NO_REMOTE': '1', 18:50:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:49 INFO - 'NO_EM_RESTART': '1', 18:50:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:50:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:50:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:50:49 INFO - 'SHELL': '/bin/bash', 18:50:49 INFO - 'SHLVL': '1', 18:50:49 INFO - 'TERM': 'linux', 18:50:49 INFO - 'TMOUT': '86400', 18:50:49 INFO - 'USER': 'cltbld', 18:50:49 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1447900856.534738-891863675', 18:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:49 INFO - '_': '/tools/buildbot/bin/python'} 18:50:49 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 18:50:50 INFO - mozversion INFO | application_buildid: 20151118173022 18:50:50 INFO - mozversion INFO | application_changeset: 42a976b770f1b1e54133ee0383940013ded058eb 18:50:50 INFO - mozversion INFO | application_display_name: Nightly 18:50:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:50:50 INFO - mozversion INFO | application_name: Firefox 18:50:50 INFO - mozversion INFO | application_remotingname: firefox 18:50:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:50:50 INFO - mozversion INFO | application_vendor: Mozilla 18:50:50 INFO - mozversion INFO | application_version: 45.0a1 18:50:50 INFO - mozversion INFO | platform_buildid: 20151118173022 18:50:50 INFO - mozversion INFO | platform_changeset: 42a976b770f1b1e54133ee0383940013ded058eb 18:50:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:50:50 INFO - mozversion INFO | platform_version: 45.0a1 18:50:50 INFO - 2015-11-18 18:50:50,057 DEBUG : using testdate: 1447901450 18:50:50 INFO - 2015-11-18 18:50:50,057 DEBUG : actual date: 1447901450 18:50:50 INFO - 2015-11-18 18:50:50,141 INFO : starting webserver on 'localhost:56397' 18:50:50 INFO - 2015-11-18 18:50:50,142 INFO : Starting test suite talos-linux64-ix-042.e 18:50:50 INFO - 2015-11-18 18:50:50,142 INFO : Starting test dromaeo_css 18:50:50 INFO - 2015-11-18 18:50:50,143 DEBUG : operating with platform_type : linux_ 18:50:50 INFO - 2015-11-18 18:50:50,143 INFO : Initialising browser for dromaeo_css test... 18:50:50 INFO - 2015-11-18 18:50:50,156 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9LlGt_/profile http://localhost:56397/getInfo.html 18:50:55 INFO - 2015-11-18 18:50:55,530 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:50:55 INFO - 2015-11-18 18:50:55,531 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:50:55 INFO - 2015-11-18 18:50:55,531 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:50:55 INFO - 2015-11-18 18:50:55,531 DEBUG : BROWSER_OUTPUT: __metrics 18:50:56 INFO - 2015-11-18 18:50:56,693 INFO : Browser initialized. 18:50:56 INFO - 2015-11-18 18:50:56,694 INFO : Running cycle 1/1 for dromaeo_css test... 18:50:56 INFO - 2015-11-18 18:50:56,694 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9LlGt_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:51:08 INFO - 2015-11-18 18:51:08,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 141946880 18:51:08 INFO - 2015-11-18 18:51:08,484 DEBUG : BROWSER_OUTPUT: 18:51:58 INFO - 2015-11-18 18:51:58,110 DEBUG : BROWSER_OUTPUT: 1447901518106 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] 18:54:07 INFO - 2015-11-18 18:54:07,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56397/tests/dromaeo/cssquery-ext.html) 18:54:08 INFO - 2015-11-18 18:54:08,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 148946944 18:54:08 INFO - 2015-11-18 18:54:08,221 DEBUG : BROWSER_OUTPUT: 18:57:10 INFO - 2015-11-18 18:57:10,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-ext.html (next: http://localhost:56397/tests/dromaeo/cssquery-jquery.html) 18:57:10 INFO - 2015-11-18 18:57:10,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 141930496 18:57:10 INFO - 2015-11-18 18:57:10,784 DEBUG : BROWSER_OUTPUT: 19:00:12 INFO - 2015-11-18 19:00:12,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56397/tests/dromaeo/cssquery-mootools.html) 19:00:12 INFO - 2015-11-18 19:00:12,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 143802368 19:00:12 INFO - 2015-11-18 19:00:12,966 DEBUG : BROWSER_OUTPUT: 19:03:14 INFO - 2015-11-18 19:03:14,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56397/tests/dromaeo/cssquery-prototype.html) 19:03:15 INFO - 2015-11-18 19:03:15,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 19:03:15 INFO - 2015-11-18 19:03:15,222 DEBUG : BROWSER_OUTPUT: 19:06:17 INFO - 2015-11-18 19:06:17,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56397/tests/dromaeo/cssquery-yui.html) 19:06:18 INFO - 2015-11-18 19:06:18,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 141565952 19:06:18 INFO - 2015-11-18 19:06:18,085 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/dromaeo/cssquery-yui.html (next: http://localhost:56397/tests/dromaeo/cssquery-dojo.html) 19:09:20 INFO - 2015-11-18 19:09:20,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 143757312 19:09:20 INFO - 2015-11-18 19:09:20,561 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3203.983980080099;3261.217307846116;3278.8196649184283;3305;3310.8344582770856;5221.425643179247;5352.464753524646;5375;5418.160185171299;5438.075527160382;5318.46815318468;5333.38666053404;5339.41266460689;5356.276902618145;5366.087765079936;4924.729139897304;4971.45314015458;5003.774830132635;5004.949950500485;5010.824621138243;4878.1219380511675;4939.456659767423;4941.975290123544;4951.405831300249;4983.975080124595;4731.881702957437;4839.758012099381;4951.405831300249;4954.232094025432;4970.701757894538;4973.229149481836;4974.079795237856;4980.9252861207115;4985.551300382983;5019.548240658358;4769.499202583714;4941.110600092018;4956.1822299320565;4972.87567810804;5000.849974500771;5143.485651434864;5159.845204643829;5208.739563021872;5211.218317252443;5246.580273578104;5732.140178973145;5772.913406298909;5787.50806181475;5797.594168408213;5807;5746.42535746422;5825.912611310834;5829.242198514166;5835.824925252249;5842.444967728059;5332.893342133136;5378.058839703036;5378.220158077057;5381.892362152735;5385.488378604026;5922.792702255487;5971.19388882504;5972.731227094791;5976.193213916153;6027.45752882234;5783.8554036149435;5787.797427090031;5793.102069179284;5796.188533605298;5801.390853960358;5609.551235901118;5764.942350576524;5775.768969241183;5801.01382764931;5853.946289667815;5692.0323544997445;5699.458551437607;5701.515371193412;5705.058665320175;5853.619514731528;5765;5799.652020878761;5824.446677565625;5830.708464576839;5831.970840145772;4495.955040449619;4512.323151527232;4522.660800439914;4525.479569849509;4552.2488789350045;3821.7324787264624;3912.550056743454;3951.249262640089;4011.438398624195;4012.117334186474;5479.232907392969;5494.718143882784;5507.284053073155;5513.393526712059;5552.7778888843995;5551.084071128219;5773.047447171254;5775.768969241268;5787.102999035156;5798;5400.297961265089;5458.181272809111;5509.063459211943;5535.280413546213;5577.1355439906065;5040.747962601855;5059.645824792229;5074.4671809460215;5096.05722941257;5119.078565858107;5828.6502809831545;5951.613145145465;6071.969640151771;6079.878402431927;6094.542909281821;5667.716614169192;5808.36108028125;5810.796622118206;5833.154192641959;5838.211841401357;6035.245594300713;6060.636361818305;6070.848228794315;6077;6083.361247068994;5458.890822183614;5511.118221084607;5614.04561224601;5772.913406298825;5805.042168042226;5849.795257165979;5874.353821079763;5885.440883116097;5900.7049647518315;5901.409859014064;5705.372409035086;5739.139129130664;5749.741261643152;5766.769329226784;5775.9133612995;5480.671159730429;5566.52684521804;5598.356189038313;5734.856628584152;5737.799177028784;5559.471850174227;5582.8325150245555;5600.131979543177;5600.299962504687;5618.2415373924;5614.5789065821045;5689.886202276014;5707.6290041147195;5748.195252664546;5751.252337196138;5269.868253293698;5429.077056900257;5461.863453413696;5518.91721624184;5565.30433695788 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.23759399998;579.0590290777486;582.4408567774935;615.5783288447413;620.9906851397227;39699;40254.39618405726;40581;40682.18635627289;40773.18453630926;42650;43182.56817431825;43215.78392108043;43218.351724724074;43252.567474325326;8691.26124279437;8768.298536117127;8813.515256660881;8840.734777956672;8854.690085846996;8538.018127915277;8669.869951950726;8683.261922736576;8685.609147588373;8698.739037828875;8712.085231050743;8798.384113112084;8842.159994800484;8845.380823342368;8846.292296616255;8711.651533938635;8738.257248133885;8794.868076978786;8802.427842190236;8818.735437936872;8612.1387861214;8686.261667758248;8759.781005474913;8766.780830479225;8771.73684789451;39708.80145599283;40166.196676066604;40172;40469.797651011555;40524;3339.7996120232865;3490.616032236477;3689.6494832991093;3888.8250028748776;3998.2403343364667;29671.25821854449;29901.850490747405;30120.397592048037;30311.24221894448;31231.219219519466;3556.1287484566187;3628.2924829658227;3630.5280313559333;3714.461403096536;3735.34631439497;271536;271793;272309.63845180644;272456;272496;57680;57825.421745782005;57888.710556446946;57898.71050644804;58128.418715813146;60964.695176523834;61450;65904;66718.66640666766;66813.66593167002;16238.106904120386;16273.349066037226;16325.510234692978;16387.098709571088;16412.589685257724;12352.25886446816;12356.073294502949;12386;12397.93801030989;12428.937855310665;20832.1667133316;20906.686399704016;20986.89506552488;21022.894885525475;21245.150193992376;7963.402744794048;8367.748967530984;8372.120927302667;8382.79043023917;8422.494650321001;952.2429668413489;964.9565769540247;978.1294647763497;979.5640939781871;1015.9535678251412;28829.56755648667;29395.7060429393;29409.55885661717;29546.261343466154;29644.407111857643;1017.6539976408056;1019.5819713917258;1021.2187676427391;1022.7392015036119;1057.370864335719;14681.706365872837;15168.696626067416;17120.74318885218;17275.222614982355;17474.213660385314;390544;393631;394524;395597;396208.0568791471;56009.71995139998;56206.156907646415;56221;56248.43751562514;56398.436015639316;1334.1061488802331;1353.6074538383955;1363.1412210307642;1372.3001269352503;1391.3460673483648;29396.85301573564;30399.08802735833;32597.18507037343;33157.50263746094;33292.66707332896;49839.75080124721;49882.75058624684;50400.49599504105;50518.74740626421;50564.74717626388;285937;286864;286916;287001;289265;43108;46486.58377454137;47016.7649161752;47464.52535474601;47698.76150619225;44905.32642010307;44957;45088;45106.54893451023;45159;37454.25091498209;37490.81254593709;37944.620553794106;38190.82429544424;39069.218615628095;38078.619213807506;38418.231635367694;38651.22697546089;38799.80600096982;38895.027624309616;36024.27951441009;37360.25279494341;37436.43845342268;37502.43746343862;37783.433248501846;31769.841150795022;34567.308653827284;34751.65248347585;34801;35012.64987350094;26234;26256.911021836477;26289.605655914795;26366;26431.471370572865 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.18865006958396;340.9130671678722;343.239724011315;347.99130021749454;349.3397478765133;11532.423378831067;11844.466998985044;16455.83544164558;17133.742993855085;18945.33691320804;10928.180386471007;11068.723281917955;11090.33457992521;11112.944435277832;11182.944085279561;4388.890277743058;4510.25580779171;4515.029268707227;4517.728936263835;4523.977380113111;4406.581374769407;4488.910221795579;4489.977550112261;4503.1218912312115;4521.502634710196;4452.10957808438;4453.599176074153;4458.175237581057;4594.977025114869;4704.529547045302;4698.624110071186;4704.247320428732;4709.740964246965;4718.150732868083;4745.881352966187;4012.7191096623246;4080.6735461163034;4108.36320370343;4115.691323150746;4128;12568.05739569536;12588.307643079626;12612.558560450432;12824.166429182073;13168.078234523588;1869.9158537865828;1919.6256729937668;1981.128303546435;1981.5541503161817;2035.0130186859362;9642.373245739005;9847.507624618813;9873.259505537113;9911.40531568101;10021.649242276486;1650.075957463812;1655.1393275496675;1657.1962598139892;1680.2522877319598;1725.6462425202803;58445.41554584485;59204.70397647984;60458.69770651162;61174.694126529525;61777.382226177615;6456.838579035561;6708.865822683519;6754.797356079325;6776.390124888783;6799.966000169968;8048;8076.353891688651;8088.555129467935;8090;8091.150429204967;5483.75323110453;5542.168674698747;5550.361708403585;5557.944420555743;5606.915896261559;5660.575456840671;5676.716164191774;5700.971495142498;5710.857228569319;5718.342390625048;3122.9219269518444;3132.98433507831;3150.763692723055;3161.731252843488;3176.8093914365213;1102.2229328323513;1109.4452773613193;1111.5442668506034;1130.0846314485293;1159.4029075026367;456.7168355619537;477.98566043018764;484.3799936081821;496.13672210354446;506.4808571214461;11168.609098681507;11184.27302225369;11467.197296189186;11640.417979101012;11859.703507412383;484.9733264670477;493.73091665042637;507.8501841956558;513.5634710496048;527.411935691701;6044.697765111727;6171.814845554641;6177.938220617826;6199.380061993855;6539.411452969161;491933;505626;508112;508132;508526;72734;72870.99999999894;73908.2609173912;75025.62487187529;76636;551.8565173054955;559.4070285497386;559.4098226371136;559.9832005039856;563.2424389196524;10450.686479405325;10899.727506812393;11183.105351571692;11270.549178033114;11341.092712583139;32005;32179.03462896117;32200.35599288048;32637.836810816745;32686.83656581702;41796.79101604594;45202;45924.770376147906;46924.530754693384;47030.529694702615;6877.58734475913;6983.755568555076;6997.055397521473;7034.929650703428;7060.258672839278;12310.26138431697;12319.099163395626;12632.494700212255;12633.557825476064;12639.557615483414;9872.308938374244;10048.748781280527;10217.23370747182;10389.909059548638;10890.836637450602;10205.132563732166;10253.487325633838;10313.1233845124;10366.378017318984;10588.629397971034;10126.39241645474;10140.340877842917;10177.847332289874;10815.56737730482;10927;6487.091807146909;6557.147570815763;6619.66901654925;6636.502262330248;6660;10360.481975901024;10404.167666586503;10457.68626941193;10462.267641265344;10640.201984851323 19:09:20 INFO - 2015-11-18 19:09:20,562 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1417.2488581052044;1482.36999275308;1598.0571462836924;1605.0851014921484;1779.5995900922287;6075.362086980869;6217;6240.219972503437;7206.423486121111;7637.694492220305;7756.495827771191;7776.766696999085;7844.137144914069;7886.093099293583;7920.92079079209;2127.4468638154112;2176.662617294314;2179;2180.5529866377433;2183.410479170623;2232.0513781642817;2245.461089338555;2258.695076164713;2266.829987750917;2267.0931627349028;2187.890605469728;2212.3473575295247;2228.1644383356243;2241.8654880707127;2250.2799104286637;2087.926922557703;2148.699182114505;2177.314146043991;2188.3434969509085;2189.9452513687124;2253.988730056339;2274.4541310085624;2280.85174463661;2284.9657255141187;2286.4855407533337;7289.599072051035;7382.7046918123215;7392.482526223166;7401.592912389817;7410.481266311361;4293.4203882476095;4357.106793107406;4368;4368.47578290604;4387.210302145612;2797.37059161689;2902.3904979954236;2924.020453148177;2924.3712601790717;2934.4131173765118;964.6961207219773;988.0465350936381;997.581015973293;997.880254369473;1061.1510791366952;10027.348222365596;10056.396616203052;10146.746331341701;10168.847467287997;10172.847407288897;3944.546377166605;3992.201559688074;3995;4019.7588144710826;4030.6775457963295;8249.958750206211;8271.875921861178;8323;8333.749987500385;8346.165383461726;4485.730856148642;4493.078918821634;4508;4509.842155524607;4514.435695538058;4089.3865920111625;4106.486689163855;4115;4118.876433706993;4126.381042843537;3381.7970921744773;3382.30662714143;3382.3235352929514;3390.355832391838;3401.3027329397414;1012.1143999000874;1024.349538043333;1025.0569476082023;1028.2545154762886;1036.2797855490362;1053.6628278950661;1072.0726571515584;1084.0081325587157;1246.2335663566842;1383.3290853935832;7069.08101946754;7153.964230178815;7160.964195178991;7221.42228621709;7235.8552828944175;1148.8047032004579;1153.1005815463952;1161.3148242536943;1169.7134202120535;1171.37916904041;5489.2589500417735;5499.395066542677;5523.751431185526;5535.833924982257;5553.194786755897;8516.06323304436;8569.400141990125;8680.131986801396;8689.652413903374;8707.129287071242;8602.268807151337;8672.262857657044;8689.391742578086;8702.34732395073;8729.083446238054;6711.395974362234;6718.160229971254;6731.49513786468;6772.8984065239065;6899.17209934811;6876.17485901675;6889.517733758589;6913.2049814272;6921.515493915579;6938.757143499954;7626.42436880916;7697.692092316244;7759.534427934342;7850.0972388173805;7954.602269886367;7726.729564465217;7780.49426787257;7781.610919454118;7811.336036436966;7985;6620.271770105188;6642.4021838034805;6705.094812200486;6709.496787740842;6741.393274605309;7140.428765698628;7201.819954501179;7238.927610723826;7253.455990800606;7257.673404696907;6613.6693165340575;6763.2222294434805;6774.525783195129;6789.15135608049;6880.208775990625;6848.14398200225;6915.481338899502;6927.099477067949;6953.721851125898;7097.645117744195;6972.477064220305;6993.4754893384215;7001.474889383215;7030.156381234285;7031.05080814104;6357.110004599267;6410.1987251593555;6443.742250309935;6452.483801295979;6455.548111632141;6430.48556115519;6439.839004024937;6505.0567667688865;6538.574992625464;6549.96725016391 19:09:20 INFO - 2015-11-18 19:09:20,563 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.67382595926205;318.69086985623943;320.40085040973383;327.1771494690851;328.1599106287902;6187.969060154698;6324.399182077706;6337.683115844206;6347.301796802354;6444.291127975919;6230.065490176476;6248.4064013918605;6293.056041593763;6301.338359472258;6306.1171435998995;4634.58288754012;4743.691660042086;4784.354112194861;4785.928211076819;4791.113643975876;4752.1683705351425;4763.618910487153;4769.403824521934;4790.473047964739;4803.831865884695;4725.826119984811;4726.314684370765;4727.1254817858635;4740.573348398643;4747.192977193886;4741.454732705749;4742.454617718938;4744.691595046328;4748.881277968044;4752.76236188191;3996.7002474814212;4115.444415003996;4117.3206420940505;4125.23683118624;4134.276501612206;5929;5952.3631001474505;5964.522838172936;5969.462748352626;5985.281766188042;5464.672119672832;5509.146082357241;5518.144687573433;5520.420355862657;5523.199136125279;6525.543211975164;6578.079068930354;6624.906890363084;6640.435562977153;6646.534742568022;4514.210013247669;4543.409356783597;4552.8146489684805;4555.589996900295;4567.086582683477;6906.965465172642;6928.237893831674;6948.513604047719;6979.89530157048;6987.685554150075;4626.583607475343;4629.259318509023;4637.420322459692;4638.0955713636195;4638.930416043762;4566.383538222364;4638.5593368629925;4665.766711664403;4671.252599584118;4694.976525117352;5447.4824891635235;5461.098918678453;5462.317210348707;5468.945310546844;5473.863153421196;6621.702023408958;6669.533132680763;6672.266050734415;6673.599584024877;6704.631245281556;1646.5471995201415;1670.62410957536;1671.264643556831;1671.816100228974;1671.9665606687797;1059.433203236265;1085.4898197846999;1088.4992903264429;1089.1341383600056;1108.933463992163;6361.745530178741;6475.093486911836;6483.870322593521;6490.993895946041;6500.70746816385;6920.757773477904;6965.651717414109;6989.126359205099;7031.613261270577;7032.296770322927;6532.118164047793;6535.542512024208;6553.115329430561;6554.246261679872;6586.209654841449;3708.7774733516076;3749.418840079792;3784.848606055782;3789.090618251655;3799.848006079781;7137.393321567725;7258.02016727735;7260.67326970277;7270.818229544304;7276.63616819157;7095.609741464269;7151.177614574391;7184.317489838457;7205.819854503679;7208.495405321577;7044.295570442915;7214.206437291894;7223.205447400782;7259.745908893164;7277.3086556777025;6907.067545881443;6977.546459480118;6982.930170698228;6984.685689143899;6991.300869912968;6867.450603951572;6872.518923675495;6875.140607424072;6897.379235868595;6905.136857892763;7087.7164913402885;7183.892241616275;7218.314260145278;7222.241664625349;7259.346658800733;4640.327152562927;4674.9247673034715;4674.9766251169885;4684.6252299816615;4692.1084993851055;6973.895391569232;6977.546459480118;6981.930180698128;6988.37104660583;7011.614361210182;6618.205815302002;6765.9661701691175;6766.391024807594;6779.627120508222;6785.218060595133;6726.7981960541265;6728.798136055926;6744.966275168593;6750.932490675031;6760.526763126534;6428.839279018062;6529.412352888263;6543.378379053982;6553.082568440517;6577.440917522064;6644.169478815148;6791.72833086671;6811.591304521745;6817.181938167451;6823.1812182538415;6607.504437167136;6660.56706314088;6681.2984636612455;6695.531312808057;6696.464282857262 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.4779024158694;780.5940910726418;782.2334112569681;822.6544851162511;886.2024178239584;13088.803667944976;13514.32428378582;13541.729165416698;13554.525591604295;13567.185968841877;12436.626901192978;13210.075294729373;13491;13691.383887725051;13730;829.784256093414;833.1834801894147;836.0385556609887;843.359047124187;843.6498852976008;822.8189798244376;823.4071468542639;829.1956801902145;831.5177197225595;836.3100442135233;869.8086420987404;873.6505397840883;876.9166929141753;877.4340550345023;879.6965047058786;866.3718803867209;873.0265753684596;874.4665753890122;874.510274246424;876.3733930239878;632.8639342541329;636.8153235561682;640.1709785827318;640.8942524483455;643.2217017408941;12505.49978000879;12524.624261272176;12570.182938108994;12579.937100314532;12605.30670813105;11017.669469915916;11035.779284414266;11267.323960562393;11268.774624507547;11314.717132071682;10036.447995360253;10112.089911907964;10190.541425635864;10327.948360258151;10335.534900929477;3524.541809564766;3594.291711640929;3619.565652121736;3672.6510981456986;3714.4242642390473;40370.394444083366;40602.18795624071;45484.54515454836;45559.77220113878;46741.29888051648;10128.59485620567;10160;10190.949045254727;10367;10415.531301091469;17970.820291797176;17994.10029498546;18003;18020.36928707489;18056.729149062776;7404.296591823768;7486.513376630502;7580.620968951531;7635.961820190863;7662.961685191538;4292.892677683083;4304.117655880599;4352.608265256142;4372.978135109368;4403.229434848889;2974.301039255773;3027.5458681197997;3032.3935212957053;3038.4075105354245;3045.558394032853;439.604356079531;446.83690452985076;448.9079738653634;457.320878495434;464.39396587453024;568.647438588078;635.1774452084469;677.9830504237434;679.6669631880343;718.1956209045902;9113.270938324918;9117.36178467501;9181.58682859273;9259.490728010023;9292.303077269233;647.5661306924372;658.7529676371361;677.386179344168;679.6635665345685;685.3215316836296;3717.665410113103;3823.3500304948225;3824.2733880562605;3882.7476214045996;3903.1413089120347;53181.46818531765;53636.73181634067;53861;56024.159637605466;60282;44673.55326446694;45273.54726452693;45674;47005;51318.74340628273;38382.424263636065;43033.35449968253;46666.300005499266;47538;49187;8700.434471759316;8865;8879.289656827568;9031.683891063782;9255.953720231355;37078.73594536663;37170.8141459291;37339;37599.81200093982;37722;45297.77351113223;46346.53653463422;46475.76762116168;46490.76754616205;46504.53495465002;8653.307735381028;8784.253338466302;8831.779205519913;8873.689420870238;8940.061293564082;11905.702357441134;12024.519019239133;12031.639050828138;12150.756984860076;12301.692457688629;11471.827922581;11606.767864642828;11639.068874490189;11701.824472632747;12126.818097728717;10989.560417583207;11017.889821101686;11298.717532061764;11381;11639.127065470293;10859.457027148454;11240.109737187297;11252.437378131224;11265.436728163722;11685.123615728684;10188.490575471345;10210.693679189637;10229.539670714687;10249.590016399261;10355.534000969823;9225.308101892251;9452.952735236555;9466.2427005838;10092;10116.747081323027 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,283 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: __startTimestamp1447902560554__endTimestamp 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5385.06 Median:5559.47 stddev:595.28 (10.7%) stddev-sans-first:571.98 19:09:20 INFO - 2015-11-18 19:09:20,565 DEBUG : BROWSER_OUTPUT: Values: 3204.0 3261.2 3278.8 3305.0 3310.8 5221.4 5352.5 5375.0 5418.2 5438.1 5318.5 5333.4 5339.4 5356.3 5366.1 4924.7 4971.5 5003.8 5004.9 5010.8 4878.1 4939.5 4942.0 4951.4 4984.0 4731.9 4839.8 4951.4 4954.2 4970.7 4973.2 4974.1 4980.9 4985.6 5019.5 4769.5 4941.1 4956.2 4972.9 5000.8 5143.5 5159.8 5208.7 5211.2 5246.6 5732.1 5772.9 5787.5 5797.6 5807.0 5746.4 5825.9 5829.2 5835.8 5842.4 5332.9 5378.1 5378.2 5381.9 5385.5 5922.8 5971.2 5972.7 5976.2 6027.5 5783.9 5787.8 5793.1 5796.2 5801.4 5609.6 5764.9 5775.8 5801.0 5853.9 5692.0 5699.5 5701.5 5705.1 5853.6 5765.0 5799.7 5824.4 5830.7 5832.0 4496.0 4512.3 4522.7 4525.5 4552.2 3821.7 3912.6 3951.2 4011.4 4012.1 5479.2 5494.7 5507.3 5513.4 5552.8 5551.1 5773.0 5775.8 5787.1 5798.0 5400.3 5458.2 5509.1 5535.3 5577.1 5040.7 5059.6 5074.5 5096.1 5119.1 5828.7 5951.6 6072.0 6079.9 6094.5 5667.7 5808.4 5810.8 5833.2 5838.2 6035.2 6060.6 6070.8 6077.0 6083.4 5458.9 5511.1 5614.0 5772.9 5805.0 5849.8 5874.4 5885.4 5900.7 5901.4 5705.4 5739.1 5749.7 5766.8 5775.9 5480.7 5566.5 5598.4 5734.9 5737.8 5559.5 5582.8 5600.1 5600.3 5618.2 5614.6 5689.9 5707.6 5748.2 5751.3 5269.9 5429.1 5461.9 5518.9 5565.3 19:09:20 INFO - 2015-11-18 19:09:20,566 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,566 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49787.13 Median:216350.11 stddev:84508.54 (39.1%) stddev-sans-first:84664.83 19:09:20 INFO - 2015-11-18 19:09:20,566 DEBUG : BROWSER_OUTPUT: Values: 573.2 579.1 582.4 615.6 621.0 39699.0 40254.4 40581.0 40682.2 40773.2 42650.0 43182.6 43215.8 43218.4 43252.6 8691.3 8768.3 8813.5 8840.7 8854.7 8538.0 8669.9 8683.3 8685.6 8698.7 8712.1 8798.4 8842.2 8845.4 8846.3 8711.7 8738.3 8794.9 8802.4 8818.7 8612.1 8686.3 8759.8 8766.8 8771.7 39708.8 40166.2 40172.0 40469.8 40524.0 3339.8 3490.6 3689.6 3888.8 3998.2 29671.3 29901.9 30120.4 30311.2 31231.2 3556.1 3628.3 3630.5 3714.5 3735.3 271536.0 271793.0 272309.6 272456.0 272496.0 57680.0 57825.4 57888.7 57898.7 58128.4 60964.7 61450.0 65904.0 66718.7 66813.7 16238.1 16273.3 16325.5 16387.1 16412.6 12352.3 12356.1 12386.0 12397.9 12428.9 20832.2 20906.7 20986.9 21022.9 21245.2 7963.4 8367.7 8372.1 8382.8 8422.5 952.2 965.0 978.1 979.6 1016.0 28829.6 29395.7 29409.6 29546.3 29644.4 1017.7 1019.6 1021.2 1022.7 1057.4 14681.7 15168.7 17120.7 17275.2 17474.2 390544.0 393631.0 394524.0 395597.0 396208.1 56009.7 56206.2 56221.0 56248.4 56398.4 1334.1 1353.6 1363.1 1372.3 1391.3 29396.9 30399.1 32597.2 33157.5 33292.7 49839.8 49882.8 50400.5 50518.7 50564.7 285937.0 286864.0 286916.0 287001.0 289265.0 43108.0 46486.6 47016.8 47464.5 47698.8 44905.3 44957.0 45088.0 45106.5 45159.0 37454.3 37490.8 37944.6 38190.8 39069.2 38078.6 38418.2 38651.2 38799.8 38895.0 36024.3 37360.3 37436.4 37502.4 37783.4 31769.8 34567.3 34751.7 34801.0 35012.6 26234.0 26256.9 26289.6 26366.0 26431.5 19:09:20 INFO - 2015-11-18 19:09:20,566 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,566 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25554.66 Median:4473.54 stddev:82751.46 (1849.8%) stddev-sans-first:82961.94 19:09:20 INFO - 2015-11-18 19:09:20,567 DEBUG : BROWSER_OUTPUT: Values: 340.2 340.9 343.2 348.0 349.3 11532.4 11844.5 16455.8 17133.7 18945.3 10928.2 11068.7 11090.3 11112.9 11182.9 4388.9 4510.3 4515.0 4517.7 4524.0 4406.6 4488.9 4490.0 4503.1 4521.5 4452.1 4453.6 4458.2 4595.0 4704.5 4698.6 4704.2 4709.7 4718.2 4745.9 4012.7 4080.7 4108.4 4115.7 4128.0 12568.1 12588.3 12612.6 12824.2 13168.1 1869.9 1919.6 1981.1 1981.6 2035.0 9642.4 9847.5 9873.3 9911.4 10021.6 1650.1 1655.1 1657.2 1680.3 1725.6 58445.4 59204.7 60458.7 61174.7 61777.4 6456.8 6708.9 6754.8 6776.4 6800.0 8048.0 8076.4 8088.6 8090.0 8091.2 5483.8 5542.2 5550.4 5557.9 5606.9 5660.6 5676.7 5701.0 5710.9 5718.3 3122.9 3133.0 3150.8 3161.7 3176.8 1102.2 1109.4 1111.5 1130.1 1159.4 456.7 478.0 484.4 496.1 506.5 11168.6 11184.3 11467.2 11640.4 11859.7 485.0 493.7 507.9 513.6 527.4 6044.7 6171.8 6177.9 6199.4 6539.4 491933.0 505626.0 508112.0 508132.0 508526.0 72734.0 72871.0 73908.3 75025.6 76636.0 551.9 559.4 559.4 560.0 563.2 10450.7 10899.7 11183.1 11270.5 11341.1 32005.0 32179.0 32200.4 32637.8 32686.8 41796.8 45202.0 45924.8 46924.5 47030.5 6877.6 6983.8 6997.1 7034.9 7060.3 12310.3 12319.1 12632.5 12633.6 12639.6 9872.3 10048.7 10217.2 10389.9 10890.8 10205.1 10253.5 10313.1 10366.4 10588.6 10126.4 10140.3 10177.8 10815.6 10927.0 6487.1 6557.1 6619.7 6636.5 6660.0 10360.5 10404.2 10457.7 10462.3 10640.2 19:09:20 INFO - 2015-11-18 19:09:20,567 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5204.91 Median:6420.34 stddev:2646.78 (41.2%) stddev-sans-first:2638.89 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: Values: 1417.2 1482.4 1598.1 1605.1 1779.6 6075.4 6217.0 6240.2 7206.4 7637.7 7756.5 7776.8 7844.1 7886.1 7920.9 2127.4 2176.7 2179.0 2180.6 2183.4 2232.1 2245.5 2258.7 2266.8 2267.1 2187.9 2212.3 2228.2 2241.9 2250.3 2087.9 2148.7 2177.3 2188.3 2189.9 2254.0 2274.5 2280.9 2285.0 2286.5 7289.6 7382.7 7392.5 7401.6 7410.5 4293.4 4357.1 4368.0 4368.5 4387.2 2797.4 2902.4 2924.0 2924.4 2934.4 964.7 988.0 997.6 997.9 1061.2 10027.3 10056.4 10146.7 10168.8 10172.8 3944.5 3992.2 3995.0 4019.8 4030.7 8250.0 8271.9 8323.0 8333.7 8346.2 4485.7 4493.1 4508.0 4509.8 4514.4 4089.4 4106.5 4115.0 4118.9 4126.4 3381.8 3382.3 3382.3 3390.4 3401.3 1012.1 1024.3 1025.1 1028.3 1036.3 1053.7 1072.1 1084.0 1246.2 1383.3 7069.1 7154.0 7161.0 7221.4 7235.9 1148.8 1153.1 1161.3 1169.7 1171.4 5489.3 5499.4 5523.8 5535.8 5553.2 8516.1 8569.4 8680.1 8689.7 8707.1 8602.3 8672.3 8689.4 8702.3 8729.1 6711.4 6718.2 6731.5 6772.9 6899.2 6876.2 6889.5 6913.2 6921.5 6938.8 7626.4 7697.7 7759.5 7850.1 7954.6 7726.7 7780.5 7781.6 7811.3 7985.0 6620.3 6642.4 6705.1 6709.5 6741.4 7140.4 7201.8 7238.9 7253.5 7257.7 6613.7 6763.2 6774.5 6789.2 6880.2 6848.1 6915.5 6927.1 6953.7 7097.6 6972.5 6993.5 7001.5 7030.2 7031.1 6357.1 6410.2 6443.7 6452.5 6455.5 6430.5 6439.8 6505.1 6538.6 6550.0 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5591.86 Median:6436.57 stddev:1724.53 (26.8%) stddev-sans-first:1683.30 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: Values: 316.7 318.7 320.4 327.2 328.2 6188.0 6324.4 6337.7 6347.3 6444.3 6230.1 6248.4 6293.1 6301.3 6306.1 4634.6 4743.7 4784.4 4785.9 4791.1 4752.2 4763.6 4769.4 4790.5 4803.8 4725.8 4726.3 4727.1 4740.6 4747.2 4741.5 4742.5 4744.7 4748.9 4752.8 3996.7 4115.4 4117.3 4125.2 4134.3 5929.0 5952.4 5964.5 5969.5 5985.3 5464.7 5509.1 5518.1 5520.4 5523.2 6525.5 6578.1 6624.9 6640.4 6646.5 4514.2 4543.4 4552.8 4555.6 4567.1 6907.0 6928.2 6948.5 6979.9 6987.7 4626.6 4629.3 4637.4 4638.1 4638.9 4566.4 4638.6 4665.8 4671.3 4695.0 5447.5 5461.1 5462.3 5468.9 5473.9 6621.7 6669.5 6672.3 6673.6 6704.6 1646.5 1670.6 1671.3 1671.8 1672.0 1059.4 1085.5 1088.5 1089.1 1108.9 6361.7 6475.1 6483.9 6491.0 6500.7 6920.8 6965.7 6989.1 7031.6 7032.3 6532.1 6535.5 6553.1 6554.2 6586.2 3708.8 3749.4 3784.8 3789.1 3799.8 7137.4 7258.0 7260.7 7270.8 7276.6 7095.6 7151.2 7184.3 7205.8 7208.5 7044.3 7214.2 7223.2 7259.7 7277.3 6907.1 6977.5 6982.9 6984.7 6991.3 6867.5 6872.5 6875.1 6897.4 6905.1 7087.7 7183.9 7218.3 7222.2 7259.3 4640.3 4674.9 4675.0 4684.6 4692.1 6973.9 6977.5 6981.9 6988.4 7011.6 6618.2 6766.0 6766.4 6779.6 6785.2 6726.8 6728.8 6745.0 6750.9 6760.5 6428.8 6529.4 6543.4 6553.1 6577.4 6644.2 6791.7 6811.6 6817.2 6823.2 6607.5 6660.6 6681.3 6695.5 6696.5 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: 19:09:20 INFO - 2015-11-18 19:09:20,568 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13491.05 Median:2421.42 stddev:15391.74 (635.7%) stddev-sans-first:15405.29 19:09:20 INFO - 2015-11-18 19:09:20,569 DEBUG : BROWSER_OUTPUT: Values: 773.5 780.6 782.2 822.7 886.2 13088.8 13514.3 13541.7 13554.5 13567.2 12436.6 13210.1 13491.0 13691.4 13730.0 829.8 833.2 836.0 843.4 843.6 822.8 823.4 829.2 831.5 836.3 869.8 873.7 876.9 877.4 879.7 866.4 873.0 874.5 874.5 876.4 632.9 636.8 640.2 640.9 643.2 12505.5 12524.6 12570.2 12579.9 12605.3 11017.7 11035.8 11267.3 11268.8 11314.7 10036.4 10112.1 10190.5 10327.9 10335.5 3524.5 3594.3 3619.6 3672.7 3714.4 40370.4 40602.2 45484.5 45559.8 46741.3 10128.6 10160.0 10190.9 10367.0 10415.5 17970.8 17994.1 18003.0 18020.4 18056.7 7404.3 7486.5 7580.6 7636.0 7663.0 4292.9 4304.1 4352.6 4373.0 4403.2 2974.3 3027.5 3032.4 3038.4 3045.6 439.6 446.8 448.9 457.3 464.4 568.6 635.2 678.0 679.7 718.2 9113.3 9117.4 9181.6 9259.5 9292.3 647.6 658.8 677.4 679.7 685.3 3717.7 3823.4 3824.3 3882.7 3903.1 53181.5 53636.7 53861.0 56024.2 60282.0 44673.6 45273.5 45674.0 47005.0 51318.7 38382.4 43033.4 46666.3 47538.0 49187.0 8700.4 8865.0 8879.3 9031.7 9256.0 37078.7 37170.8 37339.0 37599.8 37722.0 45297.8 46346.5 46475.8 46490.8 46504.5 8653.3 8784.3 8831.8 8873.7 8940.1 11905.7 12024.5 12031.6 12150.8 12301.7 11471.8 11606.8 11639.1 11701.8 12126.8 10989.6 11017.9 11298.7 11381.0 11639.1 10859.5 11240.1 11252.4 11265.4 11685.1 10188.5 10210.7 10229.5 10249.6 10355.5 9225.3 9453.0 9466.2 10092.0 10116.7 19:09:20 INFO - 2015-11-18 19:09:20,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:09:20 INFO - 2015-11-18 19:09:20,570 DEBUG : BROWSER_OUTPUT: 19:09:21 INFO - 2015-11-18 19:09:21,157 INFO : Browser exited with error code: 0 19:09:21 INFO - 2015-11-18 19:09:21,181 INFO : Completed test dromaeo_css (00:18:31) 19:09:21 INFO - 2015-11-18 19:09:21,181 INFO : Starting test kraken 19:09:21 INFO - 2015-11-18 19:09:21,181 DEBUG : operating with platform_type : linux_ 19:09:21 INFO - 2015-11-18 19:09:21,181 INFO : Initialising browser for kraken test... 19:09:21 INFO - 2015-11-18 19:09:21,187 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCvK1PA/profile http://localhost:56397/getInfo.html 19:09:25 INFO - 2015-11-18 19:09:25,699 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:09:25 INFO - 2015-11-18 19:09:25,700 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:09:25 INFO - 2015-11-18 19:09:25,700 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:09:25 INFO - 2015-11-18 19:09:25,700 DEBUG : BROWSER_OUTPUT: __metrics 19:09:26 INFO - 2015-11-18 19:09:26,749 INFO : Browser initialized. 19:09:26 INFO - 2015-11-18 19:09:26,750 INFO : Running cycle 1/1 for kraken test... 19:09:26 INFO - 2015-11-18 19:09:26,750 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCvK1PA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:09:38 INFO - 2015-11-18 19:09:38,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 142016512 19:09:38 INFO - 2015-11-18 19:09:38,552 DEBUG : BROWSER_OUTPUT: 19:09:41 INFO - 2015-11-18 19:09:41,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56397/tests/kraken/driver.html?testName=audio-beat-detection) 19:09:41 INFO - 2015-11-18 19:09:41,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 142970880 19:09:41 INFO - 2015-11-18 19:09:41,643 DEBUG : BROWSER_OUTPUT: 19:09:44 INFO - 2015-11-18 19:09:44,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56397/tests/kraken/driver.html?testName=audio-dft) 19:09:44 INFO - 2015-11-18 19:09:44,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 141864960 19:09:44 INFO - 2015-11-18 19:09:44,881 DEBUG : BROWSER_OUTPUT: 19:09:47 INFO - 2015-11-18 19:09:47,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56397/tests/kraken/driver.html?testName=audio-fft) 19:09:48 INFO - 2015-11-18 19:09:48,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 136384512 19:09:48 INFO - 2015-11-18 19:09:48,308 DEBUG : BROWSER_OUTPUT: 19:09:50 INFO - 2015-11-18 19:09:50,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56397/tests/kraken/driver.html?testName=audio-oscillator) 19:09:50 INFO - 2015-11-18 19:09:50,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 136892416 19:09:50 INFO - 2015-11-18 19:09:50,942 DEBUG : BROWSER_OUTPUT: 19:09:53 INFO - 2015-11-18 19:09:53,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56397/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:09:53 INFO - 2015-11-18 19:09:53,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 138039296 19:09:53 INFO - 2015-11-18 19:09:53,726 DEBUG : BROWSER_OUTPUT: 19:09:56 INFO - 2015-11-18 19:09:56,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56397/tests/kraken/driver.html?testName=imaging-darkroom) 19:09:57 INFO - 2015-11-18 19:09:57,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 19:09:57 INFO - 2015-11-18 19:09:57,341 DEBUG : BROWSER_OUTPUT: 19:10:00 INFO - 2015-11-18 19:10:00,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56397/tests/kraken/driver.html?testName=imaging-desaturate) 19:10:01 INFO - 2015-11-18 19:10:01,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 138645504 19:10:01 INFO - 2015-11-18 19:10:01,362 DEBUG : BROWSER_OUTPUT: 19:10:04 INFO - 2015-11-18 19:10:04,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56397/tests/kraken/driver.html?testName=json-parse-financial) 19:10:04 INFO - 2015-11-18 19:10:04,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 138780672 19:10:04 INFO - 2015-11-18 19:10:04,826 DEBUG : BROWSER_OUTPUT: 19:10:06 INFO - 2015-11-18 19:10:06,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56397/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:10:06 INFO - 2015-11-18 19:10:06,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 19:10:06 INFO - 2015-11-18 19:10:06,996 DEBUG : BROWSER_OUTPUT: 19:10:08 INFO - 2015-11-18 19:10:08,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:09 INFO - 2015-11-18 19:10:09,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 138444800 19:10:09 INFO - 2015-11-18 19:10:09,437 DEBUG : BROWSER_OUTPUT: 19:10:11 INFO - 2015-11-18 19:10:11,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:12 INFO - 2015-11-18 19:10:12,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 140496896 19:10:12 INFO - 2015-11-18 19:10:12,128 DEBUG : BROWSER_OUTPUT: 19:10:14 INFO - 2015-11-18 19:10:14,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:15 INFO - 2015-11-18 19:10:15,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 139702272 19:10:15 INFO - 2015-11-18 19:10:15,178 DEBUG : BROWSER_OUTPUT: 19:10:17 INFO - 2015-11-18 19:10:17,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:18 INFO - 2015-11-18 19:10:18,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 140505088 19:10:18 INFO - 2015-11-18 19:10:18,320 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56397/tests/kraken/driver.html?testName=ai-astar) 19:10:20 INFO - 2015-11-18 19:10:20,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 140718080 19:10:20 INFO - 2015-11-18 19:10:20,288 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,291 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:10:20 INFO - 2015-11-18 19:10:20,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;106;113;112;113;125;111;112;112;113 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;126;150;173;127;155;152;132;161;132 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;164;164;162;162;163;164;167;161 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;161;72;72;72;73;152;72 19:10:20 INFO - 2015-11-18 19:10:20,292 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;140;90;90;91;141;91;92;137 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;110;111;110;109;109;109 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;149;146;147;146;147;146;146 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;98;96;96;97;96;97;96;96 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;62;61;61;63;62;62;71;63;61 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;70;69;69;70;70;69;69 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;94;93;86;84;87;86;86;96 19:10:20 INFO - 2015-11-18 19:10:20,293 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;116;121;120;121;124;124;118;119;119 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;144;153;151;152;149;149;150;141;142 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;72;70;75;71;68;70;68;69 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: __startTimestamp1447902620289__endTimestamp 19:10:20 INFO - 2015-11-18 19:10:20,294 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:4.71 (4.2%) stddev-sans-first:5.00 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 113.0 112.0 113.0 125.0 111.0 112.0 112.0 113.0 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.00 Median:152.00 stddev:15.90 (10.5%) stddev-sans-first:16.72 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: Values: 152.0 126.0 150.0 173.0 127.0 155.0 152.0 132.0 161.0 132.0 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:164.00 stddev:1.70 (1.0%) stddev-sans-first:1.79 19:10:20 INFO - 2015-11-18 19:10:20,298 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 164.0 164.0 162.0 162.0 163.0 164.0 167.0 161.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.90 Median:72.00 stddev:35.69 (49.6%) stddev-sans-first:37.33 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 161.0 72.0 72.0 72.0 73.0 152.0 72.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:91.00 stddev:23.44 (25.8%) stddev-sans-first:24.28 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 140.0 90.0 90.0 91.0 141.0 91.0 92.0 137.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 110.0 111.0 110.0 109.0 109.0 109.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 149.0 146.0 147.0 146.0 147.0 146.0 146.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 98.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 19:10:20 INFO - 2015-11-18 19:10:20,299 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.80 Median:62.00 stddev:2.97 (4.8%) stddev-sans-first:3.14 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 61.0 61.0 63.0 62.0 62.0 71.0 63.0 61.0 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 69.0 69.0 70.0 70.0 69.0 69.0 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.50 stddev:4.46 (5.2%) stddev-sans-first:4.48 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 94.0 93.0 86.0 84.0 87.0 86.0 86.0 96.0 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:121.00 stddev:2.64 (2.2%) stddev-sans-first:2.64 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: Values: 123.0 116.0 121.0 120.0 121.0 124.0 124.0 118.0 119.0 119.0 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:149.50 stddev:4.45 (3.0%) stddev-sans-first:4.43 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: Values: 143.0 144.0 153.0 151.0 152.0 149.0 149.0 150.0 141.0 142.0 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: 19:10:20 INFO - 2015-11-18 19:10:20,300 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.06 (2.9%) stddev-sans-first:2.18 19:10:20 INFO - 2015-11-18 19:10:20,301 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 72.0 70.0 75.0 71.0 68.0 70.0 68.0 69.0 19:10:20 INFO - 2015-11-18 19:10:20,301 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:10:20 INFO - 2015-11-18 19:10:20,301 DEBUG : BROWSER_OUTPUT: 19:10:21 INFO - 2015-11-18 19:10:21,137 INFO : Browser exited with error code: 0 19:10:21 INFO - 2015-11-18 19:10:21,188 INFO : Completed test kraken (00:01:00) 19:10:21 INFO - 2015-11-18 19:10:21,188 INFO : Starting test v8_7 19:10:21 INFO - 2015-11-18 19:10:21,188 DEBUG : operating with platform_type : linux_ 19:10:21 INFO - 2015-11-18 19:10:21,188 INFO : Initialising browser for v8_7 test... 19:10:21 INFO - 2015-11-18 19:10:21,194 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSDALni/profile http://localhost:56397/getInfo.html 19:10:25 INFO - 2015-11-18 19:10:25,563 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:10:25 INFO - 2015-11-18 19:10:25,563 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:10:25 INFO - 2015-11-18 19:10:25,563 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:10:25 INFO - 2015-11-18 19:10:25,563 DEBUG : BROWSER_OUTPUT: __metrics 19:10:26 INFO - 2015-11-18 19:10:26,653 INFO : Browser initialized. 19:10:26 INFO - 2015-11-18 19:10:26,654 INFO : Running cycle 1/1 for v8_7 test... 19:10:26 INFO - 2015-11-18 19:10:26,654 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSDALni/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:10:38 INFO - 2015-11-18 19:10:38,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 19:10:38 INFO - 2015-11-18 19:10:38,455 DEBUG : BROWSER_OUTPUT: 19:10:59 INFO - 2015-11-18 19:10:59,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56397/tests/v8_7/run.html (next: http://localhost:56397/tests/v8_7/run.html) 19:11:00 INFO - 2015-11-18 19:11:00,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 137596928 19:11:00 INFO - 2015-11-18 19:11:00,120 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,120 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:11:00 INFO - 2015-11-18 19:11:00,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:11:00 INFO - 2015-11-18 19:11:00,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:11:00 INFO - 2015-11-18 19:11:00,121 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:11:00 INFO - 2015-11-18 19:11:00,121 DEBUG : BROWSER_OUTPUT: |0;Richards;162.60162601626016 19:11:00 INFO - 2015-11-18 19:11:00,121 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.14675446848543 19:11:00 INFO - 2015-11-18 19:11:00,121 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 19:11:00 INFO - 2015-11-18 19:11:00,121 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |5;Earley;738.0073800738007 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |8;Splay;699.4535519125683 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 19:11:00 INFO - 2015-11-18 19:11:00,122 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: __startTimestamp1447902660116__endTimestamp 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.60 Median:162.60 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: Values: 162.6 19:11:00 INFO - 2015-11-18 19:11:00,123 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: Values: 188.1 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: Values: 281.4 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,124 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: Values: 5055.6 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: Values: 1068.4 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:738.01 Median:738.01 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: Values: 738.0 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: Values: 11964.3 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,125 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: Values: 25425.0 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:699.45 Median:699.45 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: Values: 699.5 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: Values: 4840.6 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:11:00 INFO - 2015-11-18 19:11:00,126 DEBUG : BROWSER_OUTPUT: 19:11:01 INFO - 2015-11-18 19:11:01,077 INFO : Browser exited with error code: 0 19:11:01 INFO - 2015-11-18 19:11:01,096 INFO : Completed test v8_7 (00:00:39) 19:11:01 INFO - 2015-11-18 19:11:01,132 INFO : Completed test suite (00:20:10) 19:11:01 INFO - 2015-11-18 19:11:01,132 DEBUG : Working with test: dromaeo_css 19:11:01 INFO - 2015-11-18 19:11:01,132 DEBUG : Generating results file: dromaeo_css 19:11:01 INFO - 2015-11-18 19:11:01,133 DEBUG : Working with test: kraken 19:11:01 INFO - 2015-11-18 19:11:01,133 DEBUG : Generating results file: kraken 19:11:01 INFO - 2015-11-18 19:11:01,134 INFO : javascript benchmark 19:11:01 INFO - 2015-11-18 19:11:01,134 DEBUG : Working with test: v8_7 19:11:01 INFO - 2015-11-18 19:11:01,134 DEBUG : Generating results file: v8_7 19:11:01 INFO - 2015-11-18 19:11:01,134 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:11:01 INFO - 2015-11-18 19:11:01,193 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 19:11:01 INFO - 2015-11-18 19:11:01,193 DEBUG : process_Request line: dromaeo_css 6739.27 graph.html#tests=[[72,64,43]] 19:11:01 INFO - 2015-11-18 19:11:01,193 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:11:01 INFO - 2015-11-18 19:11:01,317 DEBUG : process_Request line: kraken 1527.80 graph.html#tests=[[232,64,43]] 19:11:01 INFO - 2015-11-18 19:11:01,317 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:11:01 INFO - 2015-11-18 19:11:01,418 DEBUG : process_Request line: v8_7 21116.90 graph.html#tests=[[230,64,43]] 19:11:01 INFO - 2015-11-18 19:11:01,419 INFO : javascript benchmark 19:11:01 INFO - 2015-11-18 19:11:01,422 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.983980080099, 3261.217307846116, 3278.8196649184283, 3305.0, 3310.8344582770856, 5221.425643179247, 5352.464753524646, 5375.0, 5418.160185171299, 5438.075527160382, 5318.46815318468, 5333.38666053404, 5339.41266460689, 5356.276902618145, 5366.087765079936, 4924.729139897304, 4971.45314015458, 5003.774830132635, 5004.949950500485, 5010.824621138243, 4878.1219380511675, 4939.456659767423, 4941.975290123544, 4951.405831300249, 4983.975080124595, 4731.881702957437, 4839.758012099381, 4951.405831300249, 4954.232094025432, 4970.701757894538, 4973.229149481836, 4974.079795237856, 4980.9252861207115, 4985.551300382983, 5019.548240658358, 4769.499202583714, 4941.110600092018, 4956.1822299320565, 4972.87567810804, 5000.849974500771, 5143.485651434864, 5159.845204643829, 5208.739563021872, 5211.218317252443, 5246.580273578104, 5732.140178973145, 5772.913406298909, 5787.50806181475, 5797.594168408213, 5807.0, 5746.42535746422, 5825.912611310834, 5829.242198514166, 5835.824925252249, 5842.444967728059, 5332.893342133136, 5378.058839703036, 5378.220158077057, 5381.892362152735, 5385.488378604026, 5922.792702255487, 5971.19388882504, 5972.731227094791, 5976.193213916153, 6027.45752882234, 5783.8554036149435, 5787.797427090031, 5793.102069179284, 5796.188533605298, 5801.390853960358, 5609.551235901118, 5764.942350576524, 5775.768969241183, 5801.01382764931, 5853.946289667815, 5692.0323544997445, 5699.458551437607, 5701.515371193412, 5705.058665320175, 5853.619514731528, 5765.0, 5799.652020878761, 5824.446677565625, 5830.708464576839, 5831.970840145772, 4495.955040449619, 4512.323151527232, 4522.660800439914, 4525.479569849509, 4552.2488789350045, 3821.7324787264624, 3912.550056743454, 3951.249262640089, 4011.438398624195, 4012.117334186474, 5479.232907392969, 5494.718143882784, 5507.284053073155, 5513.393526712059, 5552.7778888843995, 5551.084071128219, 5773.047447171254, 5775.768969241268, 5787.102999035156, 5798.0, 5400.297961265089, 5458.181272809111, 5509.063459211943, 5535.280413546213, 5577.1355439906065, 5040.747962601855, 5059.645824792229, 5074.4671809460215, 5096.05722941257, 5119.078565858107, 5828.6502809831545, 5951.613145145465, 6071.969640151771, 6079.878402431927, 6094.542909281821, 5667.716614169192, 5808.36108028125, 5810.796622118206, 5833.154192641959, 5838.211841401357, 6035.245594300713, 6060.636361818305, 6070.848228794315, 6077.0, 6083.361247068994, 5458.890822183614, 5511.118221084607, 5614.04561224601, 5772.913406298825, 5805.042168042226, 5849.795257165979, 5874.353821079763, 5885.440883116097, 5900.7049647518315, 5901.409859014064, 5705.372409035086, 5739.139129130664, 5749.741261643152, 5766.769329226784, 5775.9133612995, 5480.671159730429, 5566.52684521804, 5598.356189038313, 5734.856628584152, 5737.799177028784, 5559.471850174227, 5582.8325150245555, 5600.131979543177, 5600.299962504687, 5618.2415373924, 5614.5789065821045, 5689.886202276014, 5707.6290041147195, 5748.195252664546, 5751.252337196138, 5269.868253293698, 5429.077056900257, 5461.863453413696, 5518.91721624184, 5565.30433695788], "unit": "ms", "name": "dojo.html", "value": 5346.863962292405}, {"lowerIsBetter": false, "replicates": [573.23759399998, 579.0590290777486, 582.4408567774935, 615.5783288447413, 620.9906851397227, 39699.0, 40254.39618405726, 40581.0, 40682.18635627289, 40773.18453630926, 42650.0, 43182.56817431825, 43215.78392108043, 43218.351724724074, 43252.567474325326, 8691.26124279437, 8768.298536117127, 8813.515256660881, 8840.734777956672, 8854.690085846996, 8538.018127915277, 8669.869951950726, 8683.261922736576, 8685.609147588373, 8698.739037828875, 8712.085231050743, 8798.384113112084, 8842.159994800484, 8845.380823342368, 8846.292296616255, 8711.651533938635, 8738.257248133885, 8794.868076978786, 8802.427842190236, 8818.735437936872, 8612.1387861214, 8686.261667758248, 8759.781005474913, 8766.780830479225, 8771.73684789451, 39708.80145599283, 40166.196676066604, 40172.0, 40469.797651011555, 40524.0, 3339.7996120232865, 3490.616032236477, 3689.6494832991093, 3888.8250028748776, 3998.2403343364667, 29671.25821854449, 29901.850490747405, 30120.397592048037, 30311.24221894448, 31231.219219519466, 3556.1287484566187, 3628.2924829658227, 3630.5280313559333, 3714.461403096536, 3735.34631439497, 271536.0, 271793.0, 272309.63845180644, 272456.0, 272496.0, 57680.0, 57825.421745782005, 57888.710556446946, 57898.71050644804, 58128.418715813146, 60964.695176523834, 61450.0, 65904.0, 66718.66640666766, 66813.66593167002, 16238.106904120386, 16273.349066037226, 16325.510234692978, 16387.098709571088, 16412.589685257724, 12352.25886446816, 12356.073294502949, 12386.0, 12397.93801030989, 12428.937855310665, 20832.1667133316, 20906.686399704016, 20986.89506552488, 21022.894885525475, 21245.150193992376, 7963.402744794048, 8367.748967530984, 8372.120927302667, 8382.79043023917, 8422.494650321001, 952.2429668413489, 964.9565769540247, 978.1294647763497, 979.5640939781871, 1015.9535678251412, 28829.56755648667, 29395.7060429393, 29409.55885661717, 29546.261343466154, 29644.407111857643, 1017.6539976408056, 1019.5819713917258, 1021.2187676427391, 1022.7392015036119, 1057.370864335719, 14681.706365872837, 15168.696626067416, 17120.74318885218, 17275.222614982355, 17474.213660385314, 390544.0, 393631.0, 394524.0, 395597.0, 396208.0568791471, 56009.71995139998, 56206.156907646415, 56221.0, 56248.43751562514, 56398.436015639316, 1334.1061488802331, 1353.6074538383955, 1363.1412210307642, 1372.3001269352503, 1391.3460673483648, 29396.85301573564, 30399.08802735833, 32597.18507037343, 33157.50263746094, 33292.66707332896, 49839.75080124721, 49882.75058624684, 50400.49599504105, 50518.74740626421, 50564.74717626388, 285937.0, 286864.0, 286916.0, 287001.0, 289265.0, 43108.0, 46486.58377454137, 47016.7649161752, 47464.52535474601, 47698.76150619225, 44905.32642010307, 44957.0, 45088.0, 45106.54893451023, 45159.0, 37454.25091498209, 37490.81254593709, 37944.620553794106, 38190.82429544424, 39069.218615628095, 38078.619213807506, 38418.231635367694, 38651.22697546089, 38799.80600096982, 38895.027624309616, 36024.27951441009, 37360.25279494341, 37436.43845342268, 37502.43746343862, 37783.433248501846, 31769.841150795022, 34567.308653827284, 34751.65248347585, 34801.0, 35012.64987350094, 26234.0, 26256.911021836477, 26289.605655914795, 26366.0, 26431.471370572865], "unit": "ms", "name": "ext.html", "value": 19360.67009278345}, {"lowerIsBetter": false, "replicates": [340.18865006958396, 340.9130671678722, 343.239724011315, 347.99130021749454, 349.3397478765133, 11532.423378831067, 11844.466998985044, 16455.83544164558, 17133.742993855085, 18945.33691320804, 10928.180386471007, 11068.723281917955, 11090.33457992521, 11112.944435277832, 11182.944085279561, 4388.890277743058, 4510.25580779171, 4515.029268707227, 4517.728936263835, 4523.977380113111, 4406.581374769407, 4488.910221795579, 4489.977550112261, 4503.1218912312115, 4521.502634710196, 4452.10957808438, 4453.599176074153, 4458.175237581057, 4594.977025114869, 4704.529547045302, 4698.624110071186, 4704.247320428732, 4709.740964246965, 4718.150732868083, 4745.881352966187, 4012.7191096623246, 4080.6735461163034, 4108.36320370343, 4115.691323150746, 4128.0, 12568.05739569536, 12588.307643079626, 12612.558560450432, 12824.166429182073, 13168.078234523588, 1869.9158537865828, 1919.6256729937668, 1981.128303546435, 1981.5541503161817, 2035.0130186859362, 9642.373245739005, 9847.507624618813, 9873.259505537113, 9911.40531568101, 10021.649242276486, 1650.075957463812, 1655.1393275496675, 1657.1962598139892, 1680.2522877319598, 1725.6462425202803, 58445.41554584485, 59204.70397647984, 60458.69770651162, 61174.694126529525, 61777.382226177615, 6456.838579035561, 6708.865822683519, 6754.797356079325, 6776.390124888783, 6799.966000169968, 8048.0, 8076.353891688651, 8088.555129467935, 8090.0, 8091.150429204967, 5483.75323110453, 5542.168674698747, 5550.361708403585, 5557.944420555743, 5606.915896261559, 5660.575456840671, 5676.716164191774, 5700.971495142498, 5710.857228569319, 5718.342390625048, 3122.9219269518444, 3132.98433507831, 3150.763692723055, 3161.731252843488, 3176.8093914365213, 1102.2229328323513, 1109.4452773613193, 1111.5442668506034, 1130.0846314485293, 1159.4029075026367, 456.7168355619537, 477.98566043018764, 484.3799936081821, 496.13672210354446, 506.4808571214461, 11168.609098681507, 11184.27302225369, 11467.197296189186, 11640.417979101012, 11859.703507412383, 484.9733264670477, 493.73091665042637, 507.8501841956558, 513.5634710496048, 527.411935691701, 6044.697765111727, 6171.814845554641, 6177.938220617826, 6199.380061993855, 6539.411452969161, 491933.0, 505626.0, 508112.0, 508132.0, 508526.0, 72734.0, 72870.99999999894, 73908.2609173912, 75025.62487187529, 76636.0, 551.8565173054955, 559.4070285497386, 559.4098226371136, 559.9832005039856, 563.2424389196524, 10450.686479405325, 10899.727506812393, 11183.105351571692, 11270.549178033114, 11341.092712583139, 32005.0, 32179.03462896117, 32200.35599288048, 32637.836810816745, 32686.83656581702, 41796.79101604594, 45202.0, 45924.770376147906, 46924.530754693384, 47030.529694702615, 6877.58734475913, 6983.755568555076, 6997.055397521473, 7034.929650703428, 7060.258672839278, 12310.26138431697, 12319.099163395626, 12632.494700212255, 12633.557825476064, 12639.557615483414, 9872.308938374244, 10048.748781280527, 10217.23370747182, 10389.909059548638, 10890.836637450602, 10205.132563732166, 10253.487325633838, 10313.1233845124, 10366.378017318984, 10588.629397971034, 10126.39241645474, 10140.340877842917, 10177.847332289874, 10815.56737730482, 10927.0, 6487.091807146909, 6557.147570815763, 6619.66901654925, 6636.502262330248, 6660.0, 10360.481975901024, 10404.167666586503, 10457.68626941193, 10462.267641265344, 10640.201984851323], "unit": "ms", "name": "jquery.html", "value": 6720.266643422066}, {"lowerIsBetter": false, "replicates": [1417.2488581052044, 1482.36999275308, 1598.0571462836924, 1605.0851014921484, 1779.5995900922287, 6075.362086980869, 6217.0, 6240.219972503437, 7206.423486121111, 7637.694492220305, 7756.495827771191, 7776.766696999085, 7844.137144914069, 7886.093099293583, 7920.92079079209, 2127.4468638154112, 2176.662617294314, 2179.0, 2180.5529866377433, 2183.410479170623, 2232.0513781642817, 2245.461089338555, 2258.695076164713, 2266.829987750917, 2267.0931627349028, 2187.890605469728, 2212.3473575295247, 2228.1644383356243, 2241.8654880707127, 2250.2799104286637, 2087.926922557703, 2148.699182114505, 2177.314146043991, 2188.3434969509085, 2189.9452513687124, 2253.988730056339, 2274.4541310085624, 2280.85174463661, 2284.9657255141187, 2286.4855407533337, 7289.599072051035, 7382.7046918123215, 7392.482526223166, 7401.592912389817, 7410.481266311361, 4293.4203882476095, 4357.106793107406, 4368.0, 4368.47578290604, 4387.210302145612, 2797.37059161689, 2902.3904979954236, 2924.020453148177, 2924.3712601790717, 2934.4131173765118, 964.6961207219773, 988.0465350936381, 997.581015973293, 997.880254369473, 1061.1510791366952, 10027.348222365596, 10056.396616203052, 10146.746331341701, 10168.847467287997, 10172.847407288897, 3944.546377166605, 3992.201559688074, 3995.0, 4019.7588144710826, 4030.6775457963295, 8249.958750206211, 8271.875921861178, 8323.0, 8333.749987500385, 8346.165383461726, 4485.730856148642, 4493.078918821634, 4508.0, 4509.842155524607, 4514.435695538058, 4089.3865920111625, 4106.486689163855, 4115.0, 4118.876433706993, 4126.381042843537, 3381.7970921744773, 3382.30662714143, 3382.3235352929514, 3390.355832391838, 3401.3027329397414, 1012.1143999000874, 1024.349538043333, 1025.0569476082023, 1028.2545154762886, 1036.2797855490362, 1053.6628278950661, 1072.0726571515584, 1084.0081325587157, 1246.2335663566842, 1383.3290853935832, 7069.08101946754, 7153.964230178815, 7160.964195178991, 7221.42228621709, 7235.8552828944175, 1148.8047032004579, 1153.1005815463952, 1161.3148242536943, 1169.7134202120535, 1171.37916904041, 5489.2589500417735, 5499.395066542677, 5523.751431185526, 5535.833924982257, 5553.194786755897, 8516.06323304436, 8569.400141990125, 8680.131986801396, 8689.652413903374, 8707.129287071242, 8602.268807151337, 8672.262857657044, 8689.391742578086, 8702.34732395073, 8729.083446238054, 6711.395974362234, 6718.160229971254, 6731.49513786468, 6772.8984065239065, 6899.17209934811, 6876.17485901675, 6889.517733758589, 6913.2049814272, 6921.515493915579, 6938.757143499954, 7626.42436880916, 7697.692092316244, 7759.534427934342, 7850.0972388173805, 7954.602269886367, 7726.729564465217, 7780.49426787257, 7781.610919454118, 7811.336036436966, 7985.0, 6620.271770105188, 6642.4021838034805, 6705.094812200486, 6709.496787740842, 6741.393274605309, 7140.428765698628, 7201.819954501179, 7238.927610723826, 7253.455990800606, 7257.673404696907, 6613.6693165340575, 6763.2222294434805, 6774.525783195129, 6789.15135608049, 6880.208775990625, 6848.14398200225, 6915.481338899502, 6927.099477067949, 6953.721851125898, 7097.645117744195, 6972.477064220305, 6993.4754893384215, 7001.474889383215, 7030.156381234285, 7031.05080814104, 6357.110004599267, 6410.1987251593555, 6443.742250309935, 6452.483801295979, 6455.548111632141, 6430.48556115519, 6439.839004024937, 6505.0567667688865, 6538.574992625464, 6549.96725016391], "unit": "ms", "name": "mootools.html", "value": 4306.291200549138}, {"lowerIsBetter": false, "replicates": [316.67382595926205, 318.69086985623943, 320.40085040973383, 327.1771494690851, 328.1599106287902, 6187.969060154698, 6324.399182077706, 6337.683115844206, 6347.301796802354, 6444.291127975919, 6230.065490176476, 6248.4064013918605, 6293.056041593763, 6301.338359472258, 6306.1171435998995, 4634.58288754012, 4743.691660042086, 4784.354112194861, 4785.928211076819, 4791.113643975876, 4752.1683705351425, 4763.618910487153, 4769.403824521934, 4790.473047964739, 4803.831865884695, 4725.826119984811, 4726.314684370765, 4727.1254817858635, 4740.573348398643, 4747.192977193886, 4741.454732705749, 4742.454617718938, 4744.691595046328, 4748.881277968044, 4752.76236188191, 3996.7002474814212, 4115.444415003996, 4117.3206420940505, 4125.23683118624, 4134.276501612206, 5929.0, 5952.3631001474505, 5964.522838172936, 5969.462748352626, 5985.281766188042, 5464.672119672832, 5509.146082357241, 5518.144687573433, 5520.420355862657, 5523.199136125279, 6525.543211975164, 6578.079068930354, 6624.906890363084, 6640.435562977153, 6646.534742568022, 4514.210013247669, 4543.409356783597, 4552.8146489684805, 4555.589996900295, 4567.086582683477, 6906.965465172642, 6928.237893831674, 6948.513604047719, 6979.89530157048, 6987.685554150075, 4626.583607475343, 4629.259318509023, 4637.420322459692, 4638.0955713636195, 4638.930416043762, 4566.383538222364, 4638.5593368629925, 4665.766711664403, 4671.252599584118, 4694.976525117352, 5447.4824891635235, 5461.098918678453, 5462.317210348707, 5468.945310546844, 5473.863153421196, 6621.702023408958, 6669.533132680763, 6672.266050734415, 6673.599584024877, 6704.631245281556, 1646.5471995201415, 1670.62410957536, 1671.264643556831, 1671.816100228974, 1671.9665606687797, 1059.433203236265, 1085.4898197846999, 1088.4992903264429, 1089.1341383600056, 1108.933463992163, 6361.745530178741, 6475.093486911836, 6483.870322593521, 6490.993895946041, 6500.70746816385, 6920.757773477904, 6965.651717414109, 6989.126359205099, 7031.613261270577, 7032.296770322927, 6532.118164047793, 6535.542512024208, 6553.115329430561, 6554.246261679872, 6586.209654841449, 3708.7774733516076, 3749.418840079792, 3784.848606055782, 3789.090618251655, 3799.848006079781, 7137.393321567725, 7258.02016727735, 7260.67326970277, 7270.818229544304, 7276.63616819157, 7095.609741464269, 7151.177614574391, 7184.317489838457, 7205.819854503679, 7208.495405321577, 7044.295570442915, 7214.206437291894, 7223.205447400782, 7259.745908893164, 7277.3086556777025, 6907.067545881443, 6977.546459480118, 6982.930170698228, 6984.685689143899, 6991.300869912968, 6867.450603951572, 6872.518923675495, 6875.140607424072, 6897.379235868595, 6905.136857892763, 7087.7164913402885, 7183.892241616275, 7218.314260145278, 7222.241664625349, 7259.346658800733, 4640.327152562927, 4674.9247673034715, 4674.9766251169885, 4684.6252299816615, 4692.1084993851055, 6973.895391569232, 6977.546459480118, 6981.930180698128, 6988.37104660583, 7011.614361210182, 6618.205815302002, 6765.9661701691175, 6766.391024807594, 6779.627120508222, 6785.218060595133, 6726.7981960541265, 6728.798136055926, 6744.966275168593, 6750.932490675031, 6760.526763126534, 6428.839279018062, 6529.412352888263, 6543.378379053982, 6553.082568440517, 6577.440917522064, 6644.169478815148, 6791.72833086671, 6811.591304521745, 6817.181938167451, 6823.1812182538415, 6607.504437167136, 6660.56706314088, 6681.2984636612455, 6695.531312808057, 6696.464282857262], "unit": "ms", "name": "prototype.html", "value": 5016.748159434879}, {"lowerIsBetter": false, "replicates": [773.4779024158694, 780.5940910726418, 782.2334112569681, 822.6544851162511, 886.2024178239584, 13088.803667944976, 13514.32428378582, 13541.729165416698, 13554.525591604295, 13567.185968841877, 12436.626901192978, 13210.075294729373, 13491.0, 13691.383887725051, 13730.0, 829.784256093414, 833.1834801894147, 836.0385556609887, 843.359047124187, 843.6498852976008, 822.8189798244376, 823.4071468542639, 829.1956801902145, 831.5177197225595, 836.3100442135233, 869.8086420987404, 873.6505397840883, 876.9166929141753, 877.4340550345023, 879.6965047058786, 866.3718803867209, 873.0265753684596, 874.4665753890122, 874.510274246424, 876.3733930239878, 632.8639342541329, 636.8153235561682, 640.1709785827318, 640.8942524483455, 643.2217017408941, 12505.49978000879, 12524.624261272176, 12570.182938108994, 12579.937100314532, 12605.30670813105, 11017.669469915916, 11035.779284414266, 11267.323960562393, 11268.774624507547, 11314.717132071682, 10036.447995360253, 10112.089911907964, 10190.541425635864, 10327.948360258151, 10335.534900929477, 3524.541809564766, 3594.291711640929, 3619.565652121736, 3672.6510981456986, 3714.4242642390473, 40370.394444083366, 40602.18795624071, 45484.54515454836, 45559.77220113878, 46741.29888051648, 10128.59485620567, 10160.0, 10190.949045254727, 10367.0, 10415.531301091469, 17970.820291797176, 17994.10029498546, 18003.0, 18020.36928707489, 18056.729149062776, 7404.296591823768, 7486.513376630502, 7580.620968951531, 7635.961820190863, 7662.961685191538, 4292.892677683083, 4304.117655880599, 4352.608265256142, 4372.978135109368, 4403.229434848889, 2974.301039255773, 3027.5458681197997, 3032.3935212957053, 3038.4075105354245, 3045.558394032853, 439.604356079531, 446.83690452985076, 448.9079738653634, 457.320878495434, 464.39396587453024, 568.647438588078, 635.1774452084469, 677.9830504237434, 679.6669631880343, 718.1956209045902, 9113.270938324918, 9117.36178467501, 9181.58682859273, 9259.490728010023, 9292.303077269233, 647.5661306924372, 658.7529676371361, 677.386179344168, 679.6635665345685, 685.3215316836296, 3717.665410113103, 3823.3500304948225, 3824.2733880562605, 3882.7476214045996, 3903.1413089120347, 53181.46818531765, 53636.73181634067, 53861.0, 56024.159637605466, 60282.0, 44673.55326446694, 45273.54726452693, 45674.0, 47005.0, 51318.74340628273, 38382.424263636065, 43033.35449968253, 46666.300005499266, 47538.0, 49187.0, 8700.434471759316, 8865.0, 8879.289656827568, 9031.683891063782, 9255.953720231355, 37078.73594536663, 37170.8141459291, 37339.0, 37599.81200093982, 37722.0, 45297.77351113223, 46346.53653463422, 46475.76762116168, 46490.76754616205, 46504.53495465002, 8653.307735381028, 8784.253338466302, 8831.779205519913, 8873.689420870238, 8940.061293564082, 11905.702357441134, 12024.519019239133, 12031.639050828138, 12150.756984860076, 12301.692457688629, 11471.827922581, 11606.767864642828, 11639.068874490189, 11701.824472632747, 12126.818097728717, 10989.560417583207, 11017.889821101686, 11298.717532061764, 11381.0, 11639.127065470293, 10859.457027148454, 11240.109737187297, 11252.437378131224, 11265.436728163722, 11685.123615728684, 10188.490575471345, 10210.693679189637, 10229.539670714687, 10249.590016399261, 10355.534000969823, 9225.308101892251, 9452.952735236555, 9466.2427005838, 10092.0, 10116.747081323027], "unit": "ms", "name": "yui.html", "value": 6233.124966333053}], "name": "dromaeo_css", "value": 6739.267742812194}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 113.0, 112.0, 113.0, 125.0, 111.0, 112.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [152.0, 126.0, 150.0, 173.0, 127.0, 155.0, 152.0, 132.0, 161.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 164.0, 164.0, 162.0, 162.0, 163.0, 164.0, 167.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 161.0, 72.0, 72.0, 72.0, 73.0, 152.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 140.0, 90.0, 90.0, 91.0, 141.0, 91.0, 92.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 149.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 62.0, 71.0, 63.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 94.0, 93.0, 86.0, 84.0, 87.0, 86.0, 86.0, 96.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [123.0, 116.0, 121.0, 120.0, 121.0, 124.0, 124.0, 118.0, 119.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.5}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 153.0, 151.0, 152.0, 149.0, 149.0, 150.0, 141.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 70.0, 75.0, 71.0, 68.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1527.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.60162601626016], "unit": "score", "name": "Richards", "value": 217.10729999999992}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5055.555555555556], "unit": "score", "name": "Decrypt", "value": 52.65118681318681}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [738.0073800738007], "unit": "score", "name": "Earley", "value": 903.057365}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [699.4535519125683], "unit": "score", "name": "Splay", "value": 116.50666406249996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21116.896173747962}]} 19:11:01 INFO - RETURN: dromaeo_css: 6739.27 19:11:01 INFO - RETURN: kraken: 1527.80 19:11:01 INFO - RETURN: v8_7: 21116.90 19:11:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21116.90"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6739.27"}}} 19:11:01 INFO - Return code: 0 19:11:01 INFO - # TBPL SUCCESS # 19:11:01 INFO - Running post-action listener: _resource_record_post_action 19:11:01 INFO - Running post-run listener: _resource_record_post_run 19:11:02 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518828032; Read time: 12; Write time: 581776 19:11:02 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232017920; Read time: 0; Write time: 368408 19:11:02 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286810112; Read time: 12; Write time: 213368 19:11:02 INFO - Running post-run listener: _upload_blobber_files 19:11:02 INFO - Blob upload gear active. 19:11:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:11:02 INFO - Copying logs to upload dir... 19:11:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1257.949478 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-18 19:11:02.198685) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 19:11:02.206845) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009947 build_url: 'https://queue.taskcluster.net/v1/task/2lF4XA16R0aOTrI_Fna2_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 19:11:02.271264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 19:11:02.272034) ========= 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=c402a24d74c70935940d60dd000001de-1447900856.534738-891863675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004631 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 19:11:02.333339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 19:11:02.337116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 19:11:02.337804) ========= ========= Total master_lag: 0.30 =========