builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1448286037.7 results: success (0) buildid: 20151123030237 builduid: 933d95c3f7ec4a1382a9e13a65e28a4a revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.700361) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.700762) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.701052) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009173 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.735008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.735373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.818884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.819134) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.965700) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.965994) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.966367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:37.966668) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 05:40:38-- 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% 47.5M=0s 2015-11-23 05:40:38 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.109707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.109996) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022330 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:38.159884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 05:40:38.160238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --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 8b1fc0961a076e35646d0472a81feefc0074558c --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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 05:40:38,690 truncating revision to first 12 chars 2015-11-23 05:40:38,690 Setting DEBUG logging. 2015-11-23 05:40:38,691 attempt 1/10 2015-11-23 05:40:38,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 05:40:39,526 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.108841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 05:40:39.282368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:39.282821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:39.291393) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:39.291742) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 05:40:39.292217) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 05:40:39.292532) ========= /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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:39 INFO - MultiFileLogger online at 20151123 05:40:39 in /builds/slave/test-pgo 05:40:39 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 05:40:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:40:39 INFO - {'append_to_log': False, 05:40:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:40:39 INFO - 'blob_upload_branch': 'Firefox', 05:40:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:40:39 INFO - 'branch': 'Firefox', 05:40:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:39 INFO - 'config_files': ('talos/linux_config.py',), 05:40:39 INFO - 'default_actions': ('clobber', 05:40:39 INFO - 'read-buildbot-config', 05:40:39 INFO - 'download-and-extract', 05:40:39 INFO - 'populate-webroot', 05:40:39 INFO - 'create-virtualenv', 05:40:39 INFO - 'install', 05:40:39 INFO - 'run-tests'), 05:40:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:39 INFO - 'download_minidump_stackwalk': True, 05:40:39 INFO - 'download_symbols': 'ondemand', 05:40:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:39 INFO - 'installer_path': 'installer.exe', 05:40:39 INFO - 'log_level': 'info', 05:40:39 INFO - 'log_name': 'talos', 05:40:39 INFO - 'log_to_console': True, 05:40:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:39 INFO - 'opt_config_files': (), 05:40:39 INFO - 'pip_index': False, 05:40:39 INFO - 'sps_profile': False, 05:40:39 INFO - 'sps_profile_interval': 0, 05:40:39 INFO - 'suite': 'dromaeojs', 05:40:39 INFO - 'system_bits': '64', 05:40:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:39 INFO - 'title': 'talos-linux64-ix-017', 05:40:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:39 INFO - 'use_talos_json': True, 05:40:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:40:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:39 INFO - 'work_dir': 'build'} 05:40:39 INFO - ##### 05:40:39 INFO - ##### Running clobber step. 05:40:39 INFO - ##### 05:40:39 INFO - Running pre-action listener: _resource_record_pre_action 05:40:39 INFO - Running main action method: clobber 05:40:39 INFO - rmtree: /builds/slave/test-pgo/build 05:40:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:40:40 INFO - Running post-action listener: _resource_record_post_action 05:40:40 INFO - ##### 05:40:40 INFO - ##### Running read-buildbot-config step. 05:40:40 INFO - ##### 05:40:40 INFO - Running pre-action listener: _resource_record_pre_action 05:40:40 INFO - Running main action method: read_buildbot_config 05:40:40 INFO - Using buildbot properties: 05:40:40 INFO - { 05:40:40 INFO - "properties": { 05:40:40 INFO - "buildnumber": 575, 05:40:40 INFO - "product": "firefox", 05:40:40 INFO - "script_repo_revision": "production", 05:40:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:40:40 INFO - "repository": "", 05:40:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:40:40 INFO - "buildid": "20151123030237", 05:40:40 INFO - "slavename": "talos-linux64-ix-017", 05:40:40 INFO - "stage_platform": "linux64-pgo", 05:40:40 INFO - "basedir": "/builds/slave/test-pgo", 05:40:40 INFO - "nightly_build": "True", 05:40:40 INFO - "project": "", 05:40:40 INFO - "platform": "ubuntu64_hw", 05:40:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:40:40 INFO - "slavebuilddir": "test", 05:40:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "branch": "mozilla-central", 05:40:40 INFO - "repo_path": "mozilla-central", 05:40:40 INFO - "pgo_build": "True", 05:40:40 INFO - "builduid": "933d95c3f7ec4a1382a9e13a65e28a4a", 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - }, 05:40:40 INFO - "sourcestamp": { 05:40:40 INFO - "repository": "", 05:40:40 INFO - "hasPatch": false, 05:40:40 INFO - "project": "", 05:40:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "changes": [ 05:40:40 INFO - { 05:40:40 INFO - "category": null, 05:40:40 INFO - "files": [ 05:40:40 INFO - { 05:40:40 INFO - "url": null, 05:40:40 INFO - "name": "https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:40:40 INFO - } 05:40:40 INFO - ], 05:40:40 INFO - "repository": "", 05:40:40 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 05:40:40 INFO - "who": "sendchange", 05:40:40 INFO - "when": 1448285996, 05:40:40 INFO - "number": 6694869, 05:40:40 INFO - "comments": "", 05:40:40 INFO - "project": "", 05:40:40 INFO - "at": "Mon 23 Nov 2015 05:39:56", 05:40:40 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:40:40 INFO - "revlink": "", 05:40:40 INFO - "properties": [ 05:40:40 INFO - [ 05:40:40 INFO - "buildid", 05:40:40 INFO - "20151123030237", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "builduid", 05:40:40 INFO - "933d95c3f7ec4a1382a9e13a65e28a4a", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "nightly_build", 05:40:40 INFO - "True", 05:40:40 INFO - "Change" 05:40:40 INFO - ], 05:40:40 INFO - [ 05:40:40 INFO - "pgo_build", 05:40:40 INFO - "True", 05:40:40 INFO - "Change" 05:40:40 INFO - ] 05:40:40 INFO - ], 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - } 05:40:40 INFO - ], 05:40:40 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 05:40:40 INFO - } 05:40:40 INFO - } 05:40:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:40:40 INFO - Running post-action listener: _resource_record_post_action 05:40:40 INFO - ##### 05:40:40 INFO - ##### Running download-and-extract step. 05:40:40 INFO - ##### 05:40:40 INFO - Running pre-action listener: _resource_record_pre_action 05:40:40 INFO - Running main action method: download_and_extract 05:40:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:40 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json 05:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json 05:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:40:41 INFO - Downloaded 1302 bytes. 05:40:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:40:41 INFO - Using the following test package requirements: 05:40:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'jsshell-linux-x86_64.zip'], 05:40:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:41 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:43 INFO - Downloaded 22524652 bytes. 05:40:43 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 05:40:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:43 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 05:40:44 INFO - Return code: 0 05:40:44 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 05:40:44 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')]} 05:40:44 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:54 INFO - Downloaded 22524652 bytes. 05:40:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:40:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:40:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:40:55 INFO - Return code: 0 05:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:55 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:56 INFO - Downloaded 11130997 bytes. 05:40:56 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 05:40:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:56 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 05:40:56 INFO - Return code: 0 05:40:56 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')]} 05:40:56 INFO - https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/num10TDNR0Oy9tiryNnSRw/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 05:40:59 INFO - Downloaded 57453419 bytes. 05:40:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:59 INFO - mkdir: /builds/slave/test-pgo/properties 05:40:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:40:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:40:59 INFO - Contents: 05:40:59 INFO - build_url:https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:40:59 INFO - Running post-action listener: _resource_record_post_action 05:40:59 INFO - Running post-action listener: set_extra_try_arguments 05:40:59 INFO - ##### 05:40:59 INFO - ##### Running populate-webroot step. 05:40:59 INFO - ##### 05:40:59 INFO - Running pre-action listener: _resource_record_pre_action 05:40:59 INFO - Running main action method: populate_webroot 05:40:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:40:59 INFO - '../fennec_ids.txt'], 05:40:59 INFO - 'tests': ['tcheck2']}, 05:40:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:59 INFO - '--tppagecycles', 05:40:59 INFO - '7'], 05:40:59 INFO - 'tests': ['tsvgm']}}, 05:40:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:40:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'tests': ['damp', 'tps']}, 05:40:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['damp', 'tps']}, 05:40:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:40:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:59 INFO - 'other': {'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'other_l64': {'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:40:59 INFO - 'ts_paint', 05:40:59 INFO - 'tpaint', 05:40:59 INFO - 'sessionrestore', 05:40:59 INFO - 'sessionrestore_no_auto_restore']}, 05:40:59 INFO - 'svgr': {'tests': ['tsvgx', 05:40:59 INFO - 'tsvgr_opacity', 05:40:59 INFO - 'tart', 05:40:59 INFO - 'tscrollx', 05:40:59 INFO - 'cart']}, 05:40:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['tsvgx', 05:40:59 INFO - 'tsvgr_opacity', 05:40:59 INFO - 'tart', 05:40:59 INFO - 'tscrollx', 05:40:59 INFO - 'cart']}, 05:40:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'tests': ['tp5o']}, 05:40:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'talos_options': ['--e10s'], 05:40:59 INFO - 'tests': ['tp5o']}, 05:40:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'talos_options': ['--xperf_path', 05:40:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:59 INFO - 'tests': ['tp5n']}, 05:40:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:59 INFO - 'talos_options': ['--e10s', 05:40:59 INFO - '--xperf_path', 05:40:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:59 INFO - 'tests': ['tp5n']}}, 05:40:59 INFO - 'talos.zip': {'path': '', 05:40:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:59 INFO - Running post-action listener: _resource_record_post_action 05:40:59 INFO - ##### 05:40:59 INFO - ##### Running create-virtualenv step. 05:40:59 INFO - ##### 05:40:59 INFO - Running pre-action listener: _resource_record_pre_action 05:40:59 INFO - Running main action method: create_virtualenv 05:40:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:40:59 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 05:40:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:40:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:59 INFO - Using real prefix '/usr' 05:40:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:41:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:02 INFO - Installing pip.................done. 05:41:02 INFO - Return code: 0 05:41:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:41:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:41:02 INFO - Using env: {'DISPLAY': ':0', 05:41:02 INFO - 'HOME': '/home/cltbld', 05:41:02 INFO - 'LANG': 'en_US.UTF-8', 05:41:02 INFO - 'LANGUAGE': 'en_US:en', 05:41:02 INFO - 'LOGNAME': 'cltbld', 05:41:02 INFO - 'MAIL': '/var/mail/cltbld', 05:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:02 INFO - 'MOZ_NO_REMOTE': '1', 05:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:02 INFO - 'NO_EM_RESTART': '1', 05:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:02 INFO - 'SHELL': '/bin/bash', 05:41:02 INFO - 'SHLVL': '1', 05:41:02 INFO - 'TERM': 'linux', 05:41:02 INFO - 'TMOUT': '86400', 05:41:02 INFO - 'USER': 'cltbld', 05:41:02 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:02 INFO - '_': '/tools/buildbot/bin/python'} 05:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:02 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 05:41:02 INFO - Cleaning up... 05:41:02 INFO - Return code: 0 05:41:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:41:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:41:02 INFO - Using env: {'DISPLAY': ':0', 05:41:02 INFO - 'HOME': '/home/cltbld', 05:41:02 INFO - 'LANG': 'en_US.UTF-8', 05:41:02 INFO - 'LANGUAGE': 'en_US:en', 05:41:02 INFO - 'LOGNAME': 'cltbld', 05:41:02 INFO - 'MAIL': '/var/mail/cltbld', 05:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:02 INFO - 'MOZ_NO_REMOTE': '1', 05:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:02 INFO - 'NO_EM_RESTART': '1', 05:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:02 INFO - 'SHELL': '/bin/bash', 05:41:02 INFO - 'SHLVL': '1', 05:41:02 INFO - 'TERM': 'linux', 05:41:02 INFO - 'TMOUT': '86400', 05:41:02 INFO - 'USER': 'cltbld', 05:41:02 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:02 INFO - '_': '/tools/buildbot/bin/python'} 05:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:02 INFO - Downloading/unpacking psutil>=0.7.1 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:04 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:41:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:41:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:04 INFO - Installing collected packages: psutil 05:41:04 INFO - Running setup.py install for psutil 05:41:04 INFO - building 'psutil._psutil_linux' extension 05:41:04 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 05:41:04 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 05:41:04 INFO - building 'psutil._psutil_posix' extension 05:41:04 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 05:41:04 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 05:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:04 INFO - Successfully installed psutil 05:41:04 INFO - Cleaning up... 05:41:04 INFO - Return code: 0 05:41:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:41:04 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')]} 05:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 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')]} 05:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:04 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 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:04 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 05:41:04 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 05:41:04 INFO - Using env: {'DISPLAY': ':0', 05:41:04 INFO - 'HOME': '/home/cltbld', 05:41:04 INFO - 'LANG': 'en_US.UTF-8', 05:41:04 INFO - 'LANGUAGE': 'en_US:en', 05:41:04 INFO - 'LOGNAME': 'cltbld', 05:41:04 INFO - 'MAIL': '/var/mail/cltbld', 05:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:04 INFO - 'MOZ_NO_REMOTE': '1', 05:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:04 INFO - 'NO_EM_RESTART': '1', 05:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:04 INFO - 'SHELL': '/bin/bash', 05:41:04 INFO - 'SHLVL': '1', 05:41:04 INFO - 'TERM': 'linux', 05:41:04 INFO - 'TMOUT': '86400', 05:41:04 INFO - 'USER': 'cltbld', 05:41:04 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:04 INFO - '_': '/tools/buildbot/bin/python'} 05:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:41:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:41:06 INFO - Installing collected packages: mozsystemmonitor 05:41:06 INFO - Running setup.py install for mozsystemmonitor 05:41:06 INFO - Successfully installed mozsystemmonitor 05:41:06 INFO - Cleaning up... 05:41:06 INFO - Return code: 0 05:41:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:06 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 05:41:06 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 05:41:06 INFO - Using env: {'DISPLAY': ':0', 05:41:06 INFO - 'HOME': '/home/cltbld', 05:41:06 INFO - 'LANG': 'en_US.UTF-8', 05:41:06 INFO - 'LANGUAGE': 'en_US:en', 05:41:06 INFO - 'LOGNAME': 'cltbld', 05:41:06 INFO - 'MAIL': '/var/mail/cltbld', 05:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:06 INFO - 'MOZ_NO_REMOTE': '1', 05:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:06 INFO - 'NO_EM_RESTART': '1', 05:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:06 INFO - 'SHELL': '/bin/bash', 05:41:06 INFO - 'SHLVL': '1', 05:41:06 INFO - 'TERM': 'linux', 05:41:06 INFO - 'TMOUT': '86400', 05:41:06 INFO - 'USER': 'cltbld', 05:41:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:06 INFO - '_': '/tools/buildbot/bin/python'} 05:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:41:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:41:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:41:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:09 INFO - Downloading docopt-0.6.1.tar.gz 05:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:41:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:09 INFO - Running setup.py install for blobuploader 05:41:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:41:09 INFO - Running setup.py install for requests 05:41:09 INFO - Running setup.py install for docopt 05:41:10 INFO - Successfully installed blobuploader requests docopt 05:41:10 INFO - Cleaning up... 05:41:10 INFO - Return code: 0 05:41:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:41:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:10 INFO - Using env: {'DISPLAY': ':0', 05:41:10 INFO - 'HOME': '/home/cltbld', 05:41:10 INFO - 'LANG': 'en_US.UTF-8', 05:41:10 INFO - 'LANGUAGE': 'en_US:en', 05:41:10 INFO - 'LOGNAME': 'cltbld', 05:41:10 INFO - 'MAIL': '/var/mail/cltbld', 05:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:10 INFO - 'MOZ_NO_REMOTE': '1', 05:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:10 INFO - 'NO_EM_RESTART': '1', 05:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:10 INFO - 'SHELL': '/bin/bash', 05:41:10 INFO - 'SHLVL': '1', 05:41:10 INFO - 'TERM': 'linux', 05:41:10 INFO - 'TMOUT': '86400', 05:41:10 INFO - 'USER': 'cltbld', 05:41:10 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:10 INFO - '_': '/tools/buildbot/bin/python'} 05:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:10 INFO - Running setup.py (path:/tmp/pip-vCYz5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:10 INFO - Running setup.py (path:/tmp/pip-vJx7RU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:10 INFO - Running setup.py (path:/tmp/pip-rnlv6S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:10 INFO - Running setup.py (path:/tmp/pip-zKxXcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:10 INFO - Running setup.py (path:/tmp/pip-HPpDeU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:10 INFO - Running setup.py (path:/tmp/pip-VI5cmF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:10 INFO - Running setup.py (path:/tmp/pip-_k7RgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:10 INFO - Running setup.py (path:/tmp/pip-m10lcu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:10 INFO - Running setup.py (path:/tmp/pip-si8MoZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:10 INFO - Running setup.py (path:/tmp/pip-wKwfav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:11 INFO - Running setup.py (path:/tmp/pip-YdL6fO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:11 INFO - Running setup.py (path:/tmp/pip-iphbiq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:11 INFO - Running setup.py (path:/tmp/pip-XH20WV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:11 INFO - Running setup.py (path:/tmp/pip-_HDV7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:11 INFO - Running setup.py (path:/tmp/pip-7k3ppe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:11 INFO - Running setup.py (path:/tmp/pip-iJaW7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:11 INFO - Running setup.py (path:/tmp/pip-wwAm_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:11 INFO - Running setup.py install for manifestparser 05:41:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:41:11 INFO - Running setup.py install for mozcrash 05:41:11 INFO - Running setup.py install for mozdebug 05:41:11 INFO - Running setup.py install for mozdevice 05:41:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:41:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:41:11 INFO - Running setup.py install for mozfile 05:41:12 INFO - Running setup.py install for mozhttpd 05:41:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozinfo 05:41:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozInstall 05:41:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozleak 05:41:12 INFO - Running setup.py install for mozlog 05:41:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for moznetwork 05:41:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozprocess 05:41:12 INFO - Running setup.py install for mozprofile 05:41:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozrunner 05:41:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:41:12 INFO - Running setup.py install for mozscreenshot 05:41:13 INFO - Running setup.py install for moztest 05:41:13 INFO - Running setup.py install for mozversion 05:41:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:41:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:13 INFO - Cleaning up... 05:41:13 INFO - Return code: 0 05:41:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41: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')]} 05:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41: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')]} 05:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:13 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 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:13 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 05:41:13 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 05:41:13 INFO - Using env: {'DISPLAY': ':0', 05:41:13 INFO - 'HOME': '/home/cltbld', 05:41:13 INFO - 'LANG': 'en_US.UTF-8', 05:41:13 INFO - 'LANGUAGE': 'en_US:en', 05:41:13 INFO - 'LOGNAME': 'cltbld', 05:41:13 INFO - 'MAIL': '/var/mail/cltbld', 05:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:13 INFO - 'MOZ_NO_REMOTE': '1', 05:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:13 INFO - 'NO_EM_RESTART': '1', 05:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:13 INFO - 'SHELL': '/bin/bash', 05:41:13 INFO - 'SHLVL': '1', 05:41:13 INFO - 'TERM': 'linux', 05:41:13 INFO - 'TMOUT': '86400', 05:41:13 INFO - 'USER': 'cltbld', 05:41:13 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:13 INFO - '_': '/tools/buildbot/bin/python'} 05:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:13 INFO - Running setup.py (path:/tmp/pip-0IlNsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:13 INFO - Running setup.py (path:/tmp/pip-Xg9uBK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:13 INFO - Running setup.py (path:/tmp/pip-7CJPyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:13 INFO - Running setup.py (path:/tmp/pip-6xIXVX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:13 INFO - Running setup.py (path:/tmp/pip-7Kh2Qg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:13 INFO - Running setup.py (path:/tmp/pip-TlBzKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:41:13 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)) 05:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:13 INFO - Running setup.py (path:/tmp/pip-kko5Au-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:14 INFO - Running setup.py (path:/tmp/pip-6vK_3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:14 INFO - Running setup.py (path:/tmp/pip-UeYEaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:14 INFO - Running setup.py (path:/tmp/pip-sVb_Kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:14 INFO - Running setup.py (path:/tmp/pip-F_jS7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:14 INFO - Running setup.py (path:/tmp/pip-2Qvz60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:14 INFO - Running setup.py (path:/tmp/pip-KnbplS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:14 INFO - Running setup.py (path:/tmp/pip-Sal9rk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:14 INFO - Running setup.py (path:/tmp/pip-bxAgT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:14 INFO - Running setup.py (path:/tmp/pip-tdocOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:41:14 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)) 05:41:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:14 INFO - Running setup.py (path:/tmp/pip-fuWZ8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:41:14 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)) 05:41:14 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)) 05:41:14 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)) 05:41:14 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)) 05:41:14 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)) 05:41:14 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)) 05:41:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:14 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 05:41:16 INFO - Downloading blessings-1.5.1.tar.gz 05:41:16 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 05:41:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:41:16 INFO - Installing collected packages: blessings 05:41:16 INFO - Running setup.py install for blessings 05:41:16 INFO - Successfully installed blessings 05:41:16 INFO - Cleaning up... 05:41:16 INFO - Return code: 0 05:41:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:41:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:16 INFO - Reading from file tmpfile_stdout 05:41:16 INFO - Current package versions: 05:41:16 INFO - argparse == 1.2.1 05:41:16 INFO - blessings == 1.5.1 05:41:16 INFO - blobuploader == 1.2.4 05:41:16 INFO - docopt == 0.6.1 05:41:16 INFO - manifestparser == 1.1 05:41:16 INFO - mozInstall == 1.12 05:41:16 INFO - mozcrash == 0.16 05:41:16 INFO - mozdebug == 0.1 05:41:16 INFO - mozdevice == 0.47 05:41:16 INFO - mozfile == 1.2 05:41:16 INFO - mozhttpd == 0.7 05:41:16 INFO - mozinfo == 0.9 05:41:16 INFO - mozleak == 0.1 05:41:16 INFO - mozlog == 3.0 05:41:16 INFO - moznetwork == 0.27 05:41:16 INFO - mozprocess == 0.22 05:41:16 INFO - mozprofile == 0.27 05:41:16 INFO - mozrunner == 6.11 05:41:16 INFO - mozscreenshot == 0.1 05:41:16 INFO - mozsystemmonitor == 0.0 05:41:16 INFO - moztest == 0.7 05:41:16 INFO - mozversion == 1.4 05:41:16 INFO - psutil == 3.1.1 05:41:16 INFO - requests == 1.2.3 05:41:16 INFO - wsgiref == 0.1.2 05:41:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:41:16 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')]} 05:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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')]} 05:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:16 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 0x7fefd6254c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x167c7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, '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': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', '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 05:41:16 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 05:41:16 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 05:41:16 INFO - Using env: {'DISPLAY': ':0', 05:41:16 INFO - 'HOME': '/home/cltbld', 05:41:16 INFO - 'LANG': 'en_US.UTF-8', 05:41:16 INFO - 'LANGUAGE': 'en_US:en', 05:41:16 INFO - 'LOGNAME': 'cltbld', 05:41:16 INFO - 'MAIL': '/var/mail/cltbld', 05:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:16 INFO - 'MOZ_NO_REMOTE': '1', 05:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:16 INFO - 'NO_EM_RESTART': '1', 05:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:16 INFO - 'SHELL': '/bin/bash', 05:41:16 INFO - 'SHLVL': '1', 05:41:16 INFO - 'TERM': 'linux', 05:41:16 INFO - 'TMOUT': '86400', 05:41:16 INFO - 'USER': 'cltbld', 05:41:16 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:16 INFO - '_': '/tools/buildbot/bin/python'} 05:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:41:17 INFO - Cleaning up... 05:41:17 INFO - Return code: 0 05:41:17 INFO - Running post-action listener: _resource_record_post_action 05:41:17 INFO - Running post-action listener: _start_resource_monitoring 05:41:17 INFO - Starting resource monitoring. 05:41:17 INFO - ##### 05:41:17 INFO - ##### Running install step. 05:41:17 INFO - ##### 05:41:17 INFO - Running pre-action listener: _resource_record_pre_action 05:41:17 INFO - Running main action method: install 05:41:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:41:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:41:17 INFO - Reading from file tmpfile_stdout 05:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:41:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:41:17 INFO - Reading from file tmpfile_stdout 05:41:17 INFO - Output received: 05:41:17 INFO - Usage: mozinstall [options] installer 05:41:17 INFO - Options: 05:41:17 INFO - -h, --help show this help message and exit 05:41:17 INFO - -d DEST, --destination=DEST 05:41:17 INFO - Directory to install application into. [default: 05:41:17 INFO - "/builds/slave/test-pgo"] 05:41:17 INFO - --app=APP Application being installed. [default: firefox] 05:41:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:41:17 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'] 05:41:17 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 05:41:32 INFO - Reading from file tmpfile_stdout 05:41:32 INFO - Output received: 05:41:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:41:32 INFO - Running post-action listener: _resource_record_post_action 05:41:32 INFO - ##### 05:41:32 INFO - ##### Running run-tests step. 05:41:32 INFO - ##### 05:41:32 INFO - Running pre-action listener: _resource_record_pre_action 05:41:32 INFO - Running main action method: run_tests 05:41:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:41:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:41:32 INFO - Python 2.7.3 05:41:32 INFO - Return code: 0 05:41:32 INFO - grabbing minidump binary from tooltool 05:41: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')]} 05:41:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c0d70>, '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 0x16c1b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c1fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:41:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:41:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:41:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:32 INFO - Return code: 0 05:41:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:41:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:41:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:41:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:41:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 05:41:32 INFO - Using env: {'DISPLAY': ':0', 05:41:32 INFO - 'HOME': '/home/cltbld', 05:41:32 INFO - 'LANG': 'en_US.UTF-8', 05:41:32 INFO - 'LANGUAGE': 'en_US:en', 05:41:32 INFO - 'LOGNAME': 'cltbld', 05:41:32 INFO - 'MAIL': '/var/mail/cltbld', 05:41:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:32 INFO - 'MOZ_NO_REMOTE': '1', 05:41:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:32 INFO - 'NO_EM_RESTART': '1', 05:41:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:41:32 INFO - 'SHELL': '/bin/bash', 05:41:32 INFO - 'SHLVL': '1', 05:41:32 INFO - 'TERM': 'linux', 05:41:32 INFO - 'TMOUT': '86400', 05:41:32 INFO - 'USER': 'cltbld', 05:41:32 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822', 05:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:32 INFO - '_': '/tools/buildbot/bin/python'} 05:41:32 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/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 05:41:32 INFO - mozversion INFO | application_buildid: 20151123030237 05:41:32 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 05:41:32 INFO - mozversion INFO | application_display_name: Nightly 05:41:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:32 INFO - mozversion INFO | application_name: Firefox 05:41:32 INFO - mozversion INFO | application_remotingname: firefox 05:41:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:41:32 INFO - mozversion INFO | application_vendor: Mozilla 05:41:32 INFO - mozversion INFO | application_version: 45.0a1 05:41:32 INFO - mozversion INFO | platform_buildid: 20151123030237 05:41:32 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 05:41:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:41:32 INFO - mozversion INFO | platform_version: 45.0a1 05:41:32 INFO - 2015-11-23 05:41:32,375 DEBUG : using testdate: 1448286092 05:41:32 INFO - 2015-11-23 05:41:32,375 DEBUG : actual date: 1448286092 05:41:32 INFO - 2015-11-23 05:41:32,384 INFO : starting webserver on 'localhost:57340' 05:41:32 INFO - 2015-11-23 05:41:32,385 INFO : Starting test suite talos-linux64-ix-017 05:41:32 INFO - 2015-11-23 05:41:32,385 INFO : Starting test dromaeo_css 05:41:32 INFO - 2015-11-23 05:41:32,385 DEBUG : operating with platform_type : linux_ 05:41:32 INFO - 2015-11-23 05:41:32,386 INFO : Initialising browser for dromaeo_css test... 05:41:32 INFO - 2015-11-23 05:41:32,402 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplGnsI8/profile http://localhost:57340/getInfo.html 05:41:35 INFO - 2015-11-23 05:41:35,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:41:35 INFO - 2015-11-23 05:41:35,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:41:35 INFO - 2015-11-23 05:41:35,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:41:35 INFO - 2015-11-23 05:41:35,936 DEBUG : BROWSER_OUTPUT: __metrics 05:41:36 INFO - 2015-11-23 05:41:36,039 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:37 INFO - 2015-11-23 05:41:37,223 INFO : Browser initialized. 05:41:37 INFO - 2015-11-23 05:41:37,224 INFO : Running cycle 1/1 for dromaeo_css test... 05:41:37 INFO - 2015-11-23 05:41:37,224 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplGnsI8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:41:49 INFO - 2015-11-23 05:41:49,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 139210752 05:41:49 INFO - 2015-11-23 05:41:49,015 DEBUG : BROWSER_OUTPUT: 05:42:40 INFO - 2015-11-23 05:42:40,594 DEBUG : BROWSER_OUTPUT: 1448286160590 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] 05:44:49 INFO - 2015-11-23 05:44:49,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57340/tests/dromaeo/cssquery-ext.html) 05:44:50 INFO - 2015-11-23 05:44:50,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 269008896 05:44:50 INFO - 2015-11-23 05:44:50,769 DEBUG : BROWSER_OUTPUT: 05:47:53 INFO - 2015-11-23 05:47:53,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-ext.html (next: http://localhost:57340/tests/dromaeo/cssquery-jquery.html) 05:47:53 INFO - 2015-11-23 05:47:53,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 219758592 05:47:53 INFO - 2015-11-23 05:47:53,937 DEBUG : BROWSER_OUTPUT: 05:50:55 INFO - 2015-11-23 05:50:55,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57340/tests/dromaeo/cssquery-mootools.html) 05:50:56 INFO - 2015-11-23 05:50:56,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 214810624 05:50:56 INFO - 2015-11-23 05:50:56,461 DEBUG : BROWSER_OUTPUT: 05:53:58 INFO - 2015-11-23 05:53:58,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57340/tests/dromaeo/cssquery-prototype.html) 05:53:58 INFO - 2015-11-23 05:53:58,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 201773056 05:53:58 INFO - 2015-11-23 05:53:58,859 DEBUG : BROWSER_OUTPUT: 05:57:01 INFO - 2015-11-23 05:57:01,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57340/tests/dromaeo/cssquery-yui.html) 05:57:01 INFO - 2015-11-23 05:57:01,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 205783040 05:57:01 INFO - 2015-11-23 05:57:01,897 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/dromaeo/cssquery-yui.html (next: http://localhost:57340/tests/dromaeo/cssquery-dojo.html) 06:00:04 INFO - 2015-11-23 06:00:04,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 260509696 06:00:04 INFO - 2015-11-23 06:00:04,667 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,668 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:00:04 INFO - 2015-11-23 06:00:04,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:00:04 INFO - 2015-11-23 06:00:04,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:00:04 INFO - 2015-11-23 06:00:04,668 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:00:04 INFO - 2015-11-23 06:00:04,672 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3215.4694475411557;3263.55941947837;3275.459549174386;3281.9835900820494;3309.4373956427403;5322.840314790563;5443.346798384195;5463.890722185554;5482.780688772445;5507.9449205507935;5397.055515284829;5457.699826509541;5457.781688732446;5472.097103977849;5562.0266453370705;4940.654154209215;4954.281629163769;4980.601551875841;4980.950190498085;5019.774110165033;4826.444958829745;5003.949960500403;5013.523715247045;5014.24786282057;5093.134167191568;4784.3780308559835;4888;4903.779329930162;4915.705057696514;4992.425871024824;4980.82567110153;4982.402111746577;4989.401271847365;4989.600831933473;5036.722980236085;4873.488283730228;4925.26121081837;4935.185694360426;4935.703857768545;5008.12357837377;5239.1093514102695;5306.575473962073;5359.705216213107;5380.811671591515;5403.243545903577;5982.0727787193055;6003.759849606011;6011.008183649737;6018;6023.578349515536;5735.512481439083;5941.732622032019;6020.157177995085;6044.153818465418;6049.637021778707;5473.425290344497;5539.362973258047;5546.55627549795;5548.4174161713245;5598.10430331145;6033.18551995475;6057.818265452043;6082;6087.1173679816175;6133.815985520441;5648.039833228361;5714.314282286152;5776.480116789509;5889.234399528034;5926.051831706906;5807.070868661079;5938.317093534212;5982;5982.790602328898;5986.790462333797;5889.4993925515955;5896.086106653475;5896.439838215363;5903.58674892762;5905.793297234576;5803.564732645069;5900.675462849585;5901.557383196277;5904.76380944766;5920.940790592125;4384.167008268419;4514.32285157229;4530.77346132692;4535.160995215896;4541.205289074464;4004.019015341202;4009.939850902239;4033.415154802537;4040.797960102042;4052.1490486997473;5512.779488820403;5572.331320241516;5577.9163312550345;5579.7489112990015;5630.071038278638;5690.231818704505;5789.478946894799;5795.94204057954;5799.739011744482;5972.820815375546;5588.944110558842;5590.0496915523645;5590.273264475592;5594.356648985337;5596;5125.051865404837;5131.281620573122;5132.076226279306;5140.126178549655;5173.586113110942;5870.090136028923;5975.492083172892;5975.940240597625;5979.342272350038;6105.6947152641305;5799.942000580109;5804.796832111025;5807.303123625192;5812.21535092757;5814.360420353673;5969.52243820502;5971.790987315423;5976.820695379146;5978.850528736816;5982.1325907744;5608.355039170548;5788.884222315614;5806.854828629318;5917.142014407973;5968.522518198447;5994.67029313392;6000.369961154016;6029.939700603113;6035.78874739382;6037.939620603738;5698.373178950229;5848.2689663792025;5869.7945571904775;5873.911891321548;5875.41245875409;5698.515626171656;5781.913271300849;5803.187553742395;5825.271841019872;5834.649921004583;5651.491365777099;5666.716664166693;5666.943330566642;5670.262865827416;5674.120511320587;5625.662460252398;5784.913226301693;5788.507976822018;5799.971000144972;5802.94197058024;5472.179173124063;5525.640833345819;5553.028220061554;5587.3015873015875;5638.4925356718095 06:00:04 INFO - 2015-11-23 06:00:04,675 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.7934853778372;567.7473524281694;570.8002199230268;594.4679511836904;596.8746563221723;31965.68034319656;32582;32611.347773044527;32615.1846203845;40148.79925600375;43994.78002609991;44920;45055.32417013747;45133.77433112838;45151.322730158994;8795.956020219906;8967.103289671013;8974.641014359418;8976.147266009719;8978.191962723353;7712.652930618107;7853.842923141534;8593.484390936532;8648.35137364697;10606.204534659932;10486.528106235237;10587.470626468685;10589.364638121699;10606.363618182895;10612.628558000471;10315.948420257888;10391.896081039205;10395.480225988671;10405.583776648926;10409.479526023668;7839.921600783976;8020.077691065544;10619.469026548719;10881.945590271998;10901.1279097672;40022;40141;40152;40370.394444083366;40451.19097618061;3289.9342013159844;3344;3368.427367347557;3703.6481534254203;4070.941555195641;30338.49718537886;30538.847305763553;31021.84489077563;31136.844315778504;31714.207144821332;3823.598522155189;3854.1713531590563;3885.339492286318;3907.2185562887253;3966.4050392441077;285635;287406;288342;288560;289238.9999999979;51392;51742.22386664203;58628.085208496304;58658;59136.19933707679;61408;61850.69074654598;62144.68927655333;62347.688261559306;62449.68775156095;15387.461438849587;15639.921800390925;15648.374065037271;15665.843341566666;15674.216289185495;10827.24209305341;10842.566297348176;10845.457727113613;10853.511591978222;10882.61910833117;19204.356856782324;19431.611367772566;19505.902470487556;19529;19542.609147816966;7314.414846812242;7438.834252818439;7477.588732619758;7493.175750667422;7553.5845528495365;915.8168366326628;918.7519369770125;954.4750387286964;996.4270544436832;1027.2244455436248;28862.71137288642;28871;29015.564766528518;29258;29272.26819329534;1025.2054657640388;1044.4725413666201;1079.7995796352195;1119.2745664307438;1123.455124264731;14870.776938345933;15077.54767356981;15218.543443696706;15392.692146157015;15395.153266570445;314988;320613;320657;320754;321743;54826.45173548293;55005.44994550003;55116.44883551193;55129.448705512434;55143.172852407246;1282.5190553542423;1295.352323838081;1295.6760809797552;1353.4653811744306;1353.8510763815973;25979;28432;29464;29572.704272956995;30609.23476913095;48232;48779.75610121927;48785.268220976;48854;48857;278383;278406;279419;279550;281294.5935270311;27098.32254193661;27876.30309242285;30727.385452291277;31127.22181945379;31952;38215.23569528538;38623.227535449696;38893.22213555656;38956.2208755829;39206;32721.672783271864;33050.504242435905;33076;33192.668073319925;36140.27719445649;31006.0698179055;33178.17054573655;34379.65620343765;37139.628603713616;37279.254414912095;33543.664563354054;36247.09382265464;36855.81572092122;36984.445233320985;36991.07522311856;28512.57231141576;30773.8461307701;31322.06033818989;31475.37049259048;31479.84260078685;25209.49581008333;25240;25350.1127460538;25638.487230255665;25845 06:00:04 INFO - 2015-11-23 06:00:04,677 DEBUG : BROWSER_OUTPUT: |2;jquery.html;349.2752538482649;352.95235143255655;361.9927601447972;362.69714788151896;362.7261417629689;13751.58745237642;14033.158010519375;16539.00765954042;16578.253978570963;17098.999999999985;16072.758908616352;16290.26693798779;16694.58263543412;17012.064336461488;17045.829541704577;5270.446603106667;5397.298351214336;5399.919001214985;5416.4312747161575;5418.756155972971;4027;4147.294959856831;5290.867728306804;5820.301563812349;5974.163617093589;5858.619189752674;5891.617044892089;5893.58744887858;5896.557758168133;5953.077273022667;5693.117566777156;5810.767569297223;5825.679587622679;5829.912551311733;5844.094165404369;5184.040952423814;5190.7404629768735;5195;5201.40183878855;5203.453637368098;12359.38203089842;12475.625731228078;12722.427490762939;12730.17253878495;20502.794972050237;1997.950051248716;2036.3992622176493;2050.4668786115717;2080.3966849613744;2113.4188098272944;9619.27855410847;10496.475176241234;12837;12962.870371296262;13336.666583335396;1777.8844375115575;1872.4663470910725;1898.9081278264914;1993.511589660528;1998.15078591598;54781.178282325796;58651.70674146602;59982.70008649929;60791.696041519506;60892.999999999556;10360.792784144274;10383.532741026673;10444.172269852745;10463.476826158661;10503.579856805794;13495.662608434868;13566;13589.456421743218;13600.659983500294;13641.181529108286;7333.523320984119;7352;7373.852522949618;7386.889196662054;7412.962935185397;6627.569208001561;6651;6949.235584085746;6967.93032069683;6995.615241161785;4433.379326894237;4457.286834106528;4460.174867649431;4499.257622492252;4508.639308855284;1677.9412720554722;1738.9217485213196;1746.868984826143;1796.092973048602;1823.6535058338873;852.3522123186423;871.9346049046347;886.3131073418152;970.8301047316692;1075.2741899217997;16218.837811621968;16313.184340782913;16614.169291535374;16718.582035448966;16884.662306754042;827.8178800663844;877.8244351129799;910.0080911806164;941.5104145844259;962.43216502264;7297.3432391084;9524.666636667822;9608.807823843485;9625.470599117116;9715.902840971641;533476;545728;547617;548053;577746;84457.57771211104;84744.57627711946;85106.57446712727;85931;86103;1098.593520397458;1107.3355986408092;1108.695108845058;1110.5946329589804;1113.7271368514766;14892.702145957237;14896.85103148998;14989.175595342362;14993.925030375214;15080.321385537896;34455.827720861234;34814;34954.825225873705;35378;35675.28649427049;46655.53344466512;48158.27762583494;49122;49401.50598494113;50055.49944500509;9778.315517913677;9926.057024582653;9960.701178964642;9971.152452041657;10093.091621754078;17348.306067757654;17382.304707811545;18100.909495452437;18158.91046537212;18227.179776910336;14611.561653150422;14611.780823287872;14637.194954277616;14857.47998820036;15280.847191527942;13710.451581936612;14043.859561404255;14152.716945661236;14840.18378989166;14973.401063957319;12327.568535101587;12514.624561262812;12779.424925878544;14328.49850255236;15048.097114173184;9525.285603579621;9672.371295865747;9770.609175633179;9882.802343953224;9883.802323953338;13119.409626567018;14336.856631433553;14743.041702289316;15048.097114173184;15400.15299158557 06:00:04 INFO - 2015-11-23 06:00:04,680 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.2206509192122;1673.4393978017363;1701.7022021146297;1722.1045056570583;1746.799118101418;6667.166604174478;7079.61062141582;7270.382017528504;7271.200167981525;7280.38116760076;7395.260473952616;7501.3623841973495;7503.962480187605;7506.437017223703;7507.662155203016;2269.5574362999264;2286.9542609147807;2291.140822191678;2292.4039749665126;2292.4154340643195;2312.8612283262974;2334.7781960713705;2342.0631747301045;2343.7070366204225;2345.2026311054237;2295.9655605165935;2305.1931823861682;2307.515421761432;2322.7909488146065;2337.3338598499345;2265.592193405186;2324.3027091872455;2329.4758679297192;2337.9415514612188;2338.0414030247516;2307.5038866643586;2311.4452531392344;2322.094383190557;2327.9883600582057;2332.7900488955906;6567.146270984741;6710.93289067108;7349.154847192588;7382.593957332345;7387.261273872624;4536.8865778355475;4656.976715116437;4666.836660716858;4671.299305104228;4683.929741053887;3024.0927721683406;3058.3883223355197;3132.530120481923;3134.514150306706;3169.4611915974338;998.3311181508334;1001.8246806808779;1021.2902033087007;1033.0289527843877;1061.930974486656;10118.342307749972;10223.38659680429;10223.642172523925;10223.744406389826;10231.590736370536;4070.57258987802;4144.233316836395;4221.514525829569;4245.724027938174;4253.1706317267835;8496.1079086695;8500.107488713596;8504.957475212708;8511.191436813493;8521.020082690446;4693.78877950493;4711.623070154379;4714.929276060861;4717.787699553528;4721.575058244705;4294.957050429518;4351.782410879507;4353.455818022747;4361.563843615613;4363.694541382136;3491.650834916488;3552.378333791576;3572.231970126383;3574.4280915053987;3589.802560859178;1073;1098.1544210957677;1101.427257825942;1114.2645853736494;1121.0639116337786;1297.7145028093805;1307.0523870194033;1330.414617568267;1339.055965544289;1340.4973135074347;7116.537425067354;7200.639968001579;7223.602701851449;7251.601161936039;7273.490855640161;498.50896866586385;508.7913955278318;511.5651696058395;512.9743512824344;514.580616797309;5366.302380690485;5441.238226648273;5639.8590035249445;5751.13732940054;5755.395683453261;8800.207981281716;8975.147361000694;9028.142326478974;9055.36612437123;9057.094290571022;8760.299176065899;8914.643414263357;8933.642654293886;8993.415427997159;9110.362274640844;6944.652767361612;7008.579485230903;7010.509264351548;7064.894026589605;7082.362587367162;6955;7031;7033.226345102137;7060.8940865886025;7062.858742825218;7783.727569535039;7804.921950780419;7865.370770338245;7989.360851131779;8037.67849286022;8077.555734434663;8118.878216826871;8119.918800811916;8256.174382561696;8298.170182981654;6499.740010399721;6558.737650493927;6559.540832141704;6560;6562.639054851838;7337.6698048589005;7402.7409040683315;7442.144153422426;7443.962780186064;7461.626918653937;6867.759628412981;6929.688164032731;6941.444684425132;7030.261822508767;7099.538529995534;6836.692348844214;6877.002834588857;6897.48268879826;6987.0567473392475;7013.964930175316;6876.69054892541;6888.862222755617;6911.17065952089;6938.132733408324;6944.965275173592;6394.328595497405;6416.647084410402;6459.806205813833;6465.482761378984;6467.094606754964;6556.2788093308745;6578.210614726264;6587.604743715392;6598.868022639616;6617.040529123154 06:00:04 INFO - 2015-11-23 06:00:04,683 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.76073466369536;332.19277156509673;343.36306152087883;344.1070422254251;346.62218182181425;5967.1049342598635;6057.727402266897;6063.09053641954;6081.422264884829;6094.146819445281;5762.596618236715;5862.0913758367415;5909.379515150912;5970.2835659720895;6012.518998480122;4657.32468792025;4661.930071048937;4668.5564871337165;4668.673192876483;4671.929921051187;4415.624671902892;4676.836310729125;4677.579017888389;4681.368015317939;4688.10925924075;4460.3309503574565;4502;4624.421947256593;4631;4636.79134438951;4615.907681846378;4616.561426664462;4624.121416930772;4633.930491042637;4639.884002899921;4072.552019277877;4074.7351422157467;4077.531083925327;4084.264832330179;4088.632023117934;5550.361708403545;5647.407022262685;5671.829845104653;5672.347680016768;5682.744276507526;5312.76092575835;5317.229001794718;5322.20166974953;5325.20121981702;5326.786928522854;6382.20222472191;6383.234011918599;6383.904241436336;6386.680665966683;6395.42441180296;4401.6478681705385;4402.053558484909;4407.07451435199;4413.735175889425;4418.29307310832;6423.42189202974;6498.707558159894;6500.4799616030605;6543.541952063358;6594.670266486656;4539.341795439643;4541.114482675913;4542.046170304207;4542.772861356919;4545.8408955687055;4580.038191979722;4593.931091033637;4594.058218065288;4595.2188128018315;4599.379083823641;5285.973570132125;5298.178782288752;5301.3373328333955;5302.893942121136;5310.7610157543;6317.305096439388;6376.617402955838;6428.839279018062;6432.871342573216;6435.232849874599;1584.706829236595;1606.2370374072457;1606.9758953615706;1608.8391160883818;1611.7582362645696;1072.485207100596;1077.8167711489066;1083.9945800270948;1085.473545330514;1085.5874767588423;6179.752809887644;6180.598261113013;6207.751689932352;6211.813645590549;6213.968930155411;6394.776182833579;6611.966940165365;6618.338166183343;6621.1392518972225;6624.337566243337;6082.330943596201;6161.630302181883;6182.072689096582;6200.472959798378;6257.687115644199;3587;3606.783592984377;3612.7290453216115;3615.07815507044;3620.637936206358;6756.864862702719;6930.410915072275;6932.61870597122;6935.757248496379;6939.063226464363;6861.691223894937;6864.828379290558;6875.1749790025515;6879;6885.518013739091;6912.101426814482;6940.618265995418;6940.895886561706;6941.0629565009085;6946.965265173743;6629.801105966829;6685.565438246498;6698.464122870061;6699.430548403246;6705.1283333166375;6555.983822507519;6582.8354291143105;6591.242007169045;6596.67016649156;6602.900956485752;6922.5154239204785;6925.930740692528;6933.237343892269;6943.6875340608785;6946.340097690711;4497.97751011256;4498.167838949805;4498.730076195438;4499.7975091120325;4508.880826011769;6459.773907913201;6692.364225398579;6696;6698.129243198353;6699.363560461748;6499.935000649933;6506;6508.544401891822;6515.381038801306;6520.021996700343;6239.376062393724;6420.1974753155855;6452.12896258999;6490.740370385131;6499.252585952676;6282.371762823681;6283.214598175228;6288.339724328879;6292.056191571301;6308.179936608211;6492.35076492347;6514.9348506514325;6524.151860258136;6527.902081468686;6534.4772418205475;6210.875782484235;6344.333844946214;6355.14205582259;6355.205599300088;6358.586691865014 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: |5;yui.html;807.7415227127321;820.5281962871354;833.9416240863138;834.9332053435724;870.8084221471277;10287.537060832261;10373.325733827305;10444.895551044487;15975.360985560592;16388.67222655546;15210;15308.6938261235;15330.540083797476;15337.769933451007;15351.155686437241;680.7923583307089;688.9345512176335;816.9060558035843;830.4602008694367;831.3432388413146;818.3248819723722;828.0436096308773;832.2634468495395;834.5284914023557;834.7370578267856;871.3290766110091;871.481468526229;873.5195642396689;873.52829472085;874.3879284500874;710.5239489541993;718.6299055986171;719;719.5358993449248;867.8307729992654;608.6256951974548;620.534599050712;620.9627422354673;620.9875802483925;621.0745988477182;14058.367373468116;14065.507707230197;14077.084989475754;14086.929565352108;14093.506727264497;12334.568290109893;12470.251784892935;12515.436805343781;12762.17045892014;13525.797113043312;10344.431056291902;10353.275270731052;10458.633947811866;10803.459827008619;10950.507227174796;3529.452934795085;3545.7340699447645;3569.678728914384;3675.1547144156725;3700.7409481336317;48525.51474485281;48588.27117593204;48974.26538601888;49177.26234106491;49220.26169607459;10203.38779673222;10536.894631053745;10929.672109836718;11040.116790656728;11152.905305426977;19162.04189790533;19183.52041198981;19210.519737006685;19220.423387298404;19323.42029739082;7463.141738700119;7562.168161502231;7573.848523029508;7818.413618978486;7906.683732650629;4171.97914010434;4223.429836971969;4268.765217913045;4290.120525292307;4293.076988447437;3061.9693803062128;3083.9514565047994;3097.303106800952;3102.348506813549;3106;516.0891027336754;538.9191621256764;541.7074779618962;557.3562535271767;558.6340946679932;635.8569321902535;689.8137502874196;692.2904023375979;715.0989752911265;732.2531018361242;8130.186981301941;8388.664453421794;8488.533130677748;8686.56567171639;8893.155150260714;573.888091822099;646.8867948109062;658.9044588534731;694.4166899804188;709.4324540367685;4174.3947127666925;4209.852655157055;4245.405643209953;4245.490541135084;4259.659227261812;55072.44927550753;56452.435475645536;56459.43540564542;56592.71703641538;56642.716786415804;49869.75065124651;50132.24801627979;50941.235881461806;51452.48547514552;53614.731926340115;48222;48233.27650085252;48241.5175848244;48391.51608483941;48506;8573.18554737299;8676.522791246289;8677.305815534868;8753.562321884008;8824.779380515538;34588.82705586456;35487.82256088703;35700.28599427945;36053.45919811257;36219.818900905324;43097.78451107725;43154;43893.78053109714;45502;46529;11105.333679979227;11111.166662500507;11223.71940701489;11472.082233421474;11506.539738410369;12577.182483138567;12829.93585032069;12932.806007910078;12935.676608084497;12937.870621293667;11278.323300601991;11447.427628618703;11477.540898363972;11848.111391645489;11849.585264515701;11941.16411851162;12037.299233448246;12228.32744199042;12393.690157746129;12786.424610892345;11253.887461125283;11581;11876.643700688994;11882.76234475323;12223.57217497419;9382.859257111286;9493.762655933657;9531.90468095338;9673.70978870635;9700.563474643799;8854.690085846965;8860.64557417696;9609.375390599589;10136.695899123039;10517.158627309644 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287204667__endTimestamp 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5462.63 Median:5648.04 stddev:618.65 (11.0%) stddev-sans-first:594.90 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: Values: 3215.5 3263.6 3275.5 3282.0 3309.4 5322.8 5443.3 5463.9 5482.8 5507.9 5397.1 5457.7 5457.8 5472.1 5562.0 4940.7 4954.3 4980.6 4981.0 5019.8 4826.4 5003.9 5013.5 5014.2 5093.1 4784.4 4888.0 4903.8 4915.7 4992.4 4980.8 4982.4 4989.4 4989.6 5036.7 4873.5 4925.3 4935.2 4935.7 5008.1 5239.1 5306.6 5359.7 5380.8 5403.2 5982.1 6003.8 6011.0 6018.0 6023.6 5735.5 5941.7 6020.2 6044.2 6049.6 5473.4 5539.4 5546.6 5548.4 5598.1 6033.2 6057.8 6082.0 6087.1 6133.8 5648.0 5714.3 5776.5 5889.2 5926.1 5807.1 5938.3 5982.0 5982.8 5986.8 5889.5 5896.1 5896.4 5903.6 5905.8 5803.6 5900.7 5901.6 5904.8 5920.9 4384.2 4514.3 4530.8 4535.2 4541.2 4004.0 4009.9 4033.4 4040.8 4052.1 5512.8 5572.3 5577.9 5579.7 5630.1 5690.2 5789.5 5795.9 5799.7 5972.8 5588.9 5590.0 5590.3 5594.4 5596.0 5125.1 5131.3 5132.1 5140.1 5173.6 5870.1 5975.5 5975.9 5979.3 6105.7 5799.9 5804.8 5807.3 5812.2 5814.4 5969.5 5971.8 5976.8 5978.9 5982.1 5608.4 5788.9 5806.9 5917.1 5968.5 5994.7 6000.4 6029.9 6035.8 6037.9 5698.4 5848.3 5869.8 5873.9 5875.4 5698.5 5781.9 5803.2 5825.3 5834.6 5651.5 5666.7 5666.9 5670.3 5674.1 5625.7 5784.9 5788.5 5800.0 5802.9 5472.2 5525.6 5553.0 5587.3 5638.5 06:00:04 INFO - 2015-11-23 06:00:04,684 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,685 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46494.24 Median:321248.50 stddev:77373.71 (24.1%) stddev-sans-first:77513.92 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: Values: 565.8 567.7 570.8 594.5 596.9 31965.7 32582.0 32611.3 32615.2 40148.8 43994.8 44920.0 45055.3 45133.8 45151.3 8796.0 8967.1 8974.6 8976.1 8978.2 7712.7 7853.8 8593.5 8648.4 10606.2 10486.5 10587.5 10589.4 10606.4 10612.6 10315.9 10391.9 10395.5 10405.6 10409.5 7839.9 8020.1 10619.5 10881.9 10901.1 40022.0 40141.0 40152.0 40370.4 40451.2 3289.9 3344.0 3368.4 3703.6 4070.9 30338.5 30538.8 31021.8 31136.8 31714.2 3823.6 3854.2 3885.3 3907.2 3966.4 285635.0 287406.0 288342.0 288560.0 289239.0 51392.0 51742.2 58628.1 58658.0 59136.2 61408.0 61850.7 62144.7 62347.7 62449.7 15387.5 15639.9 15648.4 15665.8 15674.2 10827.2 10842.6 10845.5 10853.5 10882.6 19204.4 19431.6 19505.9 19529.0 19542.6 7314.4 7438.8 7477.6 7493.2 7553.6 915.8 918.8 954.5 996.4 1027.2 28862.7 28871.0 29015.6 29258.0 29272.3 1025.2 1044.5 1079.8 1119.3 1123.5 14870.8 15077.5 15218.5 15392.7 15395.2 314988.0 320613.0 320657.0 320754.0 321743.0 54826.5 55005.4 55116.4 55129.4 55143.2 1282.5 1295.4 1295.7 1353.5 1353.9 25979.0 28432.0 29464.0 29572.7 30609.2 48232.0 48779.8 48785.3 48854.0 48857.0 278383.0 278406.0 279419.0 279550.0 281294.6 27098.3 27876.3 30727.4 31127.2 31952.0 38215.2 38623.2 38893.2 38956.2 39206.0 32721.7 33050.5 33076.0 33192.7 36140.3 31006.1 33178.2 34379.7 37139.6 37279.3 33543.7 36247.1 36855.8 36984.4 36991.1 28512.6 30773.8 31322.1 31475.4 31479.8 25209.5 25240.0 25350.1 25638.5 25845.0 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29197.30 Median:17865.48 stddev:90053.93 (504.1%) stddev-sans-first:90280.50 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: Values: 349.3 353.0 362.0 362.7 362.7 13751.6 14033.2 16539.0 16578.3 17099.0 16072.8 16290.3 16694.6 17012.1 17045.8 5270.4 5397.3 5399.9 5416.4 5418.8 4027.0 4147.3 5290.9 5820.3 5974.2 5858.6 5891.6 5893.6 5896.6 5953.1 5693.1 5810.8 5825.7 5829.9 5844.1 5184.0 5190.7 5195.0 5201.4 5203.5 12359.4 12475.6 12722.4 12730.2 20502.8 1998.0 2036.4 2050.5 2080.4 2113.4 9619.3 10496.5 12837.0 12962.9 13336.7 1777.9 1872.5 1898.9 1993.5 1998.2 54781.2 58651.7 59982.7 60791.7 60893.0 10360.8 10383.5 10444.2 10463.5 10503.6 13495.7 13566.0 13589.5 13600.7 13641.2 7333.5 7352.0 7373.9 7386.9 7413.0 6627.6 6651.0 6949.2 6967.9 6995.6 4433.4 4457.3 4460.2 4499.3 4508.6 1677.9 1738.9 1746.9 1796.1 1823.7 852.4 871.9 886.3 970.8 1075.3 16218.8 16313.2 16614.2 16718.6 16884.7 827.8 877.8 910.0 941.5 962.4 7297.3 9524.7 9608.8 9625.5 9715.9 533476.0 545728.0 547617.0 548053.0 577746.0 84457.6 84744.6 85106.6 85931.0 86103.0 1098.6 1107.3 1108.7 1110.6 1113.7 14892.7 14896.9 14989.2 14993.9 15080.3 34455.8 34814.0 34954.8 35378.0 35675.3 46655.5 48158.3 49122.0 49401.5 50055.5 9778.3 9926.1 9960.7 9971.2 10093.1 17348.3 17382.3 18100.9 18158.9 18227.2 14611.6 14611.8 14637.2 14857.5 15280.8 13710.5 14043.9 14152.7 14840.2 14973.4 12327.6 12514.6 12779.4 14328.5 15048.1 9525.3 9672.4 9770.6 9882.8 9883.8 13119.4 14336.9 14743.0 15048.1 15400.2 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5298.74 Median:6438.23 stddev:2683.99 (41.7%) stddev-sans-first:2674.96 06:00:04 INFO - 2015-11-23 06:00:04,686 DEBUG : BROWSER_OUTPUT: Values: 1332.2 1673.4 1701.7 1722.1 1746.8 6667.2 7079.6 7270.4 7271.2 7280.4 7395.3 7501.4 7504.0 7506.4 7507.7 2269.6 2287.0 2291.1 2292.4 2292.4 2312.9 2334.8 2342.1 2343.7 2345.2 2296.0 2305.2 2307.5 2322.8 2337.3 2265.6 2324.3 2329.5 2337.9 2338.0 2307.5 2311.4 2322.1 2328.0 2332.8 6567.1 6710.9 7349.2 7382.6 7387.3 4536.9 4657.0 4666.8 4671.3 4683.9 3024.1 3058.4 3132.5 3134.5 3169.5 998.3 1001.8 1021.3 1033.0 1061.9 10118.3 10223.4 10223.6 10223.7 10231.6 4070.6 4144.2 4221.5 4245.7 4253.2 8496.1 8500.1 8505.0 8511.2 8521.0 4693.8 4711.6 4714.9 4717.8 4721.6 4295.0 4351.8 4353.5 4361.6 4363.7 3491.7 3552.4 3572.2 3574.4 3589.8 1073.0 1098.2 1101.4 1114.3 1121.1 1297.7 1307.1 1330.4 1339.1 1340.5 7116.5 7200.6 7223.6 7251.6 7273.5 498.5 508.8 511.6 513.0 514.6 5366.3 5441.2 5639.9 5751.1 5755.4 8800.2 8975.1 9028.1 9055.4 9057.1 8760.3 8914.6 8933.6 8993.4 9110.4 6944.7 7008.6 7010.5 7064.9 7082.4 6955.0 7031.0 7033.2 7060.9 7062.9 7783.7 7804.9 7865.4 7989.4 8037.7 8077.6 8118.9 8119.9 8256.2 8298.2 6499.7 6558.7 6559.5 6560.0 6562.6 7337.7 7402.7 7442.1 7444.0 7461.6 6867.8 6929.7 6941.4 7030.3 7099.5 6836.7 6877.0 6897.5 6987.1 7014.0 6876.7 6888.9 6911.2 6938.1 6945.0 6394.3 6416.6 6459.8 6465.5 6467.1 6556.3 6578.2 6587.6 6598.9 6617.0 06:00:04 INFO - 2015-11-23 06:00:04,687 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,687 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5370.57 Median:6127.89 stddev:1627.11 (26.6%) stddev-sans-first:1587.04 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: Values: 327.8 332.2 343.4 344.1 346.6 5967.1 6057.7 6063.1 6081.4 6094.1 5762.6 5862.1 5909.4 5970.3 6012.5 4657.3 4661.9 4668.6 4668.7 4671.9 4415.6 4676.8 4677.6 4681.4 4688.1 4460.3 4502.0 4624.4 4631.0 4636.8 4615.9 4616.6 4624.1 4633.9 4639.9 4072.6 4074.7 4077.5 4084.3 4088.6 5550.4 5647.4 5671.8 5672.3 5682.7 5312.8 5317.2 5322.2 5325.2 5326.8 6382.2 6383.2 6383.9 6386.7 6395.4 4401.6 4402.1 4407.1 4413.7 4418.3 6423.4 6498.7 6500.5 6543.5 6594.7 4539.3 4541.1 4542.0 4542.8 4545.8 4580.0 4593.9 4594.1 4595.2 4599.4 5286.0 5298.2 5301.3 5302.9 5310.8 6317.3 6376.6 6428.8 6432.9 6435.2 1584.7 1606.2 1607.0 1608.8 1611.8 1072.5 1077.8 1084.0 1085.5 1085.6 6179.8 6180.6 6207.8 6211.8 6214.0 6394.8 6612.0 6618.3 6621.1 6624.3 6082.3 6161.6 6182.1 6200.5 6257.7 3587.0 3606.8 3612.7 3615.1 3620.6 6756.9 6930.4 6932.6 6935.8 6939.1 6861.7 6864.8 6875.2 6879.0 6885.5 6912.1 6940.6 6940.9 6941.1 6947.0 6629.8 6685.6 6698.5 6699.4 6705.1 6556.0 6582.8 6591.2 6596.7 6602.9 6922.5 6925.9 6933.2 6943.7 6946.3 4498.0 4498.2 4498.7 4499.8 4508.9 6459.8 6692.4 6696.0 6698.1 6699.4 6499.9 6506.0 6508.5 6515.4 6520.0 6239.4 6420.2 6452.1 6490.7 6499.3 6282.4 6283.2 6288.3 6292.1 6308.2 6492.4 6514.9 6524.2 6527.9 6534.5 6210.9 6344.3 6355.1 6355.2 6358.6 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14044.42 Median:46015.50 stddev:16020.49 (34.8%) stddev-sans-first:16034.60 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: Values: 807.7 820.5 833.9 834.9 870.8 10287.5 10373.3 10444.9 15975.4 16388.7 15210.0 15308.7 15330.5 15337.8 15351.2 680.8 688.9 816.9 830.5 831.3 818.3 828.0 832.3 834.5 834.7 871.3 871.5 873.5 873.5 874.4 710.5 718.6 719.0 719.5 867.8 608.6 620.5 621.0 621.0 621.1 14058.4 14065.5 14077.1 14086.9 14093.5 12334.6 12470.3 12515.4 12762.2 13525.8 10344.4 10353.3 10458.6 10803.5 10950.5 3529.5 3545.7 3569.7 3675.2 3700.7 48525.5 48588.3 48974.3 49177.3 49220.3 10203.4 10536.9 10929.7 11040.1 11152.9 19162.0 19183.5 19210.5 19220.4 19323.4 7463.1 7562.2 7573.8 7818.4 7906.7 4172.0 4223.4 4268.8 4290.1 4293.1 3062.0 3084.0 3097.3 3102.3 3106.0 516.1 538.9 541.7 557.4 558.6 635.9 689.8 692.3 715.1 732.3 8130.2 8388.7 8488.5 8686.6 8893.2 573.9 646.9 658.9 694.4 709.4 4174.4 4209.9 4245.4 4245.5 4259.7 55072.4 56452.4 56459.4 56592.7 56642.7 49869.8 50132.2 50941.2 51452.5 53614.7 48222.0 48233.3 48241.5 48391.5 48506.0 8573.2 8676.5 8677.3 8753.6 8824.8 34588.8 35487.8 35700.3 36053.5 36219.8 43097.8 43154.0 43893.8 45502.0 46529.0 11105.3 11111.2 11223.7 11472.1 11506.5 12577.2 12829.9 12932.8 12935.7 12937.9 11278.3 11447.4 11477.5 11848.1 11849.6 11941.2 12037.3 12228.3 12393.7 12786.4 11253.9 11581.0 11876.6 11882.8 12223.6 9382.9 9493.8 9531.9 9673.7 9700.6 8854.7 8860.6 9609.4 10136.7 10517.2 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:00:04 INFO - 2015-11-23 06:00:04,688 DEBUG : BROWSER_OUTPUT: 06:00:05 INFO - 2015-11-23 06:00:05,370 INFO : Browser exited with error code: 0 06:00:05 INFO - 2015-11-23 06:00:05,386 INFO : Completed test dromaeo_css (00:18:33) 06:00:05 INFO - 2015-11-23 06:00:05,386 INFO : Starting test kraken 06:00:05 INFO - 2015-11-23 06:00:05,386 DEBUG : operating with platform_type : linux_ 06:00:05 INFO - 2015-11-23 06:00:05,386 INFO : Initialising browser for kraken test... 06:00:05 INFO - 2015-11-23 06:00:05,392 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIahzQ1/profile http://localhost:57340/getInfo.html 06:00:08 INFO - 2015-11-23 06:00:08,787 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:00:08 INFO - 2015-11-23 06:00:08,788 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:00:08 INFO - 2015-11-23 06:00:08,788 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:00:08 INFO - 2015-11-23 06:00:08,788 DEBUG : BROWSER_OUTPUT: __metrics 06:00:08 INFO - 2015-11-23 06:00:08,864 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:09 INFO - 2015-11-23 06:00:09,465 DEBUG : BROWSER_OUTPUT: console.error: 06:00:09 INFO - 2015-11-23 06:00:09,465 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 06:00:09 INFO - 2015-11-23 06:00:09,465 DEBUG : BROWSER_OUTPUT: Stack: 06:00:09 INFO - 2015-11-23 06:00:09,465 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 06:00:09 INFO - 2015-11-23 06:00:09,466 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:00:09 INFO - 2015-11-23 06:00:09,467 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 06:00:09 INFO - 2015-11-23 06:00:09,467 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 06:00:09 INFO - 2015-11-23 06:00:09,467 DEBUG : BROWSER_OUTPUT: 06:00:10 INFO - 2015-11-23 06:00:10,012 INFO : Browser initialized. 06:00:10 INFO - 2015-11-23 06:00:10,012 INFO : Running cycle 1/1 for kraken test... 06:00:10 INFO - 2015-11-23 06:00:10,013 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIahzQ1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:00:21 INFO - 2015-11-23 06:00:21,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 139825152 06:00:21 INFO - 2015-11-23 06:00:21,722 DEBUG : BROWSER_OUTPUT: 06:00:24 INFO - 2015-11-23 06:00:24,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57340/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:24 INFO - 2015-11-23 06:00:24,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 179630080 06:00:24 INFO - 2015-11-23 06:00:24,782 DEBUG : BROWSER_OUTPUT: 06:00:27 INFO - 2015-11-23 06:00:27,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57340/tests/kraken/driver.html?testName=audio-dft) 06:00:27 INFO - 2015-11-23 06:00:27,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 168165376 06:00:27 INFO - 2015-11-23 06:00:27,910 DEBUG : BROWSER_OUTPUT: 06:00:30 INFO - 2015-11-23 06:00:30,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57340/tests/kraken/driver.html?testName=audio-fft) 06:00:31 INFO - 2015-11-23 06:00:31,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 151515136 06:00:31 INFO - 2015-11-23 06:00:31,356 DEBUG : BROWSER_OUTPUT: 06:00:33 INFO - 2015-11-23 06:00:33,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57340/tests/kraken/driver.html?testName=audio-oscillator) 06:00:33 INFO - 2015-11-23 06:00:33,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 154443776 06:00:33 INFO - 2015-11-23 06:00:33,878 DEBUG : BROWSER_OUTPUT: 06:00:36 INFO - 2015-11-23 06:00:36,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:36 INFO - 2015-11-23 06:00:36,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 154677248 06:00:36 INFO - 2015-11-23 06:00:36,592 DEBUG : BROWSER_OUTPUT: 06:00:39 INFO - 2015-11-23 06:00:39,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57340/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:40 INFO - 2015-11-23 06:00:40,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 155271168 06:00:40 INFO - 2015-11-23 06:00:40,068 DEBUG : BROWSER_OUTPUT: 06:00:43 INFO - 2015-11-23 06:00:43,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57340/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:43 INFO - 2015-11-23 06:00:43,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 156880896 06:00:43 INFO - 2015-11-23 06:00:43,977 DEBUG : BROWSER_OUTPUT: 06:00:46 INFO - 2015-11-23 06:00:46,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57340/tests/kraken/driver.html?testName=json-parse-financial) 06:00:47 INFO - 2015-11-23 06:00:47,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 155791360 06:00:47 INFO - 2015-11-23 06:00:47,292 DEBUG : BROWSER_OUTPUT: 06:00:48 INFO - 2015-11-23 06:00:48,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:49 INFO - 2015-11-23 06:00:49,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 166789120 06:00:49 INFO - 2015-11-23 06:00:49,393 DEBUG : BROWSER_OUTPUT: 06:00:51 INFO - 2015-11-23 06:00:51,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:51 INFO - 2015-11-23 06:00:51,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 165126144 06:00:51 INFO - 2015-11-23 06:00:51,797 DEBUG : BROWSER_OUTPUT: 06:00:53 INFO - 2015-11-23 06:00:53,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:54 INFO - 2015-11-23 06:00:54,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 169467904 06:00:54 INFO - 2015-11-23 06:00:54,388 DEBUG : BROWSER_OUTPUT: 06:00:56 INFO - 2015-11-23 06:00:56,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:57 INFO - 2015-11-23 06:00:57,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 181710848 06:00:57 INFO - 2015-11-23 06:00:57,396 DEBUG : BROWSER_OUTPUT: 06:00:59 INFO - 2015-11-23 06:00:59,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:00 INFO - 2015-11-23 06:01:00,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 179998720 06:01:00 INFO - 2015-11-23 06:01:00,493 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57340/tests/kraken/driver.html?testName=ai-astar) 06:01:02 INFO - 2015-11-23 06:01:02,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 238256128 06:01:02 INFO - 2015-11-23 06:01:02,414 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,414 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:02 INFO - 2015-11-23 06:01:02,414 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;104;108;110;110;99;110;109;111 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;124;150;159;124;157;151;124;168;126 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;161;160;161;159;165;162;162 06:01:02 INFO - 2015-11-23 06:01:02,415 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;86;97;72;71;71;110;96;71 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;136;90;91;90;134;90;90;134 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;109;109;109;109 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;146;145;146;144;145;145;144 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;96;96;96;95;96 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;58;57;56;57;57;66;65;54;55 06:01:02 INFO - 2015-11-23 06:01:02,416 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;69;70;69;68;69;69;69 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;85;84;85;84;84;85;87 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;126;123;120;133;114;119;120;124;122 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;139;149;149;138;149;149;150;141 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;69;66;69;67;67;69;67;67 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:01:02 INFO - 2015-11-23 06:01:02,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,937 06:01:02 INFO - 2015-11-23 06:01:02,418 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:01:02 INFO - 2015-11-23 06:01:02,418 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287262413__endTimestamp 06:01:02 INFO - 2015-11-23 06:01:02,418 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,421 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:02 INFO - 2015-11-23 06:01:02,422 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:01:02 INFO - 2015-11-23 06:01:02,422 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,422 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.77 (3.4%) stddev-sans-first:4.00 06:01:02 INFO - 2015-11-23 06:01:02,422 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 104.0 108.0 110.0 110.0 99.0 110.0 109.0 111.0 06:01:02 INFO - 2015-11-23 06:01:02,422 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,423 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:153.00 stddev:17.32 (11.3%) stddev-sans-first:17.89 06:01:02 INFO - 2015-11-23 06:01:02,423 DEBUG : BROWSER_OUTPUT: Values: 155.0 124.0 150.0 159.0 124.0 157.0 151.0 124.0 168.0 126.0 06:01:02 INFO - 2015-11-23 06:01:02,423 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,423 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 06:01:02 INFO - 2015-11-23 06:01:02,424 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 161.0 160.0 161.0 159.0 165.0 162.0 162.0 06:01:02 INFO - 2015-11-23 06:01:02,424 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,424 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:73.00 stddev:14.33 (19.6%) stddev-sans-first:14.90 06:01:02 INFO - 2015-11-23 06:01:02,424 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 86.0 97.0 72.0 71.0 71.0 110.0 96.0 71.0 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.00 stddev:21.52 (23.9%) stddev-sans-first:22.26 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 136.0 90.0 91.0 90.0 134.0 90.0 90.0 134.0 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:01:02 INFO - 2015-11-23 06:01:02,425 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 146.0 145.0 146.0 144.0 145.0 145.0 144.0 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:4.07 (7.1%) stddev-sans-first:4.24 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: Values: 56.0 58.0 57.0 56.0 57.0 57.0 66.0 65.0 54.0 55.0 06:01:02 INFO - 2015-11-23 06:01:02,426 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 69.0 70.0 69.0 68.0 69.0 69.0 69.0 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 87.0 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:122.50 stddev:4.97 (4.1%) stddev-sans-first:5.27 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: Values: 122.0 126.0 123.0 120.0 133.0 114.0 119.0 120.0 124.0 122.0 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:149.00 stddev:5.06 (3.4%) stddev-sans-first:4.99 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 139.0 149.0 149.0 138.0 149.0 149.0 150.0 141.0 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 69.0 66.0 69.0 67.0 67.0 69.0 67.0 67.0 06:01:02 INFO - 2015-11-23 06:01:02,427 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:02 INFO - 2015-11-23 06:01:02,428 DEBUG : BROWSER_OUTPUT: 06:01:03 INFO - 2015-11-23 06:01:03,317 INFO : Browser exited with error code: 0 06:01:03 INFO - 2015-11-23 06:01:03,367 INFO : Completed test kraken (00:00:57) 06:01:03 INFO - 2015-11-23 06:01:03,367 INFO : Starting test v8_7 06:01:03 INFO - 2015-11-23 06:01:03,367 DEBUG : operating with platform_type : linux_ 06:01:03 INFO - 2015-11-23 06:01:03,367 INFO : Initialising browser for v8_7 test... 06:01:03 INFO - 2015-11-23 06:01:03,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJWvqAU/profile http://localhost:57340/getInfo.html 06:01:06 INFO - 2015-11-23 06:01:06,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:01:06 INFO - 2015-11-23 06:01:06,948 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:01:06 INFO - 2015-11-23 06:01:06,948 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:01:06 INFO - 2015-11-23 06:01:06,948 DEBUG : BROWSER_OUTPUT: __metrics 06:01:07 INFO - 2015-11-23 06:01:07,097 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:08 INFO - 2015-11-23 06:01:08,193 INFO : Browser initialized. 06:01:08 INFO - 2015-11-23 06:01:08,194 INFO : Running cycle 1/1 for v8_7 test... 06:01:08 INFO - 2015-11-23 06:01:08,194 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJWvqAU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:01:19 INFO - 2015-11-23 06:01:19,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 142184448 06:01:19 INFO - 2015-11-23 06:01:19,915 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57340/tests/v8_7/run.html (next: http://localhost:57340/tests/v8_7/run.html) 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 472948736 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1055292774425 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.51468585878234 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.09090909090907 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |5;Earley;778.2101167315175 06:01:41 INFO - 2015-11-23 06:01:41,546 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: |8;Splay;640.2048655569782 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1448287301545__endTimestamp 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.11 Median:163.11 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: Values: 163.1 06:01:41 INFO - 2015-11-23 06:01:41,547 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: Values: 194.5 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.09 Median:284.09 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: Values: 284.1 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,548 DEBUG : BROWSER_OUTPUT: Values: 5035.2 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: Values: 1102.5 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.21 Median:778.21 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: Values: 778.2 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,549 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,550 DEBUG : BROWSER_OUTPUT: Values: 12144.6 06:01:41 INFO - 2015-11-23 06:01:41,550 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,551 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,551 DEBUG : BROWSER_OUTPUT: Values: 26526.3 06:01:41 INFO - 2015-11-23 06:01:41,551 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,551 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:640.20 Median:640.20 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: Values: 640.2 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:01:41 INFO - 2015-11-23 06:01:41,552 DEBUG : BROWSER_OUTPUT: 06:01:42 INFO - 2015-11-23 06:01:42,434 INFO : Browser exited with error code: 0 06:01:42 INFO - 2015-11-23 06:01:42,448 INFO : Completed test v8_7 (00:00:39) 06:01:42 INFO - 2015-11-23 06:01:42,583 INFO : Completed test suite (00:20:10) 06:01:42 INFO - 2015-11-23 06:01:42,583 DEBUG : Working with test: dromaeo_css 06:01:42 INFO - 2015-11-23 06:01:42,583 DEBUG : Generating results file: dromaeo_css 06:01:42 INFO - 2015-11-23 06:01:42,584 DEBUG : Working with test: kraken 06:01:42 INFO - 2015-11-23 06:01:42,584 DEBUG : Generating results file: kraken 06:01:42 INFO - 2015-11-23 06:01:42,585 INFO : javascript benchmark 06:01:42 INFO - 2015-11-23 06:01:42,585 DEBUG : Working with test: v8_7 06:01:42 INFO - 2015-11-23 06:01:42,585 DEBUG : Generating results file: v8_7 06:01:42 INFO - 2015-11-23 06:01:42,585 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:42 INFO - 2015-11-23 06:01:42,738 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:01:42 INFO - 2015-11-23 06:01:42,738 DEBUG : process_Request line: dromaeo_css 7020.79 graph.html#tests=[[72,1,35]] 06:01:42 INFO - 2015-11-23 06:01:42,738 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:42 INFO - 2015-11-23 06:01:42,788 DEBUG : process_Request line: kraken 1495.50 graph.html#tests=[[232,1,35]] 06:01:42 INFO - 2015-11-23 06:01:42,788 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:42 INFO - 2015-11-23 06:01:42,820 DEBUG : process_Request line: v8_7 20921.64 graph.html#tests=[[230,1,35]] 06:01:42 INFO - 2015-11-23 06:01:42,821 INFO : javascript benchmark 06:01:42 INFO - 2015-11-23 06:01:42,825 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3215.4694475411557, 3263.55941947837, 3275.459549174386, 3281.9835900820494, 3309.4373956427403, 5322.840314790563, 5443.346798384195, 5463.890722185554, 5482.780688772445, 5507.9449205507935, 5397.055515284829, 5457.699826509541, 5457.781688732446, 5472.097103977849, 5562.0266453370705, 4940.654154209215, 4954.281629163769, 4980.601551875841, 4980.950190498085, 5019.774110165033, 4826.444958829745, 5003.949960500403, 5013.523715247045, 5014.24786282057, 5093.134167191568, 4784.3780308559835, 4888.0, 4903.779329930162, 4915.705057696514, 4992.425871024824, 4980.82567110153, 4982.402111746577, 4989.401271847365, 4989.600831933473, 5036.722980236085, 4873.488283730228, 4925.26121081837, 4935.185694360426, 4935.703857768545, 5008.12357837377, 5239.1093514102695, 5306.575473962073, 5359.705216213107, 5380.811671591515, 5403.243545903577, 5982.0727787193055, 6003.759849606011, 6011.008183649737, 6018.0, 6023.578349515536, 5735.512481439083, 5941.732622032019, 6020.157177995085, 6044.153818465418, 6049.637021778707, 5473.425290344497, 5539.362973258047, 5546.55627549795, 5548.4174161713245, 5598.10430331145, 6033.18551995475, 6057.818265452043, 6082.0, 6087.1173679816175, 6133.815985520441, 5648.039833228361, 5714.314282286152, 5776.480116789509, 5889.234399528034, 5926.051831706906, 5807.070868661079, 5938.317093534212, 5982.0, 5982.790602328898, 5986.790462333797, 5889.4993925515955, 5896.086106653475, 5896.439838215363, 5903.58674892762, 5905.793297234576, 5803.564732645069, 5900.675462849585, 5901.557383196277, 5904.76380944766, 5920.940790592125, 4384.167008268419, 4514.32285157229, 4530.77346132692, 4535.160995215896, 4541.205289074464, 4004.019015341202, 4009.939850902239, 4033.415154802537, 4040.797960102042, 4052.1490486997473, 5512.779488820403, 5572.331320241516, 5577.9163312550345, 5579.7489112990015, 5630.071038278638, 5690.231818704505, 5789.478946894799, 5795.94204057954, 5799.739011744482, 5972.820815375546, 5588.944110558842, 5590.0496915523645, 5590.273264475592, 5594.356648985337, 5596.0, 5125.051865404837, 5131.281620573122, 5132.076226279306, 5140.126178549655, 5173.586113110942, 5870.090136028923, 5975.492083172892, 5975.940240597625, 5979.342272350038, 6105.6947152641305, 5799.942000580109, 5804.796832111025, 5807.303123625192, 5812.21535092757, 5814.360420353673, 5969.52243820502, 5971.790987315423, 5976.820695379146, 5978.850528736816, 5982.1325907744, 5608.355039170548, 5788.884222315614, 5806.854828629318, 5917.142014407973, 5968.522518198447, 5994.67029313392, 6000.369961154016, 6029.939700603113, 6035.78874739382, 6037.939620603738, 5698.373178950229, 5848.2689663792025, 5869.7945571904775, 5873.911891321548, 5875.41245875409, 5698.515626171656, 5781.913271300849, 5803.187553742395, 5825.271841019872, 5834.649921004583, 5651.491365777099, 5666.716664166693, 5666.943330566642, 5670.262865827416, 5674.120511320587, 5625.662460252398, 5784.913226301693, 5788.507976822018, 5799.971000144972, 5802.94197058024, 5472.179173124063, 5525.640833345819, 5553.028220061554, 5587.3015873015875, 5638.4925356718095], "unit": "ms", "name": "dojo.html", "value": 5421.745487611935}, {"lowerIsBetter": false, "replicates": [565.7934853778372, 567.7473524281694, 570.8002199230268, 594.4679511836904, 596.8746563221723, 31965.68034319656, 32582.0, 32611.347773044527, 32615.1846203845, 40148.79925600375, 43994.78002609991, 44920.0, 45055.32417013747, 45133.77433112838, 45151.322730158994, 8795.956020219906, 8967.103289671013, 8974.641014359418, 8976.147266009719, 8978.191962723353, 7712.652930618107, 7853.842923141534, 8593.484390936532, 8648.35137364697, 10606.204534659932, 10486.528106235237, 10587.470626468685, 10589.364638121699, 10606.363618182895, 10612.628558000471, 10315.948420257888, 10391.896081039205, 10395.480225988671, 10405.583776648926, 10409.479526023668, 7839.921600783976, 8020.077691065544, 10619.469026548719, 10881.945590271998, 10901.1279097672, 40022.0, 40141.0, 40152.0, 40370.394444083366, 40451.19097618061, 3289.9342013159844, 3344.0, 3368.427367347557, 3703.6481534254203, 4070.941555195641, 30338.49718537886, 30538.847305763553, 31021.84489077563, 31136.844315778504, 31714.207144821332, 3823.598522155189, 3854.1713531590563, 3885.339492286318, 3907.2185562887253, 3966.4050392441077, 285635.0, 287406.0, 288342.0, 288560.0, 289238.9999999979, 51392.0, 51742.22386664203, 58628.085208496304, 58658.0, 59136.19933707679, 61408.0, 61850.69074654598, 62144.68927655333, 62347.688261559306, 62449.68775156095, 15387.461438849587, 15639.921800390925, 15648.374065037271, 15665.843341566666, 15674.216289185495, 10827.24209305341, 10842.566297348176, 10845.457727113613, 10853.511591978222, 10882.61910833117, 19204.356856782324, 19431.611367772566, 19505.902470487556, 19529.0, 19542.609147816966, 7314.414846812242, 7438.834252818439, 7477.588732619758, 7493.175750667422, 7553.5845528495365, 915.8168366326628, 918.7519369770125, 954.4750387286964, 996.4270544436832, 1027.2244455436248, 28862.71137288642, 28871.0, 29015.564766528518, 29258.0, 29272.26819329534, 1025.2054657640388, 1044.4725413666201, 1079.7995796352195, 1119.2745664307438, 1123.455124264731, 14870.776938345933, 15077.54767356981, 15218.543443696706, 15392.692146157015, 15395.153266570445, 314988.0, 320613.0, 320657.0, 320754.0, 321743.0, 54826.45173548293, 55005.44994550003, 55116.44883551193, 55129.448705512434, 55143.172852407246, 1282.5190553542423, 1295.352323838081, 1295.6760809797552, 1353.4653811744306, 1353.8510763815973, 25979.0, 28432.0, 29464.0, 29572.704272956995, 30609.23476913095, 48232.0, 48779.75610121927, 48785.268220976, 48854.0, 48857.0, 278383.0, 278406.0, 279419.0, 279550.0, 281294.5935270311, 27098.32254193661, 27876.30309242285, 30727.385452291277, 31127.22181945379, 31952.0, 38215.23569528538, 38623.227535449696, 38893.22213555656, 38956.2208755829, 39206.0, 32721.672783271864, 33050.504242435905, 33076.0, 33192.668073319925, 36140.27719445649, 31006.0698179055, 33178.17054573655, 34379.65620343765, 37139.628603713616, 37279.254414912095, 33543.664563354054, 36247.09382265464, 36855.81572092122, 36984.445233320985, 36991.07522311856, 28512.57231141576, 30773.8461307701, 31322.06033818989, 31475.37049259048, 31479.84260078685, 25209.49581008333, 25240.0, 25350.1127460538, 25638.487230255665, 25845.0], "unit": "ms", "name": "ext.html", "value": 18580.554221872815}, {"lowerIsBetter": false, "replicates": [349.2752538482649, 352.95235143255655, 361.9927601447972, 362.69714788151896, 362.7261417629689, 13751.58745237642, 14033.158010519375, 16539.00765954042, 16578.253978570963, 17098.999999999985, 16072.758908616352, 16290.26693798779, 16694.58263543412, 17012.064336461488, 17045.829541704577, 5270.446603106667, 5397.298351214336, 5399.919001214985, 5416.4312747161575, 5418.756155972971, 4027.0, 4147.294959856831, 5290.867728306804, 5820.301563812349, 5974.163617093589, 5858.619189752674, 5891.617044892089, 5893.58744887858, 5896.557758168133, 5953.077273022667, 5693.117566777156, 5810.767569297223, 5825.679587622679, 5829.912551311733, 5844.094165404369, 5184.040952423814, 5190.7404629768735, 5195.0, 5201.40183878855, 5203.453637368098, 12359.38203089842, 12475.625731228078, 12722.427490762939, 12730.17253878495, 20502.794972050237, 1997.950051248716, 2036.3992622176493, 2050.4668786115717, 2080.3966849613744, 2113.4188098272944, 9619.27855410847, 10496.475176241234, 12837.0, 12962.870371296262, 13336.666583335396, 1777.8844375115575, 1872.4663470910725, 1898.9081278264914, 1993.511589660528, 1998.15078591598, 54781.178282325796, 58651.70674146602, 59982.70008649929, 60791.696041519506, 60892.999999999556, 10360.792784144274, 10383.532741026673, 10444.172269852745, 10463.476826158661, 10503.579856805794, 13495.662608434868, 13566.0, 13589.456421743218, 13600.659983500294, 13641.181529108286, 7333.523320984119, 7352.0, 7373.852522949618, 7386.889196662054, 7412.962935185397, 6627.569208001561, 6651.0, 6949.235584085746, 6967.93032069683, 6995.615241161785, 4433.379326894237, 4457.286834106528, 4460.174867649431, 4499.257622492252, 4508.639308855284, 1677.9412720554722, 1738.9217485213196, 1746.868984826143, 1796.092973048602, 1823.6535058338873, 852.3522123186423, 871.9346049046347, 886.3131073418152, 970.8301047316692, 1075.2741899217997, 16218.837811621968, 16313.184340782913, 16614.169291535374, 16718.582035448966, 16884.662306754042, 827.8178800663844, 877.8244351129799, 910.0080911806164, 941.5104145844259, 962.43216502264, 7297.3432391084, 9524.666636667822, 9608.807823843485, 9625.470599117116, 9715.902840971641, 533476.0, 545728.0, 547617.0, 548053.0, 577746.0, 84457.57771211104, 84744.57627711946, 85106.57446712727, 85931.0, 86103.0, 1098.593520397458, 1107.3355986408092, 1108.695108845058, 1110.5946329589804, 1113.7271368514766, 14892.702145957237, 14896.85103148998, 14989.175595342362, 14993.925030375214, 15080.321385537896, 34455.827720861234, 34814.0, 34954.825225873705, 35378.0, 35675.28649427049, 46655.53344466512, 48158.27762583494, 49122.0, 49401.50598494113, 50055.49944500509, 9778.315517913677, 9926.057024582653, 9960.701178964642, 9971.152452041657, 10093.091621754078, 17348.306067757654, 17382.304707811545, 18100.909495452437, 18158.91046537212, 18227.179776910336, 14611.561653150422, 14611.780823287872, 14637.194954277616, 14857.47998820036, 15280.847191527942, 13710.451581936612, 14043.859561404255, 14152.716945661236, 14840.18378989166, 14973.401063957319, 12327.568535101587, 12514.624561262812, 12779.424925878544, 14328.49850255236, 15048.097114173184, 9525.285603579621, 9672.371295865747, 9770.609175633179, 9882.802343953224, 9883.802323953338, 13119.409626567018, 14336.856631433553, 14743.041702289316, 15048.097114173184, 15400.15299158557], "unit": "ms", "name": "jquery.html", "value": 8842.038623383965}, {"lowerIsBetter": false, "replicates": [1332.2206509192122, 1673.4393978017363, 1701.7022021146297, 1722.1045056570583, 1746.799118101418, 6667.166604174478, 7079.61062141582, 7270.382017528504, 7271.200167981525, 7280.38116760076, 7395.260473952616, 7501.3623841973495, 7503.962480187605, 7506.437017223703, 7507.662155203016, 2269.5574362999264, 2286.9542609147807, 2291.140822191678, 2292.4039749665126, 2292.4154340643195, 2312.8612283262974, 2334.7781960713705, 2342.0631747301045, 2343.7070366204225, 2345.2026311054237, 2295.9655605165935, 2305.1931823861682, 2307.515421761432, 2322.7909488146065, 2337.3338598499345, 2265.592193405186, 2324.3027091872455, 2329.4758679297192, 2337.9415514612188, 2338.0414030247516, 2307.5038866643586, 2311.4452531392344, 2322.094383190557, 2327.9883600582057, 2332.7900488955906, 6567.146270984741, 6710.93289067108, 7349.154847192588, 7382.593957332345, 7387.261273872624, 4536.8865778355475, 4656.976715116437, 4666.836660716858, 4671.299305104228, 4683.929741053887, 3024.0927721683406, 3058.3883223355197, 3132.530120481923, 3134.514150306706, 3169.4611915974338, 998.3311181508334, 1001.8246806808779, 1021.2902033087007, 1033.0289527843877, 1061.930974486656, 10118.342307749972, 10223.38659680429, 10223.642172523925, 10223.744406389826, 10231.590736370536, 4070.57258987802, 4144.233316836395, 4221.514525829569, 4245.724027938174, 4253.1706317267835, 8496.1079086695, 8500.107488713596, 8504.957475212708, 8511.191436813493, 8521.020082690446, 4693.78877950493, 4711.623070154379, 4714.929276060861, 4717.787699553528, 4721.575058244705, 4294.957050429518, 4351.782410879507, 4353.455818022747, 4361.563843615613, 4363.694541382136, 3491.650834916488, 3552.378333791576, 3572.231970126383, 3574.4280915053987, 3589.802560859178, 1073.0, 1098.1544210957677, 1101.427257825942, 1114.2645853736494, 1121.0639116337786, 1297.7145028093805, 1307.0523870194033, 1330.414617568267, 1339.055965544289, 1340.4973135074347, 7116.537425067354, 7200.639968001579, 7223.602701851449, 7251.601161936039, 7273.490855640161, 498.50896866586385, 508.7913955278318, 511.5651696058395, 512.9743512824344, 514.580616797309, 5366.302380690485, 5441.238226648273, 5639.8590035249445, 5751.13732940054, 5755.395683453261, 8800.207981281716, 8975.147361000694, 9028.142326478974, 9055.36612437123, 9057.094290571022, 8760.299176065899, 8914.643414263357, 8933.642654293886, 8993.415427997159, 9110.362274640844, 6944.652767361612, 7008.579485230903, 7010.509264351548, 7064.894026589605, 7082.362587367162, 6955.0, 7031.0, 7033.226345102137, 7060.8940865886025, 7062.858742825218, 7783.727569535039, 7804.921950780419, 7865.370770338245, 7989.360851131779, 8037.67849286022, 8077.555734434663, 8118.878216826871, 8119.918800811916, 8256.174382561696, 8298.170182981654, 6499.740010399721, 6558.737650493927, 6559.540832141704, 6560.0, 6562.639054851838, 7337.6698048589005, 7402.7409040683315, 7442.144153422426, 7443.962780186064, 7461.626918653937, 6867.759628412981, 6929.688164032731, 6941.444684425132, 7030.261822508767, 7099.538529995534, 6836.692348844214, 6877.002834588857, 6897.48268879826, 6987.0567473392475, 7013.964930175316, 6876.69054892541, 6888.862222755617, 6911.17065952089, 6938.132733408324, 6944.965275173592, 6394.328595497405, 6416.647084410402, 6459.806205813833, 6465.482761378984, 6467.094606754964, 6556.2788093308745, 6578.210614726264, 6587.604743715392, 6598.868022639616, 6617.040529123154], "unit": "ms", "name": "mootools.html", "value": 4333.684595243928}, {"lowerIsBetter": false, "replicates": [327.76073466369536, 332.19277156509673, 343.36306152087883, 344.1070422254251, 346.62218182181425, 5967.1049342598635, 6057.727402266897, 6063.09053641954, 6081.422264884829, 6094.146819445281, 5762.596618236715, 5862.0913758367415, 5909.379515150912, 5970.2835659720895, 6012.518998480122, 4657.32468792025, 4661.930071048937, 4668.5564871337165, 4668.673192876483, 4671.929921051187, 4415.624671902892, 4676.836310729125, 4677.579017888389, 4681.368015317939, 4688.10925924075, 4460.3309503574565, 4502.0, 4624.421947256593, 4631.0, 4636.79134438951, 4615.907681846378, 4616.561426664462, 4624.121416930772, 4633.930491042637, 4639.884002899921, 4072.552019277877, 4074.7351422157467, 4077.531083925327, 4084.264832330179, 4088.632023117934, 5550.361708403545, 5647.407022262685, 5671.829845104653, 5672.347680016768, 5682.744276507526, 5312.76092575835, 5317.229001794718, 5322.20166974953, 5325.20121981702, 5326.786928522854, 6382.20222472191, 6383.234011918599, 6383.904241436336, 6386.680665966683, 6395.42441180296, 4401.6478681705385, 4402.053558484909, 4407.07451435199, 4413.735175889425, 4418.29307310832, 6423.42189202974, 6498.707558159894, 6500.4799616030605, 6543.541952063358, 6594.670266486656, 4539.341795439643, 4541.114482675913, 4542.046170304207, 4542.772861356919, 4545.8408955687055, 4580.038191979722, 4593.931091033637, 4594.058218065288, 4595.2188128018315, 4599.379083823641, 5285.973570132125, 5298.178782288752, 5301.3373328333955, 5302.893942121136, 5310.7610157543, 6317.305096439388, 6376.617402955838, 6428.839279018062, 6432.871342573216, 6435.232849874599, 1584.706829236595, 1606.2370374072457, 1606.9758953615706, 1608.8391160883818, 1611.7582362645696, 1072.485207100596, 1077.8167711489066, 1083.9945800270948, 1085.473545330514, 1085.5874767588423, 6179.752809887644, 6180.598261113013, 6207.751689932352, 6211.813645590549, 6213.968930155411, 6394.776182833579, 6611.966940165365, 6618.338166183343, 6621.1392518972225, 6624.337566243337, 6082.330943596201, 6161.630302181883, 6182.072689096582, 6200.472959798378, 6257.687115644199, 3587.0, 3606.783592984377, 3612.7290453216115, 3615.07815507044, 3620.637936206358, 6756.864862702719, 6930.410915072275, 6932.61870597122, 6935.757248496379, 6939.063226464363, 6861.691223894937, 6864.828379290558, 6875.1749790025515, 6879.0, 6885.518013739091, 6912.101426814482, 6940.618265995418, 6940.895886561706, 6941.0629565009085, 6946.965265173743, 6629.801105966829, 6685.565438246498, 6698.464122870061, 6699.430548403246, 6705.1283333166375, 6555.983822507519, 6582.8354291143105, 6591.242007169045, 6596.67016649156, 6602.900956485752, 6922.5154239204785, 6925.930740692528, 6933.237343892269, 6943.6875340608785, 6946.340097690711, 4497.97751011256, 4498.167838949805, 4498.730076195438, 4499.7975091120325, 4508.880826011769, 6459.773907913201, 6692.364225398579, 6696.0, 6698.129243198353, 6699.363560461748, 6499.935000649933, 6506.0, 6508.544401891822, 6515.381038801306, 6520.021996700343, 6239.376062393724, 6420.1974753155855, 6452.12896258999, 6490.740370385131, 6499.252585952676, 6282.371762823681, 6283.214598175228, 6288.339724328879, 6292.056191571301, 6308.179936608211, 6492.35076492347, 6514.9348506514325, 6524.151860258136, 6527.902081468686, 6534.4772418205475, 6210.875782484235, 6344.333844946214, 6355.14205582259, 6355.205599300088, 6358.586691865014], "unit": "ms", "name": "prototype.html", "value": 4840.173903946036}, {"lowerIsBetter": false, "replicates": [807.7415227127321, 820.5281962871354, 833.9416240863138, 834.9332053435724, 870.8084221471277, 10287.537060832261, 10373.325733827305, 10444.895551044487, 15975.360985560592, 16388.67222655546, 15210.0, 15308.6938261235, 15330.540083797476, 15337.769933451007, 15351.155686437241, 680.7923583307089, 688.9345512176335, 816.9060558035843, 830.4602008694367, 831.3432388413146, 818.3248819723722, 828.0436096308773, 832.2634468495395, 834.5284914023557, 834.7370578267856, 871.3290766110091, 871.481468526229, 873.5195642396689, 873.52829472085, 874.3879284500874, 710.5239489541993, 718.6299055986171, 719.0, 719.5358993449248, 867.8307729992654, 608.6256951974548, 620.534599050712, 620.9627422354673, 620.9875802483925, 621.0745988477182, 14058.367373468116, 14065.507707230197, 14077.084989475754, 14086.929565352108, 14093.506727264497, 12334.568290109893, 12470.251784892935, 12515.436805343781, 12762.17045892014, 13525.797113043312, 10344.431056291902, 10353.275270731052, 10458.633947811866, 10803.459827008619, 10950.507227174796, 3529.452934795085, 3545.7340699447645, 3569.678728914384, 3675.1547144156725, 3700.7409481336317, 48525.51474485281, 48588.27117593204, 48974.26538601888, 49177.26234106491, 49220.26169607459, 10203.38779673222, 10536.894631053745, 10929.672109836718, 11040.116790656728, 11152.905305426977, 19162.04189790533, 19183.52041198981, 19210.519737006685, 19220.423387298404, 19323.42029739082, 7463.141738700119, 7562.168161502231, 7573.848523029508, 7818.413618978486, 7906.683732650629, 4171.97914010434, 4223.429836971969, 4268.765217913045, 4290.120525292307, 4293.076988447437, 3061.9693803062128, 3083.9514565047994, 3097.303106800952, 3102.348506813549, 3106.0, 516.0891027336754, 538.9191621256764, 541.7074779618962, 557.3562535271767, 558.6340946679932, 635.8569321902535, 689.8137502874196, 692.2904023375979, 715.0989752911265, 732.2531018361242, 8130.186981301941, 8388.664453421794, 8488.533130677748, 8686.56567171639, 8893.155150260714, 573.888091822099, 646.8867948109062, 658.9044588534731, 694.4166899804188, 709.4324540367685, 4174.3947127666925, 4209.852655157055, 4245.405643209953, 4245.490541135084, 4259.659227261812, 55072.44927550753, 56452.435475645536, 56459.43540564542, 56592.71703641538, 56642.716786415804, 49869.75065124651, 50132.24801627979, 50941.235881461806, 51452.48547514552, 53614.731926340115, 48222.0, 48233.27650085252, 48241.5175848244, 48391.51608483941, 48506.0, 8573.18554737299, 8676.522791246289, 8677.305815534868, 8753.562321884008, 8824.779380515538, 34588.82705586456, 35487.82256088703, 35700.28599427945, 36053.45919811257, 36219.818900905324, 43097.78451107725, 43154.0, 43893.78053109714, 45502.0, 46529.0, 11105.333679979227, 11111.166662500507, 11223.71940701489, 11472.082233421474, 11506.539738410369, 12577.182483138567, 12829.93585032069, 12932.806007910078, 12935.676608084497, 12937.870621293667, 11278.323300601991, 11447.427628618703, 11477.540898363972, 11848.111391645489, 11849.585264515701, 11941.16411851162, 12037.299233448246, 12228.32744199042, 12393.690157746129, 12786.424610892345, 11253.887461125283, 11581.0, 11876.643700688994, 11882.76234475323, 12223.57217497419, 9382.859257111286, 9493.762655933657, 9531.90468095338, 9673.70978870635, 9700.563474643799, 8854.690085846965, 8860.64557417696, 9609.375390599589, 10136.695899123039, 10517.158627309644], "unit": "ms", "name": "yui.html", "value": 6409.300981853485}], "name": "dromaeo_css", "value": 7020.796376487108}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 104.0, 108.0, 110.0, 110.0, 99.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 150.0, 159.0, 124.0, 157.0, 151.0, 124.0, 168.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 159.0, 165.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 86.0, 97.0, 72.0, 71.0, 71.0, 110.0, 96.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 136.0, 90.0, 91.0, 90.0, 134.0, 90.0, 90.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 144.0, 145.0, 145.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 56.0, 57.0, 57.0, 66.0, 65.0, 54.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 70.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [122.0, 126.0, 123.0, 120.0, 133.0, 114.0, 119.0, 120.0, 124.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 139.0, 149.0, 149.0, 138.0, 149.0, 149.0, 150.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 66.0, 69.0, 67.0, 67.0, 69.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1495.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.1055292774425], "unit": "score", "name": "Richards", "value": 216.43656200000007}, {"lowerIsBetter": false, "replicates": [194.51468585878234], "unit": "score", "name": "DeltaBlue", "value": 339.9126379999999}, {"lowerIsBetter": false, "replicates": [284.09090909090907], "unit": "score", "name": "Encrypt", "value": 936.95712}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [778.2101167315175], "unit": "score", "name": "Earley", "value": 856.4049549999997}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [640.2048655569782], "unit": "score", "name": "Splay", "value": 127.28894200000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20921.63798011126}]} 06:01:42 INFO - RETURN: dromaeo_css: 7020.79 06:01:42 INFO - RETURN: kraken: 1495.50 06:01:42 INFO - RETURN: v8_7: 20921.64 06:01:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20921.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1495.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "7020.79"}}} 06:01:42 INFO - Return code: 0 06:01:42 INFO - # TBPL SUCCESS # 06:01:42 INFO - Running post-action listener: _resource_record_post_action 06:01:42 INFO - Running post-run listener: _resource_record_post_run 06:01:43 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 0; Write bytes: 513982464; Read time: 0; Write time: 466216 06:01:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 245690368; Read time: 0; Write time: 301064 06:01:44 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 268288000; Read time: 0; Write time: 164284 06:01:44 INFO - Running post-run listener: _upload_blobber_files 06:01:44 INFO - Blob upload gear active. 06:01:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:01:44 INFO - Copying logs to upload dir... 06:01:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.254026 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-23 06:01:43.563591) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:43.567655) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009879 build_url: 'https://queue.taskcluster.net/v1/task/num10TDNR0Oy9tiryNnSRw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:43.619671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:43.620020) ========= 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=6587686cb2da90a5f91b3170000001be-1448282362.887570-1388267822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:01:43.670342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:01:43.670649) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 06:01:43.670946) ========= ========= Total master_lag: 0.33 =========