builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1447480205.43 results: success (0) buildid: 20151113193129 builduid: c78af9f0931841c59abfbc52b6779d75 revision: 202b199b9fcf37a687bef882f2513e191f079622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.426493) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.427087) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.427452) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007625 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.451326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.451693) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.470813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.471192) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004710 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.520674) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.521044) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.521468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.521839) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 21:50:06-- 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% 46.5M=0s 2015-11-13 21:50:06 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183763 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.718457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.718831) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017190 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:05.802704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 21:50:05.803351) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 21:50:06,898 truncating revision to first 12 chars 2015-11-13 21:50:06,898 Setting DEBUG logging. 2015-11-13 21:50:06,898 attempt 1/10 2015-11-13 21:50:06,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/202b199b9fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 21:50:07,970 unpacking tar archive at: mozilla-central-202b199b9fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.425912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 21:50:07.243700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:07.244199) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:07.254599) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:07.255007) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 21:50:07.255527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-13 21:50:07.255891) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:50:08 INFO - MultiFileLogger online at 20151113 21:50:08 in /builds/slave/test-pgo 21:50:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:50:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:50:08 INFO - {'append_to_log': False, 21:50:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:50:08 INFO - 'blob_upload_branch': 'Firefox', 21:50:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:50:08 INFO - 'branch': 'Firefox', 21:50:08 INFO - 'buildbot_json_path': 'buildprops.json', 21:50:08 INFO - 'config_files': ('talos/linux_config.py',), 21:50:08 INFO - 'default_actions': ('clobber', 21:50:08 INFO - 'read-buildbot-config', 21:50:08 INFO - 'download-and-extract', 21:50:08 INFO - 'populate-webroot', 21:50:08 INFO - 'create-virtualenv', 21:50:08 INFO - 'install', 21:50:08 INFO - 'run-tests'), 21:50:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:50:08 INFO - 'download_minidump_stackwalk': True, 21:50:08 INFO - 'download_symbols': 'ondemand', 21:50:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:50:08 INFO - 'tooltool.py': '/tools/tooltool.py', 21:50:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:50:08 INFO - '/tools/misc-python/virtualenv.py')}, 21:50:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:50:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:50:08 INFO - 'installer_path': 'installer.exe', 21:50:08 INFO - 'log_level': 'info', 21:50:08 INFO - 'log_name': 'talos', 21:50:08 INFO - 'log_to_console': True, 21:50:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:50:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:50:08 INFO - 'opt_config_files': (), 21:50:08 INFO - 'pip_index': False, 21:50:08 INFO - 'sps_profile': False, 21:50:08 INFO - 'sps_profile_interval': 0, 21:50:08 INFO - 'suite': 'dromaeojs', 21:50:08 INFO - 'system_bits': '64', 21:50:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:50:08 INFO - 'title': 'talos-linux64-ix-060', 21:50:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:50:08 INFO - 'use_talos_json': True, 21:50:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:50:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:50:08 INFO - 'work_dir': 'build'} 21:50:08 INFO - ##### 21:50:08 INFO - ##### Running clobber step. 21:50:08 INFO - ##### 21:50:08 INFO - Running pre-action listener: _resource_record_pre_action 21:50:08 INFO - Running main action method: clobber 21:50:08 INFO - rmtree: /builds/slave/test-pgo/build 21:50:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:50:08 INFO - Running post-action listener: _resource_record_post_action 21:50:08 INFO - ##### 21:50:08 INFO - ##### Running read-buildbot-config step. 21:50:08 INFO - ##### 21:50:08 INFO - Running pre-action listener: _resource_record_pre_action 21:50:08 INFO - Running main action method: read_buildbot_config 21:50:08 INFO - Using buildbot properties: 21:50:08 INFO - { 21:50:08 INFO - "properties": { 21:50:08 INFO - "buildnumber": 261, 21:50:08 INFO - "product": "firefox", 21:50:08 INFO - "script_repo_revision": "production", 21:50:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:50:08 INFO - "repository": "", 21:50:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:50:08 INFO - "buildid": "20151113193129", 21:50:08 INFO - "slavename": "talos-linux64-ix-060", 21:50:08 INFO - "pgo_build": "True", 21:50:08 INFO - "basedir": "/builds/slave/test-pgo", 21:50:08 INFO - "project": "", 21:50:08 INFO - "platform": "ubuntu64_hw", 21:50:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:50:08 INFO - "slavebuilddir": "test", 21:50:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:50:08 INFO - "branch": "mozilla-central", 21:50:08 INFO - "repo_path": "mozilla-central", 21:50:08 INFO - "stage_platform": "linux64-pgo", 21:50:08 INFO - "builduid": "c78af9f0931841c59abfbc52b6779d75", 21:50:08 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 21:50:08 INFO - }, 21:50:08 INFO - "sourcestamp": { 21:50:08 INFO - "repository": "", 21:50:08 INFO - "hasPatch": false, 21:50:08 INFO - "project": "", 21:50:08 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:50:08 INFO - "changes": [ 21:50:08 INFO - { 21:50:08 INFO - "category": null, 21:50:08 INFO - "files": [ 21:50:08 INFO - { 21:50:08 INFO - "url": null, 21:50:08 INFO - "name": "https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 21:50:08 INFO - } 21:50:08 INFO - ], 21:50:08 INFO - "repository": "", 21:50:08 INFO - "rev": "202b199b9fcf37a687bef882f2513e191f079622", 21:50:08 INFO - "who": "sendchange", 21:50:08 INFO - "when": 1447480136, 21:50:08 INFO - "number": 6661665, 21:50:08 INFO - "comments": "", 21:50:08 INFO - "project": "", 21:50:08 INFO - "at": "Fri 13 Nov 2015 21:48:56", 21:50:08 INFO - "branch": "mozilla-central-linux64-pgo-talos", 21:50:08 INFO - "revlink": "", 21:50:08 INFO - "properties": [ 21:50:08 INFO - [ 21:50:08 INFO - "buildid", 21:50:08 INFO - "20151113193129", 21:50:08 INFO - "Change" 21:50:08 INFO - ], 21:50:08 INFO - [ 21:50:08 INFO - "builduid", 21:50:08 INFO - "c78af9f0931841c59abfbc52b6779d75", 21:50:08 INFO - "Change" 21:50:08 INFO - ], 21:50:08 INFO - [ 21:50:08 INFO - "pgo_build", 21:50:08 INFO - "True", 21:50:08 INFO - "Change" 21:50:08 INFO - ] 21:50:08 INFO - ], 21:50:08 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 21:50:08 INFO - } 21:50:08 INFO - ], 21:50:08 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 21:50:08 INFO - } 21:50:08 INFO - } 21:50:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 21:50:08 INFO - Running post-action listener: _resource_record_post_action 21:50:08 INFO - ##### 21:50:08 INFO - ##### Running download-and-extract step. 21:50:08 INFO - ##### 21:50:08 INFO - Running pre-action listener: _resource_record_pre_action 21:50:08 INFO - Running main action method: download_and_extract 21:50:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:50:08 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')]} 21:50:08 INFO - https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/test_packages.json 21:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/test_packages.json 21:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:50:11 INFO - Downloaded 1302 bytes. 21:50:11 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:50:11 INFO - Using the following test package requirements: 21:50:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:50:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'jsshell-linux-x86_64.zip'], 21:50:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:50:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:50:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:50:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:50:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 21:50:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 21:50:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:50:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21: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')]} 21:50:11 INFO - https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:12 INFO - Downloaded 22443711 bytes. 21:50:12 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 21:50:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:12 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 21:50:13 INFO - Return code: 0 21:50:13 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 21: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')]} 21:50:13 INFO - https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:50:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:14 INFO - Downloaded 22443711 bytes. 21:50:14 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 21:50:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 21:50:14 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 21:50:15 INFO - Return code: 0 21:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:15 INFO - https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:17 INFO - Downloaded 11131693 bytes. 21:50:17 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 21:50:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 21:50:17 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 21:50:17 INFO - Return code: 0 21:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:17 INFO - https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RnrE0exNQIa5C1XYwj_oEw/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 21:50:18 INFO - Downloaded 57164683 bytes. 21:50:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:50:18 INFO - mkdir: /builds/slave/test-pgo/properties 21:50:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:50:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:50:18 INFO - Contents: 21:50:18 INFO - build_url:https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 21:50:18 INFO - Running post-action listener: _resource_record_post_action 21:50:18 INFO - Running post-action listener: set_extra_try_arguments 21:50:18 INFO - ##### 21:50:18 INFO - ##### Running populate-webroot step. 21:50:18 INFO - ##### 21:50:18 INFO - Running pre-action listener: _resource_record_pre_action 21:50:18 INFO - Running main action method: populate_webroot 21:50:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:50:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:50:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:50:18 INFO - '../fennec_ids.txt'], 21:50:18 INFO - 'tests': ['tcheck2']}, 21:50:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:50:18 INFO - '--tppagecycles', 21:50:18 INFO - '7'], 21:50:18 INFO - 'tests': ['tsvgm']}}, 21:50:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:50:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:50:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:50:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:50:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:50:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'tests': ['damp', 'tps']}, 21:50:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['damp', 'tps']}, 21:50:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:50:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:50:18 INFO - 'other': {'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'other_l64': {'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'other_nol64': {'tests': ['a11yr', 21:50:18 INFO - 'ts_paint', 21:50:18 INFO - 'tpaint', 21:50:18 INFO - 'sessionrestore', 21:50:18 INFO - 'sessionrestore_no_auto_restore']}, 21:50:18 INFO - 'svgr': {'tests': ['tsvgx', 21:50:18 INFO - 'tsvgr_opacity', 21:50:18 INFO - 'tart', 21:50:18 INFO - 'tscrollx', 21:50:18 INFO - 'cart']}, 21:50:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['tsvgx', 21:50:18 INFO - 'tsvgr_opacity', 21:50:18 INFO - 'tart', 21:50:18 INFO - 'tscrollx', 21:50:18 INFO - 'cart']}, 21:50:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'tests': ['tp5o']}, 21:50:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'talos_options': ['--e10s'], 21:50:18 INFO - 'tests': ['tp5o']}, 21:50:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'talos_options': ['--xperf_path', 21:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:18 INFO - 'tests': ['tp5n']}, 21:50:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:50:18 INFO - 'talos_options': ['--e10s', 21:50:18 INFO - '--xperf_path', 21:50:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:50:18 INFO - 'tests': ['tp5n']}}, 21:50:18 INFO - 'talos.zip': {'path': '', 21:50:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:50:18 INFO - Running post-action listener: _resource_record_post_action 21:50:18 INFO - ##### 21:50:18 INFO - ##### Running create-virtualenv step. 21:50:18 INFO - ##### 21:50:18 INFO - Running pre-action listener: _resource_record_pre_action 21:50:18 INFO - Running main action method: create_virtualenv 21:50:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:50:18 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 21:50:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:50:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:50:18 INFO - Using real prefix '/usr' 21:50:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:50:19 INFO - Installing distribute.............................................................................................................................................................................................done. 21:50:21 INFO - Installing pip.................done. 21:50:21 INFO - Return code: 0 21:50:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:50:21 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')]} 21:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:21 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')]} 21:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:21 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:21 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 21:50:21 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 21:50:21 INFO - Using env: {'DISPLAY': ':0', 21:50:21 INFO - 'HOME': '/home/cltbld', 21:50:21 INFO - 'LANG': 'en_US.UTF-8', 21:50:21 INFO - 'LANGUAGE': 'en_US:en', 21:50:21 INFO - 'LOGNAME': 'cltbld', 21:50:21 INFO - 'MAIL': '/var/mail/cltbld', 21:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:21 INFO - 'MOZ_NO_REMOTE': '1', 21:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:21 INFO - 'NO_EM_RESTART': '1', 21:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:21 INFO - 'SHELL': '/bin/bash', 21:50:21 INFO - 'SHLVL': '1', 21:50:21 INFO - 'TERM': 'linux', 21:50:21 INFO - 'TMOUT': '86400', 21:50:21 INFO - 'USER': 'cltbld', 21:50:21 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:21 INFO - '_': '/tools/buildbot/bin/python'} 21:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:21 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 21:50:21 INFO - Cleaning up... 21:50:21 INFO - Return code: 0 21:50:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:50:21 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')]} 21:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:21 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')]} 21:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:21 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:21 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 21:50:21 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 21:50:21 INFO - Using env: {'DISPLAY': ':0', 21:50:21 INFO - 'HOME': '/home/cltbld', 21:50:21 INFO - 'LANG': 'en_US.UTF-8', 21:50:21 INFO - 'LANGUAGE': 'en_US:en', 21:50:21 INFO - 'LOGNAME': 'cltbld', 21:50:21 INFO - 'MAIL': '/var/mail/cltbld', 21:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:21 INFO - 'MOZ_NO_REMOTE': '1', 21:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:21 INFO - 'NO_EM_RESTART': '1', 21:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:21 INFO - 'SHELL': '/bin/bash', 21:50:21 INFO - 'SHLVL': '1', 21:50:21 INFO - 'TERM': 'linux', 21:50:21 INFO - 'TMOUT': '86400', 21:50:21 INFO - 'USER': 'cltbld', 21:50:21 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:21 INFO - '_': '/tools/buildbot/bin/python'} 21:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:21 INFO - Downloading/unpacking psutil>=0.7.1 21:50:21 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 21:50:21 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 21:50:21 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 21:50:21 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 21:50:21 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 21:50:21 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 21:50:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:50:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:50:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:23 INFO - Installing collected packages: psutil 21:50:23 INFO - Running setup.py install for psutil 21:50:23 INFO - building 'psutil._psutil_linux' extension 21:50:23 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 21:50:23 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 21:50:23 INFO - building 'psutil._psutil_posix' extension 21:50:23 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 21:50:23 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 21:50:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:50:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:50:24 INFO - Successfully installed psutil 21:50:24 INFO - Cleaning up... 21:50:24 INFO - Return code: 0 21:50:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21: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')]} 21:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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')]} 21:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21: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', '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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21: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 mozsystemmonitor==0.0.0 21:50:24 INFO - Using env: {'DISPLAY': ':0', 21:50:24 INFO - 'HOME': '/home/cltbld', 21:50:24 INFO - 'LANG': 'en_US.UTF-8', 21:50:24 INFO - 'LANGUAGE': 'en_US:en', 21:50:24 INFO - 'LOGNAME': 'cltbld', 21:50:24 INFO - 'MAIL': '/var/mail/cltbld', 21:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:24 INFO - 'MOZ_NO_REMOTE': '1', 21:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:24 INFO - 'NO_EM_RESTART': '1', 21:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:24 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:24 INFO - 'SHELL': '/bin/bash', 21:50:24 INFO - 'SHLVL': '1', 21:50:24 INFO - 'TERM': 'linux', 21:50:24 INFO - 'TMOUT': '86400', 21:50:24 INFO - 'USER': 'cltbld', 21:50:24 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:24 INFO - '_': '/tools/buildbot/bin/python'} 21:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:50:24 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 21:50:24 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 21:50:24 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 21:50:24 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 21:50:24 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 21:50:24 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 21:50:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:50:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:50:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:50:25 INFO - Installing collected packages: mozsystemmonitor 21:50:25 INFO - Running setup.py install for mozsystemmonitor 21:50:26 INFO - Successfully installed mozsystemmonitor 21:50:26 INFO - Cleaning up... 21:50:26 INFO - Return code: 0 21:50:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:50:26 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')]} 21:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:26 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')]} 21:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:26 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:26 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 21:50:26 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 21:50:26 INFO - Using env: {'DISPLAY': ':0', 21:50:26 INFO - 'HOME': '/home/cltbld', 21:50:26 INFO - 'LANG': 'en_US.UTF-8', 21:50:26 INFO - 'LANGUAGE': 'en_US:en', 21:50:26 INFO - 'LOGNAME': 'cltbld', 21:50:26 INFO - 'MAIL': '/var/mail/cltbld', 21:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:26 INFO - 'MOZ_NO_REMOTE': '1', 21:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:26 INFO - 'NO_EM_RESTART': '1', 21:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:26 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:26 INFO - 'SHELL': '/bin/bash', 21:50:26 INFO - 'SHLVL': '1', 21:50:26 INFO - 'TERM': 'linux', 21:50:26 INFO - 'TMOUT': '86400', 21:50:26 INFO - 'USER': 'cltbld', 21:50:26 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:26 INFO - '_': '/tools/buildbot/bin/python'} 21:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:26 INFO - Downloading/unpacking blobuploader==1.2.4 21: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 21: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 21: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 21: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 21: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 21: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 21:50:27 INFO - Downloading blobuploader-1.2.4.tar.gz 21:50:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:50:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:50:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:50:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:50:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 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 21:50:28 INFO - Downloading docopt-0.6.1.tar.gz 21:50:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:50:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:50:28 INFO - Installing collected packages: blobuploader, requests, docopt 21:50:28 INFO - Running setup.py install for blobuploader 21:50:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:50:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:50:28 INFO - Running setup.py install for requests 21:50:29 INFO - Running setup.py install for docopt 21:50:29 INFO - Successfully installed blobuploader requests docopt 21:50:29 INFO - Cleaning up... 21:50:29 INFO - Return code: 0 21:50:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:29 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:29 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 21:50:29 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 21:50:29 INFO - Using env: {'DISPLAY': ':0', 21:50:29 INFO - 'HOME': '/home/cltbld', 21:50:29 INFO - 'LANG': 'en_US.UTF-8', 21:50:29 INFO - 'LANGUAGE': 'en_US:en', 21:50:29 INFO - 'LOGNAME': 'cltbld', 21:50:29 INFO - 'MAIL': '/var/mail/cltbld', 21:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:29 INFO - 'MOZ_NO_REMOTE': '1', 21:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:29 INFO - 'NO_EM_RESTART': '1', 21:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:29 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:29 INFO - 'SHELL': '/bin/bash', 21:50:29 INFO - 'SHLVL': '1', 21:50:29 INFO - 'TERM': 'linux', 21:50:29 INFO - 'TMOUT': '86400', 21:50:29 INFO - 'USER': 'cltbld', 21:50:29 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:29 INFO - '_': '/tools/buildbot/bin/python'} 21:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:50:29 INFO - Running setup.py (path:/tmp/pip-J2X4tL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:50:29 INFO - Running setup.py (path:/tmp/pip-2mRs27-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:50:29 INFO - Running setup.py (path:/tmp/pip-RYz1eP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:50:29 INFO - Running setup.py (path:/tmp/pip-xXUQNE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:50:29 INFO - Running setup.py (path:/tmp/pip-JQ6EfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:50:29 INFO - Running setup.py (path:/tmp/pip-EPiaoG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:50:29 INFO - Running setup.py (path:/tmp/pip-0r1Cwg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:50:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:50:29 INFO - Running setup.py (path:/tmp/pip-XvP_PM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:50:30 INFO - Running setup.py (path:/tmp/pip-tHyFW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:50:30 INFO - Running setup.py (path:/tmp/pip-dLOgpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:50:30 INFO - Running setup.py (path:/tmp/pip-74mWUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:50:30 INFO - Running setup.py (path:/tmp/pip-C9fbMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:50:30 INFO - Running setup.py (path:/tmp/pip-AXUG37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:50:30 INFO - Running setup.py (path:/tmp/pip-qpQ_dz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:50:30 INFO - Running setup.py (path:/tmp/pip-Uyo6p5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:50:30 INFO - Running setup.py (path:/tmp/pip-x6WioR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:50:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:50:30 INFO - Running setup.py (path:/tmp/pip-SihBLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:50:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:50:30 INFO - Running setup.py install for manifestparser 21:50:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:50:30 INFO - Running setup.py install for mozcrash 21:50:30 INFO - Running setup.py install for mozdebug 21:50:31 INFO - Running setup.py install for mozdevice 21:50:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for mozfile 21:50:31 INFO - Running setup.py install for mozhttpd 21:50:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for mozinfo 21:50:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for mozInstall 21:50:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for mozleak 21:50:31 INFO - Running setup.py install for mozlog 21:50:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for moznetwork 21:50:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:50:31 INFO - Running setup.py install for mozprocess 21:50:31 INFO - Running setup.py install for mozprofile 21:50:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:50:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:50:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:50:32 INFO - Running setup.py install for mozrunner 21:50:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:50:32 INFO - Running setup.py install for mozscreenshot 21:50:32 INFO - Running setup.py install for moztest 21:50:32 INFO - Running setup.py install for mozversion 21:50:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:50:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:50:32 INFO - Cleaning up... 21:50:32 INFO - Return code: 0 21:50:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:32 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:32 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 21:50:32 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 21:50:32 INFO - Using env: {'DISPLAY': ':0', 21:50:32 INFO - 'HOME': '/home/cltbld', 21:50:32 INFO - 'LANG': 'en_US.UTF-8', 21:50:32 INFO - 'LANGUAGE': 'en_US:en', 21:50:32 INFO - 'LOGNAME': 'cltbld', 21:50:32 INFO - 'MAIL': '/var/mail/cltbld', 21:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:32 INFO - 'MOZ_NO_REMOTE': '1', 21:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:32 INFO - 'NO_EM_RESTART': '1', 21:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:32 INFO - 'SHELL': '/bin/bash', 21:50:32 INFO - 'SHLVL': '1', 21:50:32 INFO - 'TERM': 'linux', 21:50:32 INFO - 'TMOUT': '86400', 21:50:32 INFO - 'USER': 'cltbld', 21:50:32 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:32 INFO - '_': '/tools/buildbot/bin/python'} 21:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:50:32 INFO - Running setup.py (path:/tmp/pip-GlTSz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:50:32 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)) 21:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:50:32 INFO - Running setup.py (path:/tmp/pip-ajoTen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:50:32 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)) 21:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:50:32 INFO - Running setup.py (path:/tmp/pip-skCbl4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:50:32 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)) 21:50:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:50:32 INFO - Running setup.py (path:/tmp/pip-rziBJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:50:33 INFO - Running setup.py (path:/tmp/pip-8X_Wuo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:50:33 INFO - Running setup.py (path:/tmp/pip-AtS66n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:50:33 INFO - Running setup.py (path:/tmp/pip-IwhcKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:50:33 INFO - Running setup.py (path:/tmp/pip-8qdQ_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:50:33 INFO - Running setup.py (path:/tmp/pip-TlozuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:50:33 INFO - Running setup.py (path:/tmp/pip-PyEhbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:50:33 INFO - Running setup.py (path:/tmp/pip-3sCY25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:50:33 INFO - Running setup.py (path:/tmp/pip-ps_mBv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:50:33 INFO - Running setup.py (path:/tmp/pip-SSGgfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:50:33 INFO - Running setup.py (path:/tmp/pip-y5J48S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:50:33 INFO - Running setup.py (path:/tmp/pip-AHmn8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:50:33 INFO - Running setup.py (path:/tmp/pip-InQO13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:50:33 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)) 21:50:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:50:33 INFO - Running setup.py (path:/tmp/pip-e2IPPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:50:33 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)) 21:50:33 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)) 21:50:33 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)) 21:50:33 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)) 21:50:33 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)) 21:50:33 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)) 21:50:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:50:33 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 21:50:33 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 21:50:33 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 21:50:33 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 21:50:33 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 21:50:33 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 21:50:35 INFO - Downloading blessings-1.5.1.tar.gz 21:50:35 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 21:50:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:50:35 INFO - Installing collected packages: blessings 21:50:35 INFO - Running setup.py install for blessings 21:50:35 INFO - Successfully installed blessings 21:50:35 INFO - Cleaning up... 21:50:35 INFO - Return code: 0 21:50:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:50:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:50:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:50:36 INFO - Reading from file tmpfile_stdout 21:50:36 INFO - Current package versions: 21:50:36 INFO - argparse == 1.2.1 21:50:36 INFO - blessings == 1.5.1 21:50:36 INFO - blobuploader == 1.2.4 21:50:36 INFO - docopt == 0.6.1 21:50:36 INFO - manifestparser == 1.1 21:50:36 INFO - mozInstall == 1.12 21:50:36 INFO - mozcrash == 0.16 21:50:36 INFO - mozdebug == 0.1 21:50:36 INFO - mozdevice == 0.47 21:50:36 INFO - mozfile == 1.2 21:50:36 INFO - mozhttpd == 0.7 21:50:36 INFO - mozinfo == 0.9 21:50:36 INFO - mozleak == 0.1 21:50:36 INFO - mozlog == 3.0 21:50:36 INFO - moznetwork == 0.27 21:50:36 INFO - mozprocess == 0.22 21:50:36 INFO - mozprofile == 0.27 21:50:36 INFO - mozrunner == 6.11 21:50:36 INFO - mozscreenshot == 0.1 21:50:36 INFO - mozsystemmonitor == 0.0 21:50:36 INFO - moztest == 0.7 21:50:36 INFO - mozversion == 1.4 21:50:36 INFO - psutil == 3.1.1 21:50:36 INFO - requests == 1.2.3 21:50:36 INFO - wsgiref == 0.1.2 21:50:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:50:36 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')]} 21:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:36 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')]} 21:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:50:36 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 0x7f8f9a45fc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, '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': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', '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 21:50:36 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 21:50:36 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 21:50:36 INFO - Using env: {'DISPLAY': ':0', 21:50:36 INFO - 'HOME': '/home/cltbld', 21:50:36 INFO - 'LANG': 'en_US.UTF-8', 21:50:36 INFO - 'LANGUAGE': 'en_US:en', 21:50:36 INFO - 'LOGNAME': 'cltbld', 21:50:36 INFO - 'MAIL': '/var/mail/cltbld', 21:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:36 INFO - 'MOZ_NO_REMOTE': '1', 21:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:36 INFO - 'NO_EM_RESTART': '1', 21:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:36 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:36 INFO - 'SHELL': '/bin/bash', 21:50:36 INFO - 'SHLVL': '1', 21:50:36 INFO - 'TERM': 'linux', 21:50:36 INFO - 'TMOUT': '86400', 21:50:36 INFO - 'USER': 'cltbld', 21:50:36 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:36 INFO - '_': '/tools/buildbot/bin/python'} 21:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 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)) 21:50:36 INFO - Cleaning up... 21:50:36 INFO - Return code: 0 21:50:36 INFO - Running post-action listener: _resource_record_post_action 21:50:36 INFO - Running post-action listener: _start_resource_monitoring 21:50:36 INFO - Starting resource monitoring. 21:50:36 INFO - ##### 21:50:36 INFO - ##### Running install step. 21:50:36 INFO - ##### 21:50:36 INFO - Running pre-action listener: _resource_record_pre_action 21:50:36 INFO - Running main action method: install 21:50:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:50:36 INFO - Reading from file tmpfile_stdout 21:50:36 INFO - Detecting whether we're running mozinstall >=1.0... 21:50:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:50:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:50:36 INFO - Reading from file tmpfile_stdout 21:50:36 INFO - Output received: 21:50:36 INFO - Usage: mozinstall [options] installer 21:50:36 INFO - Options: 21:50:36 INFO - -h, --help show this help message and exit 21:50:36 INFO - -d DEST, --destination=DEST 21:50:36 INFO - Directory to install application into. [default: 21:50:36 INFO - "/builds/slave/test-pgo"] 21:50:36 INFO - --app=APP Application being installed. [default: firefox] 21:50:36 INFO - mkdir: /builds/slave/test-pgo/build/application 21:50:36 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'] 21:50:36 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 21:50:50 INFO - Reading from file tmpfile_stdout 21:50:50 INFO - Output received: 21:50:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:50:50 INFO - Running post-action listener: _resource_record_post_action 21:50:50 INFO - ##### 21:50:50 INFO - ##### Running run-tests step. 21:50:50 INFO - ##### 21:50:50 INFO - Running pre-action listener: _resource_record_pre_action 21:50:50 INFO - Running main action method: run_tests 21:50:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:50:50 INFO - Python 2.7.3 21:50:50 INFO - Return code: 0 21:50:50 INFO - grabbing minidump binary from tooltool 21:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:50:50 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 0x20c78c0>, '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 0x2074420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20748b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:50:50 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 21:50:50 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 21:50:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:50:51 INFO - Return code: 0 21:50:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:50:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:50:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:50:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:50:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:50:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 21:50:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 21:50:51 INFO - Using env: {'DISPLAY': ':0', 21:50:51 INFO - 'HOME': '/home/cltbld', 21:50:51 INFO - 'LANG': 'en_US.UTF-8', 21:50:51 INFO - 'LANGUAGE': 'en_US:en', 21:50:51 INFO - 'LOGNAME': 'cltbld', 21:50:51 INFO - 'MAIL': '/var/mail/cltbld', 21:50:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:50:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:50:51 INFO - 'MOZ_NO_REMOTE': '1', 21:50:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:50:51 INFO - 'NO_EM_RESTART': '1', 21:50:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:50:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:50:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:50:51 INFO - 'SHELL': '/bin/bash', 21:50:51 INFO - 'SHLVL': '1', 21:50:51 INFO - 'TERM': 'linux', 21:50:51 INFO - 'TMOUT': '86400', 21:50:51 INFO - 'USER': 'cltbld', 21:50:51 INFO - 'XDG_SESSION_COOKIE': '49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446', 21:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:50:51 INFO - '_': '/tools/buildbot/bin/python'} 21:50:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 21:50:51 INFO - mozversion INFO | application_buildid: 20151113193129 21:50:51 INFO - mozversion INFO | application_changeset: 202b199b9fcf37a687bef882f2513e191f079622 21:50:51 INFO - mozversion INFO | application_display_name: Nightly 21:50:51 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:50:51 INFO - mozversion INFO | application_name: Firefox 21:50:51 INFO - mozversion INFO | application_remotingname: firefox 21:50:51 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 21:50:51 INFO - mozversion INFO | application_vendor: Mozilla 21:50:51 INFO - mozversion INFO | application_version: 45.0a1 21:50:51 INFO - mozversion INFO | platform_buildid: 20151113193129 21:50:51 INFO - mozversion INFO | platform_changeset: 202b199b9fcf37a687bef882f2513e191f079622 21:50:51 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 21:50:51 INFO - mozversion INFO | platform_version: 45.0a1 21:50:51 INFO - 2015-11-13 21:50:51,244 DEBUG : using testdate: 1447480251 21:50:51 INFO - 2015-11-13 21:50:51,244 DEBUG : actual date: 1447480251 21:50:51 INFO - 2015-11-13 21:50:51,253 INFO : starting webserver on 'localhost:58851' 21:50:51 INFO - 2015-11-13 21:50:51,254 INFO : Starting test suite talos-linux64-ix-060 21:50:51 INFO - 2015-11-13 21:50:51,254 INFO : Starting test dromaeo_css 21:50:51 INFO - 2015-11-13 21:50:51,254 DEBUG : operating with platform_type : linux_ 21:50:51 INFO - 2015-11-13 21:50:51,255 INFO : Initialising browser for dromaeo_css test... 21:50:51 INFO - 2015-11-13 21:50:51,271 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQu0XoK/profile http://localhost:58851/getInfo.html 21:50:55 INFO - 2015-11-13 21:50:55,326 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:50:55 INFO - 2015-11-13 21:50:55,327 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:50:55 INFO - 2015-11-13 21:50:55,327 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:50:55 INFO - 2015-11-13 21:50:55,327 DEBUG : BROWSER_OUTPUT: __metrics 21:50:55 INFO - 2015-11-13 21:50:55,455 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:50:56 INFO - 2015-11-13 21:50:56,541 INFO : Browser initialized. 21:50:56 INFO - 2015-11-13 21:50:56,542 INFO : Running cycle 1/1 for dromaeo_css test... 21:50:56 INFO - 2015-11-13 21:50:56,542 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQu0XoK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:51:08 INFO - 2015-11-13 21:51:08,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 140939264 21:51:08 INFO - 2015-11-13 21:51:08,200 DEBUG : BROWSER_OUTPUT: 21:51:59 INFO - 2015-11-13 21:51:59,798 DEBUG : BROWSER_OUTPUT: 1447480319798 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] 21:54:08 INFO - 2015-11-13 21:54:08,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58851/tests/dromaeo/cssquery-ext.html) 21:54:09 INFO - 2015-11-13 21:54:09,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 234450944 21:54:09 INFO - 2015-11-13 21:54:09,212 DEBUG : BROWSER_OUTPUT: 21:57:11 INFO - 2015-11-13 21:57:11,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-ext.html (next: http://localhost:58851/tests/dromaeo/cssquery-jquery.html) 21:57:12 INFO - 2015-11-13 21:57:12,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 225136640 21:57:12 INFO - 2015-11-13 21:57:12,089 DEBUG : BROWSER_OUTPUT: 22:00:14 INFO - 2015-11-13 22:00:14,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58851/tests/dromaeo/cssquery-mootools.html) 22:00:14 INFO - 2015-11-13 22:00:14,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 217964544 22:00:14 INFO - 2015-11-13 22:00:14,631 DEBUG : BROWSER_OUTPUT: 22:03:16 INFO - 2015-11-13 22:03:16,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58851/tests/dromaeo/cssquery-prototype.html) 22:03:17 INFO - 2015-11-13 22:03:17,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 201936896 22:03:17 INFO - 2015-11-13 22:03:17,048 DEBUG : BROWSER_OUTPUT: 22:06:19 INFO - 2015-11-13 22:06:19,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58851/tests/dromaeo/cssquery-yui.html) 22:06:20 INFO - 2015-11-13 22:06:20,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 202399744 22:06:20 INFO - 2015-11-13 22:06:20,036 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-yui.html (next: http://localhost:58851/tests/dromaeo/cssquery-dojo.html) 22:09:22 INFO - 2015-11-13 22:09:22,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 283799552 22:09:22 INFO - 2015-11-13 22:09:22,719 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:09:22 INFO - 2015-11-13 22:09:22,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:09:22 INFO - 2015-11-13 22:09:22,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:09:22 INFO - 2015-11-13 22:09:22,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:09:22 INFO - 2015-11-13 22:09:22,722 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3231.9676803231964;3297.8021318720894;3327.650596687348;3341.398548261312;3349.4305967985447;5412.648177868436;5498.945010549894;5542.0855558832745;5558.194061861032;5565.582581306408;5515.779368825252;5559.471850174227;5564.137558678402;5569.693666848321;5703.201551782754;4984.22744474607;5015.398152221738;5101.948980510185;5118.9488105119035;5174.637775355726;5070.670406423571;5134.460881607433;5163.302954101205;5172.715500647463;5174.4825517448335;4971.4034315882145;5000.174971129759;5084.0594490019275;5146;5149;5053.646244762868;5055.974720126376;5060.772265248036;5061.949380506185;5098.337216161875;4924.4583095859425;5012.27322038306;5040.143175660147;5057.115004874169;5057.924131138036;5284.4187139414635;5358.705271210082;5372.140457526816;5401.945980540184;5407.729613519308;5983.311919129313;6044.516438684895;6080.300765411946;6085.5435842312;6106.694665266719;5798.10129429939;5924.911126333109;6076.4834989025985;6105.053716673922;6111.694415279263;5504.119340905476;5578.553715702734;5589.8323050308145;5604.495595396434;5627.803026894039;6102;6127.571070025056;6133.205558217569;6133.478654314434;6133.693315334215;5684.118961560965;5807;5915.387867784199;5978.880422391615;5985.581009329305;5928.970355148283;6026.457618814327;6027.30685971119;6031.638101713911;6080.027195648675;5989.790357337472;5996.190514280516;5996.340402555716;6007.909881351783;6050.2437195350585;5746.367899531048;5854.765809367577;5919.526437884959;5998.610090344114;6005.159277701126;4604.723716577016;4605.355250264965;4608.101420223024;4618.168729628699;4638.721676699409;4062.512498500199;4079.102597428561;4084.4281800547947;4086.3666131749033;4108.815103320358;5399.1091469907815;5553.611247212737;5581.441855814386;5701.600887937804;5735.397783232784;6059.242594675666;6087.756489740449;6137.539684523678;6146.323904370515;6150.630962142286;5706.3722990471015;5706.400827913092;5708.914366284509;5709.885802284014;5715.942840571541;5018.774155163026;5078.492150784966;5093.643444958891;5174.560162386239;5213.7393130343335;6315.336889626615;6331.398517140957;6337.7148028337915;6337.746490140435;6349.809505714744;5795.449432303924;6110.9833754861675;6112.602680825732;6116.633002019893;6116.816495505142;6108.342071131425;6108.623263290827;6128;6137.539684523768;6242;5939.524838013035;5945.40545945402;5948.048312270016;5985.102234664835;5995.940040599538;5829.504492118048;5970.253718285215;6027.57806953509;6037.849053773691;6039.184710064261;5782.45066718661;5808.30300363959;5815.76736930518;5886.646801191942;5920.259967504062;5835.766569337349;5876.41235876409;5914.378990205966;5927.525797936241;5954.553408494294;5572.972135139298;5710.743016564347;5750.0512415450985;5844.883102338014;5855.385184555731;5933.584649074523;5939.46544810969;5964.612300200473;5969.880602388015;5995.430434108753;5807.157962095388;5815.04051831443;5816.592838501264;5826.854328641648;5876.970615147068 22:09:22 INFO - 2015-11-13 22:09:22,724 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.3045701502077;582.6766144789641;586.208618365207;595.6842873277164;605.6093819486434;31918;39698.206035879266;40370.7981460093;40399.59600403995;40853.7957310213;43921;43955.560444395545;44313;44403;44664.77667611658;7603.505772124794;7670.7698769037015;8734.956325218365;8921.59852806622;10261.79476410475;10423.322484038514;10561.894381056169;10568.048875601233;10569.260151789378;10571.101456376216;10513.211509136807;10589.364638121699;10604;10606.575736970512;10630.415327157003;7811.257930496622;7996.480228785169;10612.840807387895;10835.891641083646;10841.024307812257;10353;10478.79042419155;10510.369377837354;10511.316764410289;10515;40505.392419113734;41025.794871025755;41106.9723256921;41139.14873830655;41210.1757964842;3238;3299.4555898276753;3562.9643703562892;3976.920461590781;4133.9793301033305;30439;30568.235794105327;30622.84688576543;30685.539716904263;30703.692963070305;3332.4001679697644;3350.71518920892;3373;3465.4455287154187;3490.127468132967;271339;272333;274323;274377;274668;56881.431185687616;57865.71067144637;59294;59853.70073149694;60258.39741602616;55206;55292;55406.445935540934;55495.44504554984;55515;15229.314680839389;15291.61770955735;15480.380784768708;15503.689926201412;15519.767203491956;10765.892341076646;10782.514786834612;10790.24468287228;10792.676219713421;10816.134709223243;18940.81059189418;19158.808411915703;19207;19213.807861921483;19225;7612.429067819825;7774.572398518136;7855;7902.841943161105;7931.286184243446;938.4463166731662;1033.7415646088477;1038.46000079958;1050.0077426831572;1133.7732453509166;27897;28652.426951460853;28733.856330718212;28988;29051.85474072616;1008.3395376028712;1031.1441503552035;1038.8857225705317;1054.8681414823147;1084.4144162152506;14853.925730371278;15280.694386112216;15286.006409583342;15706.764398534031;15934.60163495922;323975;329395;330768;330795;331101;51883;51992.48007519952;52064.739676301375;52105;52116;1342.6710455938162;1359.3611002828654;1378.255741899383;1379.661982814217;1384.9653758656113;27600.723992760617;28422.85788571044;28582.285442864093;28749.71250287554;28904.421911562073;45042;45343.31985020293;45373.773131134134;45410.77294613506;45416.318755219356;262837;269695;289572;296599;297882;28461;28651.713482864903;28816.567751483326;28824.567631485126;28855;38128.809355953046;39041.609583903795;39136.2172756549;39464.60535394609;39510.2097958045;35261.47107793334;35709.82145089258;36514.452283216306;36694;36766.264674705824;32981.86082487069;36041.279174416886;36381.454278185316;36459.27081458409;36575.45136822897;35953.82023089868;36073.0981725459;36120.4581931266;36143.63856361508;36314.8184259077;30760.230994225323;30940.69059309468;33341.83329083339;33489.497657534666;33719.4942075874;24470.755292446847;24895.751042489344;25075.576612383575;25320.366990825376;25590 22:09:22 INFO - 2015-11-13 22:09:22,727 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.39937505615507;356.44572689467884;357.43168362303965;357.98210089495535;358.7112374538496;14594.635134121652;14628.195449250314;16580.751288730662;16992.91503542482;17740.733888991675;15381.230938453089;16570.42003529877;16675.91551056118;16681.249343779527;17027;5233.816816411417;5272.6836389816735;5369.114096174127;5369.5167434930845;5373.462653734615;3862.4206369044728;3979.4229836673667;5311.62818602698;5340.465953404668;5836.328822185439;5839.649621022731;5932.11018347247;5962.672053037081;5963.522918166536;5965.761369545213;5453.536449401806;5485.670859748428;5500.944990550103;5504.944950550524;5596.468335508121;5178.741062946875;5264.6314757966575;5266.4733526647415;5283.841484755463;5290.867728306823;20131.194752209893;20424.591508169902;20705.68941465879;21324.147034118618;21328.680069798964;2079.178724403852;2089.310527525928;2102.3167470572125;2187.4859408039097;2336.995092110392;12987.675308117277;13057.80413293792;13083.607491775261;13586.38861251246;13655.522056727967;1686.9746953795702;1732.4629364896796;1765.62921786425;1832.4594244697846;1870.560418301698;58622.120668190015;59246.40753592452;60325.39674603286;60491.697541512454;61450.692746535984;9474.810503789886;9716.708498745049;9870.901290986998;9878.703638890845;9907.999999999856;12566.685832854251;12613;12630.684232894067;12630.789611817896;12634.557790477289;7248.202697703248;7293.124825021031;7332.633368331562;7427.925720742724;7483.13943896448;7062.6821793019435;7087.574745515286;7106.71573137079;7160.711072006985;7173.820654483576;5866.354700982888;5998.49012833914;6000.519958403317;6003.879922401527;6069.939300607026;1605.5022942887742;1668.9165541722866;1669.5826043489128;1723.4398820383426;1756.7162688504893;880.2473884828507;924;933.6872147830417;982.8673129127476;1003.2124782046059;11622.302661840316;12772.61682149537;12811.679708007188;12848.550300739429;17239.22423490946;429.13743375814835;492.3869782121282;495.88098856274235;501.96988180709275;508.8804131029205;6321.399467050623;6587.571807832475;6626.204855417284;6762.222344430454;6780.982852572055;489010;536534;545728;590505;594423;79943;80018.5999070001;81135;83535.16464835395;84452.57773711215;498.82042464712674;507.12520901445447;507.2745973258276;507.98984020319386;508.12602324002654;11079.612213572485;11162.218644694793;11228.943855280671;11293.265937714023;11328.886711132784;36334.81832590926;36430.27139457143;36539.817300913324;36606.816965915;37383.626163738016;44424.33363499615;47884.521154788;48272.275915861996;49897.00205995787;50016.749916250184;6822.590644561342;6859.142607174103;6966.12923384577;6976.720931162697;7019.754308599175;12633.431495582538;12802.67993300175;12887.93556032214;12963.740725185255;13006.284654344103;10823.67528974132;10911.290766100496;11034.337939723322;11332.206745528063;11360.715982100513;10370.740731481774;11033.613823516138;11092.833607495733;11102.944485277521;11244.55021799119;8553.529555874487;8731.214190722865;10755.247132700635;11433.1996760226;11558.653240402802;6646.169228846395;6859.348361905611;6897.206821215424;6909.896351554831;6916.066331045245;10819.350838949687;10993.119357276366;11093.667189984313;11113.944430277797;11204.047655949336 22:09:22 INFO - 2015-11-13 22:09:22,727 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1581.9446319378824;1681;1742.1115231232072;1758.900687070581;1797.8831375960563;6545.607263564183;7603.0496187976505;7803.921960780398;7804.843903121934;7823.3350165236025;7669.079710434742;7784.338331241851;7787.805304867367;7793.415493837956;7794.103678077023;1930.6814375628076;1970.4088773368003;2137.6045431595203;2236.9888150559264;2259.89830457629;2234.6089434349005;2247.0674670011927;2255.5150642611834;2258.3337915314937;2258.7176602924633;2179.4769255378756;2272.36373815332;2272.7954484096426;2276.1009401286483;2278.7493375728654;1949.7465329507215;1985.6525108106096;2148.4628842789225;2219.7225346831647;2224.5217278285086;2222.8888555572316;2246.359787460582;2281.2471884278316;2283.8058765004994;2285.531466049456;7715.961420192863;7730.072391313022;7774.883376749353;7785.883211751771;7799.610019499002;4330.631896288788;4404.933925991113;4407.382966384709;4419;4421.823127074913;2804.2568719289407;2807.1297897651793;2845.9146225613263;2848.2025032990587;3006.2634654509566;948.8149810786899;956.0439560439561;961.7932144588947;977.9608815647366;985.069109691342;9912.702618921443;9919.752006199831;9926.950365248127;9940.10539051489;9940.950295248549;4074.2055299216368;4148.834046638161;4182.351735480945;4193.30810416284;4201.222773786859;8594.097619749837;8596.054434012254;8597.441166324168;8609;8614.569271536398;4645.814167433333;4652.511486293958;4656.534346565317;4657.580817726353;4660.743659098782;4228.5982831630945;4231.280682284019;4232.25935461293;4233.576642335804;4239.236937351307;3675.209829886587;3706.5181526401393;3723.255348930225;3726.06848287928;3756.9436458453147;1180.3685028509879;1189.9940500297444;1197.9820302695466;1207.3600991474532;1218.3542722357165;1020.0717347213999;1034.8809886863107;1035.295998720877;1174.976500469986;1331.5539294336506;7290.744823931137;7338.853222935618;7355.338019578264;7388.187299397062;7388.593627350439;478.82762205605957;484.44531011991074;484.68495477938916;489.1098201273719;496.76900241387926;5711.514521265656;5764.971175144097;5771.6537007778825;5775.8556036099435;5781.421857814269;8816.250618697355;9077.954610227038;9143.63425462974;9157.404768690014;9165.266778657691;9082.545872706338;9103.135202155785;9106.544672766335;9108.180263776292;9115.407498512708;6883.552569082994;6955.65221738911;7333.413326933833;7402.259774022662;7419.332260096618;7254.093238345207;7296;7299.598522081336;7303.050603421521;7303.269673032654;8178.918210818054;8222.054463736747;8302.377321700777;8414.158584141536;8485.448445851;8457.788555286166;8502.14978502145;8639.568021598769;8640;8653.350998674998;6900.137482814648;7022.157341118894;7030.50786444944;7111.60886151246;7114.181869084914;7460.552366858006;7491.700331986877;7504.662290197063;7515.924840751522;7520.360769334449;6940.687669055005;7018.298170182941;7037.929620703932;7157.57054576727;7192.928070719226;6193.040078787795;6629.966850165912;6683.83290417724;6757.493188010821;6913.965430172817;7027.578345299094;7049.224585295511;7074.3633073023675;7074.504784665024;7078.646067696697;6482.448991835747;6509.381608747161;6514.218293804774;6516.380943810331;6519.8044058678315;6495.707693153914;6580.80257592273;6581.638009909501;6582.275949645439;6595.043718660863 22:09:22 INFO - 2015-11-13 22:09:22,727 DEBUG : BROWSER_OUTPUT: |4;prototype.html;320.9935801283974;326.09183424163695;329.4021351247485;329.4235088594959;331.8291080093751;6007.4593286604195;6030.819075427733;6048.576599638027;6101.389861013897;6112.633242005483;5970.462658360747;5988.191594134791;5996.670183139926;6008.1888944992415;6010.188624535686;4570.954290457103;4579.152856721509;4582.1064892346;4585.335126406669;4586.610138138246;4515.954840451603;4597.103564804865;4599.494055653875;4600.792964316597;4612.3542704021465;4548.931766023512;4550.68145229834;4551.567601077909;4552.476465206494;4555.24838401665;4239.830406783725;4543.886402839939;4553.134904368176;4554.157480866033;4568.611668008223;3704.814759262026;3928.7839168845703;3981.9601803981877;3988.960110398888;3990.022444501116;5689.118186681071;5702.600817942745;5716;5716.256886604757;5722.427757224286;4882.487338829443;5008.248762685626;5176.767045482962;5285.471452854722;5311.123664595337;6317.273513545955;6325.114483972247;6328.208973878265;6331.936680633181;6337.651429171394;4376.737395756265;4385.188740083095;4428.180786554498;4430.468343798765;4433.290673492225;6507.804765857032;6561.80314590563;6564.671766411708;6600.174978127734;6612.7354905804195;4515.774211289422;4518.373385581188;4520.0507893342765;4523.84166554169;4530.705504142286;4567.2007398705755;4576.382188404523;4581.633469322513;4583.610393116623;4587.72473651582;5277.419483856773;5284.550813180923;5286.9471305287225;5292.708901010481;5293.258943747878;6242.625442473466;6417.262014868256;6419.679016049272;6421.325760795143;6440;1569.4977607165827;1580.4942418426224;1583.1371902313267;1583.7228485015075;1584.9128297943723;1015.4161357219629;1024.9743756406149;1026.6868605075524;1033.7984093101772;1036.6164519127972;6194.256689197326;6201.96899015502;6212.81361559154;6213.347598502182;6224.564280500322;6628.304028077079;6633.313508029256;6633.7346506140175;6642.202935647753;6642.236142843538;6085.482733967662;6207.81376558704;6210.968945155245;6214.40963108504;6226.346233645492;3571.499990001402;3578.946315805265;3592.4072528033103;3598.586162591283;3609.224016836393;6809;6838.1794184697155;6851.492671612237;6854.5201835872;6856.348646878539;6460.289368169498;6739.797806065826;6741.696623651849;6741.696623651947;6757.222919364238;6410.935890641033;6737.157855268091;6824.624645644537;6849.931500685029;6939.93060069403;6691.330866913465;6693.698783554654;6702.19573651165;6702.463802895854;6710.16122984627;6608.537402381787;6611.570247933869;6625.933740662532;6626.304238054935;6626.668666566556;6684.298148694317;6825.931740682729;6846.554973926679;6853.0405743195;6856.142982127234;4433.2463481208915;4438.312061630452;4445.888852778707;4446.377507148937;4452.3544086106685;6679.532432729662;6683.966580167263;6685.33146685347;6685.76599819004;6692.933070669231;6374.330695276929;6482.935170648233;6495.123158373748;6500.609963402211;6502.414782669583;6476.643784591893;6478.222613286436;6484.157059582224;6487.772927947688;6494.253160886558;6345.524085693683;6366.204224471941;6368.172137622079;6373.5857169283845;6374.29882712892;6332.366763323815;6501.187351581052;6510.707018184098;6514.022896565553;6522.021696745526;6353.491720662243;6358.141650877073;6362.236531616236;6367.9044814328745;6371.139896113966 22:09:22 INFO - 2015-11-13 22:09:22,728 DEBUG : BROWSER_OUTPUT: |5;yui.html;723.2225357740429;749.5952185819658;759.5632511306001;772.9149793522715;835.6949713354624;13587.252701101448;13633.727325453485;13656.931715341409;13689;13699.520516781915;12709.173903696254;12720;12727.681807954807;12742.108052436333;12804;672.3982036077707;679.8912174052152;797.1629788721833;808.1514409869613;834.090840983328;820.6389188756958;821.7781199076246;827.606886728805;827.755812035448;829.3821103278036;875.6322344615277;875.6497401039571;876.2726936642604;876.583622779178;877.5612193903048;707.6391040569321;717.28630013137;850.26452118917;867.5748883047324;868.0234735922088;640.0846789091597;641.1504756198057;641.4066988036049;642.9517786166057;646.83182372583;13107.934460327733;13109.082364234508;13121.737565248737;13126.934365328112;13129.606111816565;11604.303741775437;12785.360731963365;12984.091113622051;13143.539976100887;13180.275084870329;9810.656627018092;9855.113039826378;9861.556229969668;9961.551730172087;10059.69820905374;3489.319582681378;3524.488949102366;3546.2375589248177;3556.6798988091195;3569.803660798655;47168.72793724822;47858.28212576814;48169.518304817204;48210;48221.27668084981;10042.849357259647;10098.444585547719;10152.340097893613;10220.386776793417;10311.1235544978;18263.72604410935;18295.08524573766;18298;18304.359347422775;18348.174332155086;7496.58768767723;7517.097948246136;7550.962245188739;7624.852477628948;7661.808454788675;4350.151720414488;4382.101669157815;4473.977630111829;4477.238869392211;4523.32150177476;3072.5083986562045;3099.2406860319365;3105.0840002199407;3108.585593554927;3122.2350524121734;450.37173143464685;452.27861560810453;453.43094416507734;468.94607120181615;469.73459995102655;590.2680675961863;607.4290167242777;610.124471383566;642.502060902804;650.9772157974448;7847.803804904809;7898.842023159619;8057.435979481497;8230.382721295926;8987.146221108984;551.6572000178286;566.8554518597731;627.5074066857586;654.4142992022114;669.270495160268;3859.2667393195766;4096.32410652245;4102;4129.566395528486;4216.219999300078;48873.26690099651;49043.26435103476;49071;49290;49750;43216.56783432188;44109.77945110318;44156.558434415885;44161.558384416385;44177;42939.57060429418;43099.569004310186;43778.34332485015;43839.78080109579;45034.77482612631;8105.108438071925;8107.594620269081;8227.259546640831;8319.708810191856;8322;33227.335453291285;33690.32619347648;33705.66294337124;33985.830070849486;34220.48669269913;38867.222655547295;41440.1711965753;42420.57579424166;42939.570604293556;42941.141177176905;7562.470627056274;7720.382369410546;7737.767866964;7768.184340644151;7837.960810195913;12175.452104655134;12217.45021474018;12299.385030748248;12305.876941230832;12465.688357791129;10515.842262366225;10567.894321056998;10636.8936310639;10832.945835270773;11168.050715689258;10747;11164.944175279072;11360;11430.885691142983;11772.234804737665;10560.313579617608;10608.151347892304;11455.198136130392;11463.885361146282;11786.58746943853;9885.55515001841;10036.799264014824;10052.84920726175;10058.899411006088;10061.647842325483;9116.908830911607;10079.445630490394;10088.445135517324;10099.394036357842;10131.442770647685 22:09:22 INFO - 2015-11-13 22:09:22,728 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:09:22 INFO - 2015-11-13 22:09:22,728 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,823 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: __startTimestamp1447481362719__endTimestamp 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5567.11 Median:5798.10 stddev:639.20 (11.0%) stddev-sans-first:614.35 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: Values: 3232.0 3297.8 3327.7 3341.4 3349.4 5412.6 5498.9 5542.1 5558.2 5565.6 5515.8 5559.5 5564.1 5569.7 5703.2 4984.2 5015.4 5101.9 5118.9 5174.6 5070.7 5134.5 5163.3 5172.7 5174.5 4971.4 5000.2 5084.1 5146.0 5149.0 5053.6 5056.0 5060.8 5061.9 5098.3 4924.5 5012.3 5040.1 5057.1 5057.9 5284.4 5358.7 5372.1 5401.9 5407.7 5983.3 6044.5 6080.3 6085.5 6106.7 5798.1 5924.9 6076.5 6105.1 6111.7 5504.1 5578.6 5589.8 5604.5 5627.8 6102.0 6127.6 6133.2 6133.5 6133.7 5684.1 5807.0 5915.4 5978.9 5985.6 5929.0 6026.5 6027.3 6031.6 6080.0 5989.8 5996.2 5996.3 6007.9 6050.2 5746.4 5854.8 5919.5 5998.6 6005.2 4604.7 4605.4 4608.1 4618.2 4638.7 4062.5 4079.1 4084.4 4086.4 4108.8 5399.1 5553.6 5581.4 5701.6 5735.4 6059.2 6087.8 6137.5 6146.3 6150.6 5706.4 5706.4 5708.9 5709.9 5715.9 5018.8 5078.5 5093.6 5174.6 5213.7 6315.3 6331.4 6337.7 6337.7 6349.8 5795.4 6111.0 6112.6 6116.6 6116.8 6108.3 6108.6 6128.0 6137.5 6242.0 5939.5 5945.4 5948.0 5985.1 5995.9 5829.5 5970.3 6027.6 6037.8 6039.2 5782.5 5808.3 5815.8 5886.6 5920.3 5835.8 5876.4 5914.4 5927.5 5954.6 5573.0 5710.7 5750.1 5844.9 5855.4 5933.6 5939.5 5964.6 5969.9 5995.4 5807.2 5815.0 5816.6 5826.9 5877.0 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46442.18 Median:17578.00 stddev:77395.58 (440.3%) stddev-sans-first:77535.97 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: Values: 543.3 582.7 586.2 595.7 605.6 31918.0 39698.2 40370.8 40399.6 40853.8 43921.0 43955.6 44313.0 44403.0 44664.8 7603.5 7670.8 8735.0 8921.6 10261.8 10423.3 10561.9 10568.0 10569.3 10571.1 10513.2 10589.4 10604.0 10606.6 10630.4 7811.3 7996.5 10612.8 10835.9 10841.0 10353.0 10478.8 10510.4 10511.3 10515.0 40505.4 41025.8 41107.0 41139.1 41210.2 3238.0 3299.5 3563.0 3976.9 4134.0 30439.0 30568.2 30622.8 30685.5 30703.7 3332.4 3350.7 3373.0 3465.4 3490.1 271339.0 272333.0 274323.0 274377.0 274668.0 56881.4 57865.7 59294.0 59853.7 60258.4 55206.0 55292.0 55406.4 55495.4 55515.0 15229.3 15291.6 15480.4 15503.7 15519.8 10765.9 10782.5 10790.2 10792.7 10816.1 18940.8 19158.8 19207.0 19213.8 19225.0 7612.4 7774.6 7855.0 7902.8 7931.3 938.4 1033.7 1038.5 1050.0 1133.8 27897.0 28652.4 28733.9 28988.0 29051.9 1008.3 1031.1 1038.9 1054.9 1084.4 14853.9 15280.7 15286.0 15706.8 15934.6 323975.0 329395.0 330768.0 330795.0 331101.0 51883.0 51992.5 52064.7 52105.0 52116.0 1342.7 1359.4 1378.3 1379.7 1385.0 27600.7 28422.9 28582.3 28749.7 28904.4 45042.0 45343.3 45373.8 45410.8 45416.3 262837.0 269695.0 289572.0 296599.0 297882.0 28461.0 28651.7 28816.6 28824.6 28855.0 38128.8 39041.6 39136.2 39464.6 39510.2 35261.5 35709.8 36514.5 36694.0 36766.3 32981.9 36041.3 36381.5 36459.3 36575.5 35953.8 36073.1 36120.5 36143.6 36314.8 30760.2 30940.7 33341.8 33489.5 33719.5 24470.8 24895.8 25075.6 25320.4 25590.0 22:09:22 INFO - 2015-11-13 22:09:22,729 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,730 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28426.77 Median:244751.19 stddev:90471.08 (37.0%) stddev-sans-first:90700.32 22:09:22 INFO - 2015-11-13 22:09:22,730 DEBUG : BROWSER_OUTPUT: Values: 355.4 356.4 357.4 358.0 358.7 14594.6 14628.2 16580.8 16992.9 17740.7 15381.2 16570.4 16675.9 16681.2 17027.0 5233.8 5272.7 5369.1 5369.5 5373.5 3862.4 3979.4 5311.6 5340.5 5836.3 5839.6 5932.1 5962.7 5963.5 5965.8 5453.5 5485.7 5500.9 5504.9 5596.5 5178.7 5264.6 5266.5 5283.8 5290.9 20131.2 20424.6 20705.7 21324.1 21328.7 2079.2 2089.3 2102.3 2187.5 2337.0 12987.7 13057.8 13083.6 13586.4 13655.5 1687.0 1732.5 1765.6 1832.5 1870.6 58622.1 59246.4 60325.4 60491.7 61450.7 9474.8 9716.7 9870.9 9878.7 9908.0 12566.7 12613.0 12630.7 12630.8 12634.6 7248.2 7293.1 7332.6 7427.9 7483.1 7062.7 7087.6 7106.7 7160.7 7173.8 5866.4 5998.5 6000.5 6003.9 6069.9 1605.5 1668.9 1669.6 1723.4 1756.7 880.2 924.0 933.7 982.9 1003.2 11622.3 12772.6 12811.7 12848.6 17239.2 429.1 492.4 495.9 502.0 508.9 6321.4 6587.6 6626.2 6762.2 6781.0 489010.0 536534.0 545728.0 590505.0 594423.0 79943.0 80018.6 81135.0 83535.2 84452.6 498.8 507.1 507.3 508.0 508.1 11079.6 11162.2 11228.9 11293.3 11328.9 36334.8 36430.3 36539.8 36606.8 37383.6 44424.3 47884.5 48272.3 49897.0 50016.7 6822.6 6859.1 6966.1 6976.7 7019.8 12633.4 12802.7 12887.9 12963.7 13006.3 10823.7 10911.3 11034.3 11332.2 11360.7 10370.7 11033.6 11092.8 11102.9 11244.6 8553.5 8731.2 10755.2 11433.2 11558.7 6646.2 6859.3 6897.2 6909.9 6916.1 10819.4 10993.1 11093.7 11113.9 11204.0 22:09:22 INFO - 2015-11-13 22:09:22,730 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,730 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5364.40 Median:6588.66 stddev:2789.68 (42.3%) stddev-sans-first:2783.02 22:09:22 INFO - 2015-11-13 22:09:22,731 DEBUG : BROWSER_OUTPUT: Values: 1581.9 1681.0 1742.1 1758.9 1797.9 6545.6 7603.0 7803.9 7804.8 7823.3 7669.1 7784.3 7787.8 7793.4 7794.1 1930.7 1970.4 2137.6 2237.0 2259.9 2234.6 2247.1 2255.5 2258.3 2258.7 2179.5 2272.4 2272.8 2276.1 2278.7 1949.7 1985.7 2148.5 2219.7 2224.5 2222.9 2246.4 2281.2 2283.8 2285.5 7716.0 7730.1 7774.9 7785.9 7799.6 4330.6 4404.9 4407.4 4419.0 4421.8 2804.3 2807.1 2845.9 2848.2 3006.3 948.8 956.0 961.8 978.0 985.1 9912.7 9919.8 9927.0 9940.1 9941.0 4074.2 4148.8 4182.4 4193.3 4201.2 8594.1 8596.1 8597.4 8609.0 8614.6 4645.8 4652.5 4656.5 4657.6 4660.7 4228.6 4231.3 4232.3 4233.6 4239.2 3675.2 3706.5 3723.3 3726.1 3756.9 1180.4 1190.0 1198.0 1207.4 1218.4 1020.1 1034.9 1035.3 1175.0 1331.6 7290.7 7338.9 7355.3 7388.2 7388.6 478.8 484.4 484.7 489.1 496.8 5711.5 5765.0 5771.7 5775.9 5781.4 8816.3 9078.0 9143.6 9157.4 9165.3 9082.5 9103.1 9106.5 9108.2 9115.4 6883.6 6955.7 7333.4 7402.3 7419.3 7254.1 7296.0 7299.6 7303.1 7303.3 8178.9 8222.1 8302.4 8414.2 8485.4 8457.8 8502.1 8639.6 8640.0 8653.4 6900.1 7022.2 7030.5 7111.6 7114.2 7460.6 7491.7 7504.7 7515.9 7520.4 6940.7 7018.3 7037.9 7157.6 7192.9 6193.0 6630.0 6683.8 6757.5 6914.0 7027.6 7049.2 7074.4 7074.5 7078.6 6482.4 6509.4 6514.2 6516.4 6519.8 6495.7 6580.8 6581.6 6582.3 6595.0 22:09:22 INFO - 2015-11-13 22:09:22,731 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,732 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5343.71 Median:6153.44 stddev:1636.30 (26.6%) stddev-sans-first:1596.87 22:09:22 INFO - 2015-11-13 22:09:22,732 DEBUG : BROWSER_OUTPUT: Values: 321.0 326.1 329.4 329.4 331.8 6007.5 6030.8 6048.6 6101.4 6112.6 5970.5 5988.2 5996.7 6008.2 6010.2 4571.0 4579.2 4582.1 4585.3 4586.6 4516.0 4597.1 4599.5 4600.8 4612.4 4548.9 4550.7 4551.6 4552.5 4555.2 4239.8 4543.9 4553.1 4554.2 4568.6 3704.8 3928.8 3982.0 3989.0 3990.0 5689.1 5702.6 5716.0 5716.3 5722.4 4882.5 5008.2 5176.8 5285.5 5311.1 6317.3 6325.1 6328.2 6331.9 6337.7 4376.7 4385.2 4428.2 4430.5 4433.3 6507.8 6561.8 6564.7 6600.2 6612.7 4515.8 4518.4 4520.1 4523.8 4530.7 4567.2 4576.4 4581.6 4583.6 4587.7 5277.4 5284.6 5286.9 5292.7 5293.3 6242.6 6417.3 6419.7 6421.3 6440.0 1569.5 1580.5 1583.1 1583.7 1584.9 1015.4 1025.0 1026.7 1033.8 1036.6 6194.3 6202.0 6212.8 6213.3 6224.6 6628.3 6633.3 6633.7 6642.2 6642.2 6085.5 6207.8 6211.0 6214.4 6226.3 3571.5 3578.9 3592.4 3598.6 3609.2 6809.0 6838.2 6851.5 6854.5 6856.3 6460.3 6739.8 6741.7 6741.7 6757.2 6410.9 6737.2 6824.6 6849.9 6939.9 6691.3 6693.7 6702.2 6702.5 6710.2 6608.5 6611.6 6625.9 6626.3 6626.7 6684.3 6825.9 6846.6 6853.0 6856.1 4433.2 4438.3 4445.9 4446.4 4452.4 6679.5 6684.0 6685.3 6685.8 6692.9 6374.3 6482.9 6495.1 6500.6 6502.4 6476.6 6478.2 6484.2 6487.8 6494.3 6345.5 6366.2 6368.2 6373.6 6374.3 6332.4 6501.2 6510.7 6514.0 6522.0 6353.5 6358.1 6362.2 6367.9 6371.1 22:09:22 INFO - 2015-11-13 22:09:22,732 DEBUG : BROWSER_OUTPUT: 22:09:22 INFO - 2015-11-13 22:09:22,733 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13045.08 Median:43974.78 stddev:14546.34 (33.1%) stddev-sans-first:14557.71 22:09:22 INFO - 2015-11-13 22:09:22,733 DEBUG : BROWSER_OUTPUT: Values: 723.2 749.6 759.6 772.9 835.7 13587.3 13633.7 13656.9 13689.0 13699.5 12709.2 12720.0 12727.7 12742.1 12804.0 672.4 679.9 797.2 808.2 834.1 820.6 821.8 827.6 827.8 829.4 875.6 875.6 876.3 876.6 877.6 707.6 717.3 850.3 867.6 868.0 640.1 641.2 641.4 643.0 646.8 13107.9 13109.1 13121.7 13126.9 13129.6 11604.3 12785.4 12984.1 13143.5 13180.3 9810.7 9855.1 9861.6 9961.6 10059.7 3489.3 3524.5 3546.2 3556.7 3569.8 47168.7 47858.3 48169.5 48210.0 48221.3 10042.8 10098.4 10152.3 10220.4 10311.1 18263.7 18295.1 18298.0 18304.4 18348.2 7496.6 7517.1 7551.0 7624.9 7661.8 4350.2 4382.1 4474.0 4477.2 4523.3 3072.5 3099.2 3105.1 3108.6 3122.2 450.4 452.3 453.4 468.9 469.7 590.3 607.4 610.1 642.5 651.0 7847.8 7898.8 8057.4 8230.4 8987.1 551.7 566.9 627.5 654.4 669.3 3859.3 4096.3 4102.0 4129.6 4216.2 48873.3 49043.3 49071.0 49290.0 49750.0 43216.6 44109.8 44156.6 44161.6 44177.0 42939.6 43099.6 43778.3 43839.8 45034.8 8105.1 8107.6 8227.3 8319.7 8322.0 33227.3 33690.3 33705.7 33985.8 34220.5 38867.2 41440.2 42420.6 42939.6 42941.1 7562.5 7720.4 7737.8 7768.2 7838.0 12175.5 12217.5 12299.4 12305.9 12465.7 10515.8 10567.9 10636.9 10832.9 11168.1 10747.0 11164.9 11360.0 11430.9 11772.2 10560.3 10608.2 11455.2 11463.9 11786.6 9885.6 10036.8 10052.8 10058.9 10061.6 9116.9 10079.4 10088.4 10099.4 10131.4 22:09:22 INFO - 2015-11-13 22:09:22,733 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:09:22 INFO - 2015-11-13 22:09:22,733 DEBUG : BROWSER_OUTPUT: 22:09:23 INFO - 2015-11-13 22:09:23,409 INFO : Browser exited with error code: 0 22:09:23 INFO - 2015-11-13 22:09:23,428 INFO : Completed test dromaeo_css (00:18:32) 22:09:23 INFO - 2015-11-13 22:09:23,428 INFO : Starting test kraken 22:09:23 INFO - 2015-11-13 22:09:23,428 DEBUG : operating with platform_type : linux_ 22:09:23 INFO - 2015-11-13 22:09:23,428 INFO : Initialising browser for kraken test... 22:09:23 INFO - 2015-11-13 22:09:23,434 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMndAhq/profile http://localhost:58851/getInfo.html 22:09:27 INFO - 2015-11-13 22:09:27,131 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:09:27 INFO - 2015-11-13 22:09:27,131 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:09:27 INFO - 2015-11-13 22:09:27,131 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:09:27 INFO - 2015-11-13 22:09:27,131 DEBUG : BROWSER_OUTPUT: __metrics 22:09:27 INFO - 2015-11-13 22:09:27,293 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:09:28 INFO - 2015-11-13 22:09:28,503 INFO : Browser initialized. 22:09:28 INFO - 2015-11-13 22:09:28,503 INFO : Running cycle 1/1 for kraken test... 22:09:28 INFO - 2015-11-13 22:09:28,503 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMndAhq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:09:40 INFO - 2015-11-13 22:09:40,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 22:09:40 INFO - 2015-11-13 22:09:40,240 DEBUG : BROWSER_OUTPUT: 22:09:42 INFO - 2015-11-13 22:09:42,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection) 22:09:43 INFO - 2015-11-13 22:09:43,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 182513664 22:09:43 INFO - 2015-11-13 22:09:43,291 DEBUG : BROWSER_OUTPUT: 22:09:45 INFO - 2015-11-13 22:09:45,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-dft) 22:09:46 INFO - 2015-11-13 22:09:46,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 172400640 22:09:46 INFO - 2015-11-13 22:09:46,456 DEBUG : BROWSER_OUTPUT: 22:09:49 INFO - 2015-11-13 22:09:49,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-fft) 22:09:49 INFO - 2015-11-13 22:09:49,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 151031808 22:09:49 INFO - 2015-11-13 22:09:49,889 DEBUG : BROWSER_OUTPUT: 22:09:51 INFO - 2015-11-13 22:09:51,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator) 22:09:52 INFO - 2015-11-13 22:09:52,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 153911296 22:09:52 INFO - 2015-11-13 22:09:52,422 DEBUG : BROWSER_OUTPUT: 22:09:54 INFO - 2015-11-13 22:09:54,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:09:55 INFO - 2015-11-13 22:09:55,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 156233728 22:09:55 INFO - 2015-11-13 22:09:55,113 DEBUG : BROWSER_OUTPUT: 22:09:58 INFO - 2015-11-13 22:09:58,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom) 22:09:58 INFO - 2015-11-13 22:09:58,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 156758016 22:09:58 INFO - 2015-11-13 22:09:58,631 DEBUG : BROWSER_OUTPUT: 22:10:02 INFO - 2015-11-13 22:10:02,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate) 22:10:02 INFO - 2015-11-13 22:10:02,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 156901376 22:10:02 INFO - 2015-11-13 22:10:02,635 DEBUG : BROWSER_OUTPUT: 22:10:05 INFO - 2015-11-13 22:10:05,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial) 22:10:05 INFO - 2015-11-13 22:10:05,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 156520448 22:10:05 INFO - 2015-11-13 22:10:05,973 DEBUG : BROWSER_OUTPUT: 22:10:07 INFO - 2015-11-13 22:10:07,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:10:08 INFO - 2015-11-13 22:10:08,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 163217408 22:10:08 INFO - 2015-11-13 22:10:08,074 DEBUG : BROWSER_OUTPUT: 22:10:09 INFO - 2015-11-13 22:10:09,858 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:10:10 INFO - 2015-11-13 22:10:10,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 163905536 22:10:10 INFO - 2015-11-13 22:10:10,460 DEBUG : BROWSER_OUTPUT: 22:10:12 INFO - 2015-11-13 22:10:12,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:10:13 INFO - 2015-11-13 22:10:13,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 175706112 22:10:13 INFO - 2015-11-13 22:10:13,072 DEBUG : BROWSER_OUTPUT: 22:10:15 INFO - 2015-11-13 22:10:15,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:10:16 INFO - 2015-11-13 22:10:16,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 181452800 22:10:16 INFO - 2015-11-13 22:10:16,073 DEBUG : BROWSER_OUTPUT: 22:10:18 INFO - 2015-11-13 22:10:18,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:10:19 INFO - 2015-11-13 22:10:19,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 179941376 22:10:19 INFO - 2015-11-13 22:10:19,209 DEBUG : BROWSER_OUTPUT: 22:10:20 INFO - 2015-11-13 22:10:20,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58851/tests/kraken/driver.html?testName=ai-astar) 22:10:21 INFO - 2015-11-13 22:10:21,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 240091136 22:10:21 INFO - 2015-11-13 22:10:21,145 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,147 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:10:21 INFO - 2015-11-13 22:10:21,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:10:21 INFO - 2015-11-13 22:10:21,147 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:10:21 INFO - 2015-11-13 22:10:21,147 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;108;111;111;98;113;110;109 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;160;169;126;152;150;125;164;124 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;161;163;159;159;160;164;161;161 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;83;91;73;72;72;101;94;72 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;133;90;91;92;137;91;92;132 22:10:21 INFO - 2015-11-13 22:10:21,148 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;110;110;109;110 22:10:21 INFO - 2015-11-13 22:10:21,149 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;144;145;146 22:10:21 INFO - 2015-11-13 22:10:21,149 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;96;96;96;95;95;95 22:10:21 INFO - 2015-11-13 22:10:21,149 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;58;57;60;57;58;64;56;56 22:10:21 INFO - 2015-11-13 22:10:21,149 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;67;68;67;67;67;67;68;67 22:10:21 INFO - 2015-11-13 22:10:21,149 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;84;84;85;84;84;85;83 22:10:21 INFO - 2015-11-13 22:10:21,150 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;127;113;118;116;122;133;118;125;118 22:10:21 INFO - 2015-11-13 22:10:21,150 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;148;148;147;163;138;146;150;146;141 22:10:21 INFO - 2015-11-13 22:10:21,150 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;72;65;65;69;65;65;66;65 22:10:21 INFO - 2015-11-13 22:10:21,150 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:10:21 INFO - 2015-11-13 22:10:21,150 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:10:21 INFO - 2015-11-13 22:10:21,151 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,913 22:10:21 INFO - 2015-11-13 22:10:21,151 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:10:21 INFO - 2015-11-13 22:10:21,151 DEBUG : BROWSER_OUTPUT: __startTimestamp1447481421145__endTimestamp 22:10:21 INFO - 2015-11-13 22:10:21,151 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:111.00 stddev:4.49 (4.0%) stddev-sans-first:4.76 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 108.0 111.0 111.0 98.0 113.0 110.0 109.0 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.00 stddev:17.27 (11.3%) stddev-sans-first:18.05 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 160.0 169.0 126.0 152.0 150.0 125.0 164.0 124.0 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 161.0 163.0 159.0 159.0 160.0 164.0 161.0 161.0 22:10:21 INFO - 2015-11-13 22:10:21,155 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:11.16 (15.3%) stddev-sans-first:11.42 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 83.0 91.0 73.0 72.0 72.0 101.0 94.0 72.0 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:91.00 stddev:20.68 (22.7%) stddev-sans-first:21.38 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 133.0 90.0 91.0 92.0 137.0 91.0 92.0 132.0 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 146.0 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,156 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:2.38 (4.1%) stddev-sans-first:2.49 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 58.0 57.0 60.0 57.0 58.0 64.0 56.0 56.0 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 67.0 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 83.0 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:122.50 stddev:5.93 (4.8%) stddev-sans-first:6.25 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: Values: 123.0 127.0 113.0 118.0 116.0 122.0 133.0 118.0 125.0 118.0 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:147.50 stddev:6.76 (4.6%) stddev-sans-first:6.93 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 148.0 147.0 163.0 138.0 146.0 150.0 146.0 141.0 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,157 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:65.50 stddev:2.36 (3.6%) stddev-sans-first:2.50 22:10:21 INFO - 2015-11-13 22:10:21,158 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 72.0 65.0 65.0 69.0 65.0 65.0 66.0 65.0 22:10:21 INFO - 2015-11-13 22:10:21,158 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:10:21 INFO - 2015-11-13 22:10:21,158 DEBUG : BROWSER_OUTPUT: 22:10:21 INFO - 2015-11-13 22:10:21,973 INFO : Browser exited with error code: 0 22:10:22 INFO - 2015-11-13 22:10:22,030 INFO : Completed test kraken (00:00:58) 22:10:22 INFO - 2015-11-13 22:10:22,030 INFO : Starting test v8_7 22:10:22 INFO - 2015-11-13 22:10:22,030 DEBUG : operating with platform_type : linux_ 22:10:22 INFO - 2015-11-13 22:10:22,030 INFO : Initialising browser for v8_7 test... 22:10:22 INFO - 2015-11-13 22:10:22,036 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhaKne/profile http://localhost:58851/getInfo.html 22:10:25 INFO - 2015-11-13 22:10:25,831 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:10:25 INFO - 2015-11-13 22:10:25,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:10:25 INFO - 2015-11-13 22:10:25,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:10:25 INFO - 2015-11-13 22:10:25,832 DEBUG : BROWSER_OUTPUT: __metrics 22:10:25 INFO - 2015-11-13 22:10:25,973 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:10:27 INFO - 2015-11-13 22:10:27,154 INFO : Browser initialized. 22:10:27 INFO - 2015-11-13 22:10:27,155 INFO : Running cycle 1/1 for v8_7 test... 22:10:27 INFO - 2015-11-13 22:10:27,155 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkhaKne/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:10:38 INFO - 2015-11-13 22:10:38,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 141406208 22:10:38 INFO - 2015-11-13 22:10:38,865 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58851/tests/v8_7/run.html (next: http://localhost:58851/tests/v8_7/run.html) 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 618160128 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:11:00 INFO - 2015-11-13 22:11:00,505 DEBUG : BROWSER_OUTPUT: |0;Richards;163.50555918901242 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.91118867558657 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.8776443682104 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1100.1100110011 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |6;Boyer;11904.761904761905 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |7;RegExp;25250 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |8;Splay;639.2081736909323 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: __startTimestamp1447481460498__endTimestamp 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:11:00 INFO - 2015-11-13 22:11:00,506 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.51 Median:163.51 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: Values: 163.5 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.91 Median:193.91 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: Values: 193.9 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: Values: 285.9 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: Values: 5030.2 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: Values: 1100.1 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,507 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: Values: 795.5 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11904.76 Median:11904.76 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: Values: 11904.8 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25250.00 Median:25250.00 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: Values: 25250.0 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:639.21 Median:639.21 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: Values: 639.2 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: Values: 4835.7 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:11:00 INFO - 2015-11-13 22:11:00,508 DEBUG : BROWSER_OUTPUT: 22:11:01 INFO - 2015-11-13 22:11:01,429 INFO : Browser exited with error code: 0 22:11:01 INFO - 2015-11-13 22:11:01,448 INFO : Completed test v8_7 (00:00:39) 22:11:01 INFO - 2015-11-13 22:11:01,521 INFO : Completed test suite (00:20:10) 22:11:01 INFO - 2015-11-13 22:11:01,522 DEBUG : Working with test: dromaeo_css 22:11:01 INFO - 2015-11-13 22:11:01,522 DEBUG : Generating results file: dromaeo_css 22:11:01 INFO - 2015-11-13 22:11:01,523 DEBUG : Working with test: kraken 22:11:01 INFO - 2015-11-13 22:11:01,523 DEBUG : Generating results file: kraken 22:11:01 INFO - 2015-11-13 22:11:01,523 INFO : javascript benchmark 22:11:01 INFO - 2015-11-13 22:11:01,524 DEBUG : Working with test: v8_7 22:11:01 INFO - 2015-11-13 22:11:01,524 DEBUG : Generating results file: v8_7 22:11:01 INFO - 2015-11-13 22:11:01,524 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:11:01 INFO - 2015-11-13 22:11:01,578 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:11:01 INFO - 2015-11-13 22:11:01,578 DEBUG : process_Request line: dromaeo_css 6856.25 graph.html#tests=[[72,1,35]] 22:11:01 INFO - 2015-11-13 22:11:01,578 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:11:01 INFO - 2015-11-13 22:11:01,604 DEBUG : process_Request line: kraken 1493.20 graph.html#tests=[[232,1,35]] 22:11:01 INFO - 2015-11-13 22:11:01,604 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:11:01 INFO - 2015-11-13 22:11:01,632 DEBUG : process_Request line: v8_7 21013.62 graph.html#tests=[[230,1,35]] 22:11:01 INFO - 2015-11-13 22:11:01,633 INFO : javascript benchmark 22:11:01 INFO - 2015-11-13 22:11:01,637 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [355.39937505615507, 356.44572689467884, 357.43168362303965, 357.98210089495535, 358.7112374538496, 14594.635134121652, 14628.195449250314, 16580.751288730662, 16992.91503542482, 17740.733888991675, 15381.230938453089, 16570.42003529877, 16675.91551056118, 16681.249343779527, 17027.0, 5233.816816411417, 5272.6836389816735, 5369.114096174127, 5369.5167434930845, 5373.462653734615, 3862.4206369044728, 3979.4229836673667, 5311.62818602698, 5340.465953404668, 5836.328822185439, 5839.649621022731, 5932.11018347247, 5962.672053037081, 5963.522918166536, 5965.761369545213, 5453.536449401806, 5485.670859748428, 5500.944990550103, 5504.944950550524, 5596.468335508121, 5178.741062946875, 5264.6314757966575, 5266.4733526647415, 5283.841484755463, 5290.867728306823, 20131.194752209893, 20424.591508169902, 20705.68941465879, 21324.147034118618, 21328.680069798964, 2079.178724403852, 2089.310527525928, 2102.3167470572125, 2187.4859408039097, 2336.995092110392, 12987.675308117277, 13057.80413293792, 13083.607491775261, 13586.38861251246, 13655.522056727967, 1686.9746953795702, 1732.4629364896796, 1765.62921786425, 1832.4594244697846, 1870.560418301698, 58622.120668190015, 59246.40753592452, 60325.39674603286, 60491.697541512454, 61450.692746535984, 9474.810503789886, 9716.708498745049, 9870.901290986998, 9878.703638890845, 9907.999999999856, 12566.685832854251, 12613.0, 12630.684232894067, 12630.789611817896, 12634.557790477289, 7248.202697703248, 7293.124825021031, 7332.633368331562, 7427.925720742724, 7483.13943896448, 7062.6821793019435, 7087.574745515286, 7106.71573137079, 7160.711072006985, 7173.820654483576, 5866.354700982888, 5998.49012833914, 6000.519958403317, 6003.879922401527, 6069.939300607026, 1605.5022942887742, 1668.9165541722866, 1669.5826043489128, 1723.4398820383426, 1756.7162688504893, 880.2473884828507, 924.0, 933.6872147830417, 982.8673129127476, 1003.2124782046059, 11622.302661840316, 12772.61682149537, 12811.679708007188, 12848.550300739429, 17239.22423490946, 429.13743375814835, 492.3869782121282, 495.88098856274235, 501.96988180709275, 508.8804131029205, 6321.399467050623, 6587.571807832475, 6626.204855417284, 6762.222344430454, 6780.982852572055, 489010.0, 536534.0, 545728.0, 590505.0, 594423.0, 79943.0, 80018.5999070001, 81135.0, 83535.16464835395, 84452.57773711215, 498.82042464712674, 507.12520901445447, 507.2745973258276, 507.98984020319386, 508.12602324002654, 11079.612213572485, 11162.218644694793, 11228.943855280671, 11293.265937714023, 11328.886711132784, 36334.81832590926, 36430.27139457143, 36539.817300913324, 36606.816965915, 37383.626163738016, 44424.33363499615, 47884.521154788, 48272.275915861996, 49897.00205995787, 50016.749916250184, 6822.590644561342, 6859.142607174103, 6966.12923384577, 6976.720931162697, 7019.754308599175, 12633.431495582538, 12802.67993300175, 12887.93556032214, 12963.740725185255, 13006.284654344103, 10823.67528974132, 10911.290766100496, 11034.337939723322, 11332.206745528063, 11360.715982100513, 10370.740731481774, 11033.613823516138, 11092.833607495733, 11102.944485277521, 11244.55021799119, 8553.529555874487, 8731.214190722865, 10755.247132700635, 11433.1996760226, 11558.653240402802, 6646.169228846395, 6859.348361905611, 6897.206821215424, 6909.896351554831, 6916.066331045245, 10819.350838949687, 10993.119357276366, 11093.667189984313, 11113.944430277797, 11204.047655949336], "dojo.html": [3231.9676803231964, 3297.8021318720894, 3327.650596687348, 3341.398548261312, 3349.4305967985447, 5412.648177868436, 5498.945010549894, 5542.0855558832745, 5558.194061861032, 5565.582581306408, 5515.779368825252, 5559.471850174227, 5564.137558678402, 5569.693666848321, 5703.201551782754, 4984.22744474607, 5015.398152221738, 5101.948980510185, 5118.9488105119035, 5174.637775355726, 5070.670406423571, 5134.460881607433, 5163.302954101205, 5172.715500647463, 5174.4825517448335, 4971.4034315882145, 5000.174971129759, 5084.0594490019275, 5146.0, 5149.0, 5053.646244762868, 5055.974720126376, 5060.772265248036, 5061.949380506185, 5098.337216161875, 4924.4583095859425, 5012.27322038306, 5040.143175660147, 5057.115004874169, 5057.924131138036, 5284.4187139414635, 5358.705271210082, 5372.140457526816, 5401.945980540184, 5407.729613519308, 5983.311919129313, 6044.516438684895, 6080.300765411946, 6085.5435842312, 6106.694665266719, 5798.10129429939, 5924.911126333109, 6076.4834989025985, 6105.053716673922, 6111.694415279263, 5504.119340905476, 5578.553715702734, 5589.8323050308145, 5604.495595396434, 5627.803026894039, 6102.0, 6127.571070025056, 6133.205558217569, 6133.478654314434, 6133.693315334215, 5684.118961560965, 5807.0, 5915.387867784199, 5978.880422391615, 5985.581009329305, 5928.970355148283, 6026.457618814327, 6027.30685971119, 6031.638101713911, 6080.027195648675, 5989.790357337472, 5996.190514280516, 5996.340402555716, 6007.909881351783, 6050.2437195350585, 5746.367899531048, 5854.765809367577, 5919.526437884959, 5998.610090344114, 6005.159277701126, 4604.723716577016, 4605.355250264965, 4608.101420223024, 4618.168729628699, 4638.721676699409, 4062.512498500199, 4079.102597428561, 4084.4281800547947, 4086.3666131749033, 4108.815103320358, 5399.1091469907815, 5553.611247212737, 5581.441855814386, 5701.600887937804, 5735.397783232784, 6059.242594675666, 6087.756489740449, 6137.539684523678, 6146.323904370515, 6150.630962142286, 5706.3722990471015, 5706.400827913092, 5708.914366284509, 5709.885802284014, 5715.942840571541, 5018.774155163026, 5078.492150784966, 5093.643444958891, 5174.560162386239, 5213.7393130343335, 6315.336889626615, 6331.398517140957, 6337.7148028337915, 6337.746490140435, 6349.809505714744, 5795.449432303924, 6110.9833754861675, 6112.602680825732, 6116.633002019893, 6116.816495505142, 6108.342071131425, 6108.623263290827, 6128.0, 6137.539684523768, 6242.0, 5939.524838013035, 5945.40545945402, 5948.048312270016, 5985.102234664835, 5995.940040599538, 5829.504492118048, 5970.253718285215, 6027.57806953509, 6037.849053773691, 6039.184710064261, 5782.45066718661, 5808.30300363959, 5815.76736930518, 5886.646801191942, 5920.259967504062, 5835.766569337349, 5876.41235876409, 5914.378990205966, 5927.525797936241, 5954.553408494294, 5572.972135139298, 5710.743016564347, 5750.0512415450985, 5844.883102338014, 5855.385184555731, 5933.584649074523, 5939.46544810969, 5964.612300200473, 5969.880602388015, 5995.430434108753, 5807.157962095388, 5815.04051831443, 5816.592838501264, 5826.854328641648, 5876.970615147068], "mootools.html": [1581.9446319378824, 1681.0, 1742.1115231232072, 1758.900687070581, 1797.8831375960563, 6545.607263564183, 7603.0496187976505, 7803.921960780398, 7804.843903121934, 7823.3350165236025, 7669.079710434742, 7784.338331241851, 7787.805304867367, 7793.415493837956, 7794.103678077023, 1930.6814375628076, 1970.4088773368003, 2137.6045431595203, 2236.9888150559264, 2259.89830457629, 2234.6089434349005, 2247.0674670011927, 2255.5150642611834, 2258.3337915314937, 2258.7176602924633, 2179.4769255378756, 2272.36373815332, 2272.7954484096426, 2276.1009401286483, 2278.7493375728654, 1949.7465329507215, 1985.6525108106096, 2148.4628842789225, 2219.7225346831647, 2224.5217278285086, 2222.8888555572316, 2246.359787460582, 2281.2471884278316, 2283.8058765004994, 2285.531466049456, 7715.961420192863, 7730.072391313022, 7774.883376749353, 7785.883211751771, 7799.610019499002, 4330.631896288788, 4404.933925991113, 4407.382966384709, 4419.0, 4421.823127074913, 2804.2568719289407, 2807.1297897651793, 2845.9146225613263, 2848.2025032990587, 3006.2634654509566, 948.8149810786899, 956.0439560439561, 961.7932144588947, 977.9608815647366, 985.069109691342, 9912.702618921443, 9919.752006199831, 9926.950365248127, 9940.10539051489, 9940.950295248549, 4074.2055299216368, 4148.834046638161, 4182.351735480945, 4193.30810416284, 4201.222773786859, 8594.097619749837, 8596.054434012254, 8597.441166324168, 8609.0, 8614.569271536398, 4645.814167433333, 4652.511486293958, 4656.534346565317, 4657.580817726353, 4660.743659098782, 4228.5982831630945, 4231.280682284019, 4232.25935461293, 4233.576642335804, 4239.236937351307, 3675.209829886587, 3706.5181526401393, 3723.255348930225, 3726.06848287928, 3756.9436458453147, 1180.3685028509879, 1189.9940500297444, 1197.9820302695466, 1207.3600991474532, 1218.3542722357165, 1020.0717347213999, 1034.8809886863107, 1035.295998720877, 1174.976500469986, 1331.5539294336506, 7290.744823931137, 7338.853222935618, 7355.338019578264, 7388.187299397062, 7388.593627350439, 478.82762205605957, 484.44531011991074, 484.68495477938916, 489.1098201273719, 496.76900241387926, 5711.514521265656, 5764.971175144097, 5771.6537007778825, 5775.8556036099435, 5781.421857814269, 8816.250618697355, 9077.954610227038, 9143.63425462974, 9157.404768690014, 9165.266778657691, 9082.545872706338, 9103.135202155785, 9106.544672766335, 9108.180263776292, 9115.407498512708, 6883.552569082994, 6955.65221738911, 7333.413326933833, 7402.259774022662, 7419.332260096618, 7254.093238345207, 7296.0, 7299.598522081336, 7303.050603421521, 7303.269673032654, 8178.918210818054, 8222.054463736747, 8302.377321700777, 8414.158584141536, 8485.448445851, 8457.788555286166, 8502.14978502145, 8639.568021598769, 8640.0, 8653.350998674998, 6900.137482814648, 7022.157341118894, 7030.50786444944, 7111.60886151246, 7114.181869084914, 7460.552366858006, 7491.700331986877, 7504.662290197063, 7515.924840751522, 7520.360769334449, 6940.687669055005, 7018.298170182941, 7037.929620703932, 7157.57054576727, 7192.928070719226, 6193.040078787795, 6629.966850165912, 6683.83290417724, 6757.493188010821, 6913.965430172817, 7027.578345299094, 7049.224585295511, 7074.3633073023675, 7074.504784665024, 7078.646067696697, 6482.448991835747, 6509.381608747161, 6514.218293804774, 6516.380943810331, 6519.8044058678315, 6495.707693153914, 6580.80257592273, 6581.638009909501, 6582.275949645439, 6595.043718660863], "ext.html": [543.3045701502077, 582.6766144789641, 586.208618365207, 595.6842873277164, 605.6093819486434, 31918.0, 39698.206035879266, 40370.7981460093, 40399.59600403995, 40853.7957310213, 43921.0, 43955.560444395545, 44313.0, 44403.0, 44664.77667611658, 7603.505772124794, 7670.7698769037015, 8734.956325218365, 8921.59852806622, 10261.79476410475, 10423.322484038514, 10561.894381056169, 10568.048875601233, 10569.260151789378, 10571.101456376216, 10513.211509136807, 10589.364638121699, 10604.0, 10606.575736970512, 10630.415327157003, 7811.257930496622, 7996.480228785169, 10612.840807387895, 10835.891641083646, 10841.024307812257, 10353.0, 10478.79042419155, 10510.369377837354, 10511.316764410289, 10515.0, 40505.392419113734, 41025.794871025755, 41106.9723256921, 41139.14873830655, 41210.1757964842, 3238.0, 3299.4555898276753, 3562.9643703562892, 3976.920461590781, 4133.9793301033305, 30439.0, 30568.235794105327, 30622.84688576543, 30685.539716904263, 30703.692963070305, 3332.4001679697644, 3350.71518920892, 3373.0, 3465.4455287154187, 3490.127468132967, 271339.0, 272333.0, 274323.0, 274377.0, 274668.0, 56881.431185687616, 57865.71067144637, 59294.0, 59853.70073149694, 60258.39741602616, 55206.0, 55292.0, 55406.445935540934, 55495.44504554984, 55515.0, 15229.314680839389, 15291.61770955735, 15480.380784768708, 15503.689926201412, 15519.767203491956, 10765.892341076646, 10782.514786834612, 10790.24468287228, 10792.676219713421, 10816.134709223243, 18940.81059189418, 19158.808411915703, 19207.0, 19213.807861921483, 19225.0, 7612.429067819825, 7774.572398518136, 7855.0, 7902.841943161105, 7931.286184243446, 938.4463166731662, 1033.7415646088477, 1038.46000079958, 1050.0077426831572, 1133.7732453509166, 27897.0, 28652.426951460853, 28733.856330718212, 28988.0, 29051.85474072616, 1008.3395376028712, 1031.1441503552035, 1038.8857225705317, 1054.8681414823147, 1084.4144162152506, 14853.925730371278, 15280.694386112216, 15286.006409583342, 15706.764398534031, 15934.60163495922, 323975.0, 329395.0, 330768.0, 330795.0, 331101.0, 51883.0, 51992.48007519952, 52064.739676301375, 52105.0, 52116.0, 1342.6710455938162, 1359.3611002828654, 1378.255741899383, 1379.661982814217, 1384.9653758656113, 27600.723992760617, 28422.85788571044, 28582.285442864093, 28749.71250287554, 28904.421911562073, 45042.0, 45343.31985020293, 45373.773131134134, 45410.77294613506, 45416.318755219356, 262837.0, 269695.0, 289572.0, 296599.0, 297882.0, 28461.0, 28651.713482864903, 28816.567751483326, 28824.567631485126, 28855.0, 38128.809355953046, 39041.609583903795, 39136.2172756549, 39464.60535394609, 39510.2097958045, 35261.47107793334, 35709.82145089258, 36514.452283216306, 36694.0, 36766.264674705824, 32981.86082487069, 36041.279174416886, 36381.454278185316, 36459.27081458409, 36575.45136822897, 35953.82023089868, 36073.0981725459, 36120.4581931266, 36143.63856361508, 36314.8184259077, 30760.230994225323, 30940.69059309468, 33341.83329083339, 33489.497657534666, 33719.4942075874, 24470.755292446847, 24895.751042489344, 25075.576612383575, 25320.366990825376, 25590.0], "prototype.html": [320.9935801283974, 326.09183424163695, 329.4021351247485, 329.4235088594959, 331.8291080093751, 6007.4593286604195, 6030.819075427733, 6048.576599638027, 6101.389861013897, 6112.633242005483, 5970.462658360747, 5988.191594134791, 5996.670183139926, 6008.1888944992415, 6010.188624535686, 4570.954290457103, 4579.152856721509, 4582.1064892346, 4585.335126406669, 4586.610138138246, 4515.954840451603, 4597.103564804865, 4599.494055653875, 4600.792964316597, 4612.3542704021465, 4548.931766023512, 4550.68145229834, 4551.567601077909, 4552.476465206494, 4555.24838401665, 4239.830406783725, 4543.886402839939, 4553.134904368176, 4554.157480866033, 4568.611668008223, 3704.814759262026, 3928.7839168845703, 3981.9601803981877, 3988.960110398888, 3990.022444501116, 5689.118186681071, 5702.600817942745, 5716.0, 5716.256886604757, 5722.427757224286, 4882.487338829443, 5008.248762685626, 5176.767045482962, 5285.471452854722, 5311.123664595337, 6317.273513545955, 6325.114483972247, 6328.208973878265, 6331.936680633181, 6337.651429171394, 4376.737395756265, 4385.188740083095, 4428.180786554498, 4430.468343798765, 4433.290673492225, 6507.804765857032, 6561.80314590563, 6564.671766411708, 6600.174978127734, 6612.7354905804195, 4515.774211289422, 4518.373385581188, 4520.0507893342765, 4523.84166554169, 4530.705504142286, 4567.2007398705755, 4576.382188404523, 4581.633469322513, 4583.610393116623, 4587.72473651582, 5277.419483856773, 5284.550813180923, 5286.9471305287225, 5292.708901010481, 5293.258943747878, 6242.625442473466, 6417.262014868256, 6419.679016049272, 6421.325760795143, 6440.0, 1569.4977607165827, 1580.4942418426224, 1583.1371902313267, 1583.7228485015075, 1584.9128297943723, 1015.4161357219629, 1024.9743756406149, 1026.6868605075524, 1033.7984093101772, 1036.6164519127972, 6194.256689197326, 6201.96899015502, 6212.81361559154, 6213.347598502182, 6224.564280500322, 6628.304028077079, 6633.313508029256, 6633.7346506140175, 6642.202935647753, 6642.236142843538, 6085.482733967662, 6207.81376558704, 6210.968945155245, 6214.40963108504, 6226.346233645492, 3571.499990001402, 3578.946315805265, 3592.4072528033103, 3598.586162591283, 3609.224016836393, 6809.0, 6838.1794184697155, 6851.492671612237, 6854.5201835872, 6856.348646878539, 6460.289368169498, 6739.797806065826, 6741.696623651849, 6741.696623651947, 6757.222919364238, 6410.935890641033, 6737.157855268091, 6824.624645644537, 6849.931500685029, 6939.93060069403, 6691.330866913465, 6693.698783554654, 6702.19573651165, 6702.463802895854, 6710.16122984627, 6608.537402381787, 6611.570247933869, 6625.933740662532, 6626.304238054935, 6626.668666566556, 6684.298148694317, 6825.931740682729, 6846.554973926679, 6853.0405743195, 6856.142982127234, 4433.2463481208915, 4438.312061630452, 4445.888852778707, 4446.377507148937, 4452.3544086106685, 6679.532432729662, 6683.966580167263, 6685.33146685347, 6685.76599819004, 6692.933070669231, 6374.330695276929, 6482.935170648233, 6495.123158373748, 6500.609963402211, 6502.414782669583, 6476.643784591893, 6478.222613286436, 6484.157059582224, 6487.772927947688, 6494.253160886558, 6345.524085693683, 6366.204224471941, 6368.172137622079, 6373.5857169283845, 6374.29882712892, 6332.366763323815, 6501.187351581052, 6510.707018184098, 6514.022896565553, 6522.021696745526, 6353.491720662243, 6358.141650877073, 6362.236531616236, 6367.9044814328745, 6371.139896113966], "yui.html": [723.2225357740429, 749.5952185819658, 759.5632511306001, 772.9149793522715, 835.6949713354624, 13587.252701101448, 13633.727325453485, 13656.931715341409, 13689.0, 13699.520516781915, 12709.173903696254, 12720.0, 12727.681807954807, 12742.108052436333, 12804.0, 672.3982036077707, 679.8912174052152, 797.1629788721833, 808.1514409869613, 834.090840983328, 820.6389188756958, 821.7781199076246, 827.606886728805, 827.755812035448, 829.3821103278036, 875.6322344615277, 875.6497401039571, 876.2726936642604, 876.583622779178, 877.5612193903048, 707.6391040569321, 717.28630013137, 850.26452118917, 867.5748883047324, 868.0234735922088, 640.0846789091597, 641.1504756198057, 641.4066988036049, 642.9517786166057, 646.83182372583, 13107.934460327733, 13109.082364234508, 13121.737565248737, 13126.934365328112, 13129.606111816565, 11604.303741775437, 12785.360731963365, 12984.091113622051, 13143.539976100887, 13180.275084870329, 9810.656627018092, 9855.113039826378, 9861.556229969668, 9961.551730172087, 10059.69820905374, 3489.319582681378, 3524.488949102366, 3546.2375589248177, 3556.6798988091195, 3569.803660798655, 47168.72793724822, 47858.28212576814, 48169.518304817204, 48210.0, 48221.27668084981, 10042.849357259647, 10098.444585547719, 10152.340097893613, 10220.386776793417, 10311.1235544978, 18263.72604410935, 18295.08524573766, 18298.0, 18304.359347422775, 18348.174332155086, 7496.58768767723, 7517.097948246136, 7550.962245188739, 7624.852477628948, 7661.808454788675, 4350.151720414488, 4382.101669157815, 4473.977630111829, 4477.238869392211, 4523.32150177476, 3072.5083986562045, 3099.2406860319365, 3105.0840002199407, 3108.585593554927, 3122.2350524121734, 450.37173143464685, 452.27861560810453, 453.43094416507734, 468.94607120181615, 469.73459995102655, 590.2680675961863, 607.4290167242777, 610.124471383566, 642.502060902804, 650.9772157974448, 7847.803804904809, 7898.842023159619, 8057.435979481497, 8230.382721295926, 8987.146221108984, 551.6572000178286, 566.8554518597731, 627.5074066857586, 654.4142992022114, 669.270495160268, 3859.2667393195766, 4096.32410652245, 4102.0, 4129.566395528486, 4216.219999300078, 48873.26690099651, 49043.26435103476, 49071.0, 49290.0, 49750.0, 43216.56783432188, 44109.77945110318, 44156.558434415885, 44161.558384416385, 44177.0, 42939.57060429418, 43099.569004310186, 43778.34332485015, 43839.78080109579, 45034.77482612631, 8105.108438071925, 8107.594620269081, 8227.259546640831, 8319.708810191856, 8322.0, 33227.335453291285, 33690.32619347648, 33705.66294337124, 33985.830070849486, 34220.48669269913, 38867.222655547295, 41440.1711965753, 42420.57579424166, 42939.570604293556, 42941.141177176905, 7562.470627056274, 7720.382369410546, 7737.767866964, 7768.184340644151, 7837.960810195913, 12175.452104655134, 12217.45021474018, 12299.385030748248, 12305.876941230832, 12465.688357791129, 10515.842262366225, 10567.894321056998, 10636.8936310639, 10832.945835270773, 11168.050715689258, 10747.0, 11164.944175279072, 11360.0, 11430.885691142983, 11772.234804737665, 10560.313579617608, 10608.151347892304, 11455.198136130392, 11463.885361146282, 11786.58746943853, 9885.55515001841, 10036.799264014824, 10052.84920726175, 10058.899411006088, 10061.647842325483, 9116.908830911607, 10079.445630490394, 10088.445135517324, 10099.394036357842, 10131.442770647685]}, "summary": {"lowerIsBetter": false, "suite": 6856.256354571077, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7960.301295268826, "unit": "ms", "value": 7960.301295268826}, "dojo.html": {"lowerIsBetter": false, "filtered": 5524.372153024366, "unit": "ms", "value": 5524.372153024366}, "mootools.html": {"lowerIsBetter": false, "filtered": 4327.573751517786, "unit": "ms", "value": 4327.573751517786}, "ext.html": {"lowerIsBetter": false, "filtered": 18677.1427346659, "unit": "ms", "value": 18677.1427346659}, "prototype.html": {"lowerIsBetter": false, "filtered": 4803.101212529106, "unit": "ms", "value": 4803.101212529106}, "yui.html": {"lowerIsBetter": false, "filtered": 6084.076733184104, "unit": "ms", "value": 6084.076733184104}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1447480251, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113193129", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 161.0, 163.0, 159.0, 159.0, 160.0, 164.0, 161.0, 161.0], "ai-astar": [108.0, 111.0, 103.0, 108.0, 111.0, 111.0, 98.0, 113.0, 110.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "audio-beat-detection": [154.0, 132.0, 160.0, 169.0, 126.0, 152.0, 150.0, 125.0, 164.0, 124.0], "json-stringify-tinderbox": [67.0, 69.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0], "stanford-crypto-pbkdf2": [142.0, 148.0, 148.0, 147.0, 163.0, 138.0, 146.0, 150.0, 146.0, 141.0], "json-parse-financial": [57.0, 58.0, 58.0, 57.0, 60.0, 57.0, 58.0, 64.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 65.0, 72.0, 65.0, 65.0, 69.0, 65.0, 65.0, 66.0, 65.0], "audio-fft": [72.0, 73.0, 83.0, 91.0, 73.0, 72.0, 72.0, 101.0, 94.0, 72.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 146.0], "stanford-crypto-ccm": [123.0, 127.0, 113.0, 118.0, 116.0, 122.0, 133.0, 118.0, 125.0, 118.0], "audio-oscillator": [91.0, 92.0, 133.0, 90.0, 91.0, 92.0, 137.0, 91.0, 92.0, 132.0], "stanford-crypto-aes": [84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 83.0], "imaging-desaturate": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1493.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.3, "unit": "ms", "value": 80.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.3, "unit": "ms", "value": 121.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.0, "unit": "ms", "value": 145.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.1, "unit": "ms", "value": 58.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.2, "unit": "ms", "value": 108.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.3, "unit": "ms", "value": 66.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.4, "unit": "ms", "value": 67.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.1, "unit": "ms", "value": 84.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.5, "unit": "ms", "value": 95.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1447480251, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113193129", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.91118867558657], "Encrypt": [285.8776443682104], "NavierStokes": [4835.748792270531], "Decrypt": [5030.150753768844], "Splay": [639.2081736909323], "Richards": [163.50555918901242], "RegExp": [25250.0], "Earley": [795.5449482895783], "Boyer": [11904.761904761905], "RayTrace": [1100.1100110011]}, "summary": {"lowerIsBetter": false, "suite": 21013.621221216927, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.97052599999995, "unit": "score", "value": 340.97052599999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 931.1011380000001, "unit": "score", "value": 931.1011380000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 127.48741858141854, "unit": "score", "value": 127.48741858141854}, "RegExp": {"lowerIsBetter": false, "filtered": 36.07861386138617, "unit": "score", "value": 36.07861386138617}, "Richards": {"lowerIsBetter": false, "filtered": 215.90703200000004, "unit": "score", "value": 215.90703200000004}, "Earley": {"lowerIsBetter": false, "filtered": 837.743991, "unit": "score", "value": 837.743991}, "Boyer": {"lowerIsBetter": false, "filtered": 55.98289200000003, "unit": "score", "value": 55.98289200000003}, "RayTrace": {"lowerIsBetter": false, "filtered": 672.6500009999999, "unit": "score", "value": 672.6500009999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-060"}, "testrun": {"date": 1447480251, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113193129", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}] 22:11:01 INFO - RETURN: dromaeo_css: 6856.25 22:11:01 INFO - RETURN: kraken: 1493.20 22:11:01 INFO - RETURN: v8_7: 21013.62 22:11:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21013.62"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6856.25"}}} 22:11:01 INFO - Return code: 0 22:11:01 INFO - # TBPL SUCCESS # 22:11:01 INFO - Running post-action listener: _resource_record_post_action 22:11:01 INFO - Running post-run listener: _resource_record_post_run 22:11:02 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508715008; Read time: 152; Write time: 503312 22:11:02 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 228503552; Read time: 0; Write time: 350180 22:11:02 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280199168; Read time: 152; Write time: 153132 22:11:02 INFO - Running post-run listener: _upload_blobber_files 22:11:02 INFO - Blob upload gear active. 22:11:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:11:02 INFO - Copying logs to upload dir... 22:11:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.502943 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-13 22:11:01.944029) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:11:01.951120) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009612 build_url: 'https://queue.taskcluster.net/v1/task/RnrE0exNQIa5C1XYwj_oEw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:11:01.979243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:11:01.982821) ========= 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=49ca1b5d70b54a29b055e1ff000001bd-1447474775.301162-975332446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:11:02.035772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:11:02.036179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:11:02.036506) ========= ========= Total master_lag: 0.41 =========