builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1447335809.26 results: success (0) buildid: 20151112030238 builduid: 8fb8614915374199a582a2de5f08b97d revision: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.263245) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.263725) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.264026) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006689 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.289364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.289683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.332006) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.332525) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.382815) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.383264) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.383645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.383936) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 05:43:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2015-11-12 05:43:29 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.557608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.557917) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014712 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.624506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:29.624920) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --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 3cc3b1968524248450c465c4ea2ee5596ffa65f2 --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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 05:43:30,060 truncating revision to first 12 chars 2015-11-12 05:43:30,060 Setting DEBUG logging. 2015-11-12 05:43:30,060 attempt 1/10 2015-11-12 05:43:30,060 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cc3b1968524?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 05:43:30,311 unpacking tar archive at: mozilla-central-3cc3b1968524/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:30.198712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:30.199033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:30.206558) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:30.206874) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 05:43:30.207558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-12 05:43:30.207843) ========= /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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:43:30 INFO - MultiFileLogger online at 20151112 05:43:30 in /builds/slave/test-pgo 05:43:30 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:43:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:43:30 INFO - {'append_to_log': False, 05:43:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:43:30 INFO - 'blob_upload_branch': 'Firefox', 05:43:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:43:30 INFO - 'branch': 'Firefox', 05:43:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:43:30 INFO - 'config_files': ('talos/linux_config.py',), 05:43:30 INFO - 'default_actions': ('clobber', 05:43:30 INFO - 'read-buildbot-config', 05:43:30 INFO - 'download-and-extract', 05:43:30 INFO - 'populate-webroot', 05:43:30 INFO - 'create-virtualenv', 05:43:30 INFO - 'install', 05:43:30 INFO - 'run-tests'), 05:43:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:43:30 INFO - 'download_minidump_stackwalk': True, 05:43:30 INFO - 'download_symbols': 'ondemand', 05:43:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:43:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:43:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:43:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:43:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:43:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:43:30 INFO - 'installer_path': 'installer.exe', 05:43:30 INFO - 'log_level': 'info', 05:43:30 INFO - 'log_name': 'talos', 05:43:30 INFO - 'log_to_console': True, 05:43:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:43:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:43:30 INFO - 'opt_config_files': (), 05:43:30 INFO - 'pip_index': False, 05:43:30 INFO - 'sps_profile': False, 05:43:30 INFO - 'sps_profile_interval': 0, 05:43:30 INFO - 'suite': 'dromaeojs', 05:43:30 INFO - 'system_bits': '64', 05:43:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:43:30 INFO - 'title': 'talos-linux64-ix-014', 05:43:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:43:30 INFO - 'use_talos_json': True, 05:43:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:43:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:43:30 INFO - 'work_dir': 'build'} 05:43:30 INFO - ##### 05:43:30 INFO - ##### Running clobber step. 05:43:30 INFO - ##### 05:43:30 INFO - Running pre-action listener: _resource_record_pre_action 05:43:30 INFO - Running main action method: clobber 05:43:30 INFO - rmtree: /builds/slave/test-pgo/build 05:43:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:43:31 INFO - Running post-action listener: _resource_record_post_action 05:43:31 INFO - ##### 05:43:31 INFO - ##### Running read-buildbot-config step. 05:43:31 INFO - ##### 05:43:31 INFO - Running pre-action listener: _resource_record_pre_action 05:43:31 INFO - Running main action method: read_buildbot_config 05:43:31 INFO - Using buildbot properties: 05:43:31 INFO - { 05:43:31 INFO - "properties": { 05:43:31 INFO - "buildnumber": 546, 05:43:31 INFO - "product": "firefox", 05:43:31 INFO - "script_repo_revision": "production", 05:43:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:43:31 INFO - "repository": "", 05:43:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:43:31 INFO - "buildid": "20151112030238", 05:43:31 INFO - "slavename": "talos-linux64-ix-014", 05:43:31 INFO - "stage_platform": "linux64-pgo", 05:43:31 INFO - "basedir": "/builds/slave/test-pgo", 05:43:31 INFO - "nightly_build": "True", 05:43:31 INFO - "project": "", 05:43:31 INFO - "platform": "ubuntu64_hw", 05:43:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:43:31 INFO - "slavebuilddir": "test", 05:43:31 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:43:31 INFO - "branch": "mozilla-central", 05:43:31 INFO - "repo_path": "mozilla-central", 05:43:31 INFO - "pgo_build": "True", 05:43:31 INFO - "builduid": "8fb8614915374199a582a2de5f08b97d", 05:43:31 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:43:31 INFO - }, 05:43:31 INFO - "sourcestamp": { 05:43:31 INFO - "repository": "", 05:43:31 INFO - "hasPatch": false, 05:43:31 INFO - "project": "", 05:43:31 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:43:31 INFO - "changes": [ 05:43:31 INFO - { 05:43:31 INFO - "category": null, 05:43:31 INFO - "files": [ 05:43:31 INFO - { 05:43:31 INFO - "url": null, 05:43:31 INFO - "name": "https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:43:31 INFO - } 05:43:31 INFO - ], 05:43:31 INFO - "repository": "", 05:43:31 INFO - "rev": "3cc3b1968524248450c465c4ea2ee5596ffa65f2", 05:43:31 INFO - "who": "sendchange", 05:43:31 INFO - "when": 1447335744, 05:43:31 INFO - "number": 6653487, 05:43:31 INFO - "comments": "", 05:43:31 INFO - "project": "", 05:43:31 INFO - "at": "Thu 12 Nov 2015 05:42:24", 05:43:31 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:43:31 INFO - "revlink": "", 05:43:31 INFO - "properties": [ 05:43:31 INFO - [ 05:43:31 INFO - "buildid", 05:43:31 INFO - "20151112030238", 05:43:31 INFO - "Change" 05:43:31 INFO - ], 05:43:31 INFO - [ 05:43:31 INFO - "builduid", 05:43:31 INFO - "8fb8614915374199a582a2de5f08b97d", 05:43:31 INFO - "Change" 05:43:31 INFO - ], 05:43:31 INFO - [ 05:43:31 INFO - "nightly_build", 05:43:31 INFO - "True", 05:43:31 INFO - "Change" 05:43:31 INFO - ], 05:43:31 INFO - [ 05:43:31 INFO - "pgo_build", 05:43:31 INFO - "True", 05:43:31 INFO - "Change" 05:43:31 INFO - ] 05:43:31 INFO - ], 05:43:31 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:43:31 INFO - } 05:43:31 INFO - ], 05:43:31 INFO - "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2" 05:43:31 INFO - } 05:43:31 INFO - } 05:43:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:43:31 INFO - Running post-action listener: _resource_record_post_action 05:43:31 INFO - ##### 05:43:31 INFO - ##### Running download-and-extract step. 05:43:31 INFO - ##### 05:43:31 INFO - Running pre-action listener: _resource_record_pre_action 05:43:31 INFO - Running main action method: download_and_extract 05:43:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:31 INFO - https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/test_packages.json 05:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/test_packages.json 05:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:43:31 INFO - Downloaded 1302 bytes. 05:43:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:43:31 INFO - Using the following test package requirements: 05:43:31 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:43:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'jsshell-linux-x86_64.zip'], 05:43:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:43:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:43:31 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:43:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:43:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:43:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:43:31 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:43:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:31 INFO - https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:32 INFO - Downloaded 22439253 bytes. 05:43:32 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:43:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:32 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:43:33 INFO - Return code: 0 05:43:33 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:43:33 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:43:33 INFO - https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:43:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:35 INFO - Downloaded 22439253 bytes. 05:43:35 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:43:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:43:35 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:43:37 INFO - Return code: 0 05:43:37 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:43:37 INFO - https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:38 INFO - Downloaded 11131693 bytes. 05:43:38 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:43:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:43:38 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:43:38 INFO - Return code: 0 05:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:38 INFO - https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9AmsCazzTSqyTidO_IJbfA/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:43:41 INFO - Downloaded 57171796 bytes. 05:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:43:41 INFO - mkdir: /builds/slave/test-pgo/properties 05:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:43:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:43:41 INFO - Contents: 05:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:43:41 INFO - Running post-action listener: _resource_record_post_action 05:43:41 INFO - Running post-action listener: set_extra_try_arguments 05:43:41 INFO - ##### 05:43:41 INFO - ##### Running populate-webroot step. 05:43:41 INFO - ##### 05:43:41 INFO - Running pre-action listener: _resource_record_pre_action 05:43:41 INFO - Running main action method: populate_webroot 05:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:43:41 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:43:41 INFO - '../fennec_ids.txt'], 05:43:41 INFO - 'tests': ['tcheck2']}, 05:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:43:41 INFO - '--tppagecycles', 05:43:41 INFO - '7'], 05:43:41 INFO - 'tests': ['tsvgm']}}, 05:43:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:43:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:43:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:43:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'tests': ['damp', 'tps']}, 05:43:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['damp', 'tps']}, 05:43:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:41 INFO - 'other': {'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'other_l64': {'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'other_nol64': {'tests': ['a11yr', 05:43:41 INFO - 'ts_paint', 05:43:41 INFO - 'tpaint', 05:43:41 INFO - 'sessionrestore', 05:43:41 INFO - 'sessionrestore_no_auto_restore']}, 05:43:41 INFO - 'svgr': {'tests': ['tsvgx', 05:43:41 INFO - 'tsvgr_opacity', 05:43:41 INFO - 'tart', 05:43:41 INFO - 'tscrollx', 05:43:41 INFO - 'cart']}, 05:43:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['tsvgx', 05:43:41 INFO - 'tsvgr_opacity', 05:43:41 INFO - 'tart', 05:43:41 INFO - 'tscrollx', 05:43:41 INFO - 'cart']}, 05:43:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'tests': ['tp5o']}, 05:43:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'talos_options': ['--e10s'], 05:43:41 INFO - 'tests': ['tp5o']}, 05:43:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'talos_options': ['--xperf_path', 05:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:41 INFO - 'tests': ['tp5n']}, 05:43:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:43:41 INFO - 'talos_options': ['--e10s', 05:43:41 INFO - '--xperf_path', 05:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:41 INFO - 'tests': ['tp5n']}}, 05:43:41 INFO - 'talos.zip': {'path': '', 05:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:43:41 INFO - Running post-action listener: _resource_record_post_action 05:43:41 INFO - ##### 05:43:41 INFO - ##### Running create-virtualenv step. 05:43:41 INFO - ##### 05:43:41 INFO - Running pre-action listener: _resource_record_pre_action 05:43:41 INFO - Running main action method: create_virtualenv 05:43:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:43:41 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:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:43:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:41 INFO - Using real prefix '/usr' 05:43:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:43:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:43 INFO - Installing pip.................done. 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 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:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:43 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:43:43 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:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:43 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:43:43 INFO - Cleaning up... 05:43:43 INFO - Return code: 0 05:43:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:43 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:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:43 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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:43 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:43:43 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:43:43 INFO - Using env: {'DISPLAY': ':0', 05:43:43 INFO - 'HOME': '/home/cltbld', 05:43:43 INFO - 'LANG': 'en_US.UTF-8', 05:43:43 INFO - 'LANGUAGE': 'en_US:en', 05:43:43 INFO - 'LOGNAME': 'cltbld', 05:43:43 INFO - 'MAIL': '/var/mail/cltbld', 05:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:43 INFO - 'MOZ_NO_REMOTE': '1', 05:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:43 INFO - 'NO_EM_RESTART': '1', 05:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:43 INFO - 'SHELL': '/bin/bash', 05:43:43 INFO - 'SHLVL': '1', 05:43:43 INFO - 'TERM': 'linux', 05:43:43 INFO - 'TMOUT': '86400', 05:43:43 INFO - 'USER': 'cltbld', 05:43:43 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:43 INFO - '_': '/tools/buildbot/bin/python'} 05:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:44 INFO - Downloading/unpacking psutil>=0.7.1 05:43:44 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:43:44 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:43:44 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:43:44 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:43:44 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:43:44 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:43:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:45 INFO - Installing collected packages: psutil 05:43:45 INFO - Running setup.py install for psutil 05:43:45 INFO - building 'psutil._psutil_linux' extension 05:43:45 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:43:46 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:43:46 INFO - building 'psutil._psutil_posix' extension 05:43:46 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:43:46 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:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:46 INFO - Successfully installed psutil 05:43:46 INFO - Cleaning up... 05:43:46 INFO - Return code: 0 05:43:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:43:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:43:46 INFO - Using env: {'DISPLAY': ':0', 05:43:46 INFO - 'HOME': '/home/cltbld', 05:43:46 INFO - 'LANG': 'en_US.UTF-8', 05:43:46 INFO - 'LANGUAGE': 'en_US:en', 05:43:46 INFO - 'LOGNAME': 'cltbld', 05:43:46 INFO - 'MAIL': '/var/mail/cltbld', 05:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:46 INFO - 'MOZ_NO_REMOTE': '1', 05:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:46 INFO - 'NO_EM_RESTART': '1', 05:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:46 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:46 INFO - 'SHELL': '/bin/bash', 05:43:46 INFO - 'SHLVL': '1', 05:43:46 INFO - 'TERM': 'linux', 05:43:46 INFO - 'TMOUT': '86400', 05:43:46 INFO - 'USER': 'cltbld', 05:43:46 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:46 INFO - '_': '/tools/buildbot/bin/python'} 05:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:43:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:48 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:43:48 INFO - Installing collected packages: mozsystemmonitor 05:43:48 INFO - Running setup.py install for mozsystemmonitor 05:43:48 INFO - Successfully installed mozsystemmonitor 05:43:48 INFO - Cleaning up... 05:43:48 INFO - Return code: 0 05:43:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:43:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:43:48 INFO - Using env: {'DISPLAY': ':0', 05:43:48 INFO - 'HOME': '/home/cltbld', 05:43:48 INFO - 'LANG': 'en_US.UTF-8', 05:43:48 INFO - 'LANGUAGE': 'en_US:en', 05:43:48 INFO - 'LOGNAME': 'cltbld', 05:43:48 INFO - 'MAIL': '/var/mail/cltbld', 05:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:48 INFO - 'MOZ_NO_REMOTE': '1', 05:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:48 INFO - 'NO_EM_RESTART': '1', 05:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:48 INFO - 'SHELL': '/bin/bash', 05:43:48 INFO - 'SHLVL': '1', 05:43:48 INFO - 'TERM': 'linux', 05:43:48 INFO - 'TMOUT': '86400', 05:43:48 INFO - 'USER': 'cltbld', 05:43:48 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:48 INFO - '_': '/tools/buildbot/bin/python'} 05:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:50 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:43:50 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:43:50 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:43:50 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:43:50 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:43:50 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:43:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:43:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:50 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:43:50 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:43:50 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:43:50 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:43:50 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:43:50 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:43:50 INFO - Downloading docopt-0.6.1.tar.gz 05:43:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:43:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:51 INFO - Running setup.py install for blobuploader 05:43:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:51 INFO - Running setup.py install for requests 05:43:51 INFO - Running setup.py install for docopt 05:43:51 INFO - Successfully installed blobuploader requests docopt 05:43:51 INFO - Cleaning up... 05:43:51 INFO - Return code: 0 05:43:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:51 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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:51 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:43:51 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:43:51 INFO - Using env: {'DISPLAY': ':0', 05:43:51 INFO - 'HOME': '/home/cltbld', 05:43:51 INFO - 'LANG': 'en_US.UTF-8', 05:43:51 INFO - 'LANGUAGE': 'en_US:en', 05:43:51 INFO - 'LOGNAME': 'cltbld', 05:43:51 INFO - 'MAIL': '/var/mail/cltbld', 05:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:51 INFO - 'MOZ_NO_REMOTE': '1', 05:43:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:51 INFO - 'NO_EM_RESTART': '1', 05:43:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:51 INFO - 'SHELL': '/bin/bash', 05:43:51 INFO - 'SHLVL': '1', 05:43:51 INFO - 'TERM': 'linux', 05:43:51 INFO - 'TMOUT': '86400', 05:43:51 INFO - 'USER': 'cltbld', 05:43:51 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:51 INFO - '_': '/tools/buildbot/bin/python'} 05:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Running setup.py (path:/tmp/pip-8ewewR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:51 INFO - Running setup.py (path:/tmp/pip-ErsCRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:52 INFO - Running setup.py (path:/tmp/pip-c3fxXk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:52 INFO - Running setup.py (path:/tmp/pip-kIDO_2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:52 INFO - Running setup.py (path:/tmp/pip-MHds_p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:52 INFO - Running setup.py (path:/tmp/pip-iXV1my-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:52 INFO - Running setup.py (path:/tmp/pip-QR12G9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:52 INFO - Running setup.py (path:/tmp/pip-OAPEGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:52 INFO - Running setup.py (path:/tmp/pip-17thsa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Running setup.py (path:/tmp/pip-XvLhga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Running setup.py (path:/tmp/pip-fyAl5F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Running setup.py (path:/tmp/pip-yD8j9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Running setup.py (path:/tmp/pip-tHb4ji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Running setup.py (path:/tmp/pip-TeBOyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Running setup.py (path:/tmp/pip-cd0E8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:52 INFO - Running setup.py (path:/tmp/pip-fGDzdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:53 INFO - Running setup.py (path:/tmp/pip-3gV3zW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:53 INFO - Running setup.py install for manifestparser 05:43:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozcrash 05:43:53 INFO - Running setup.py install for mozdebug 05:43:53 INFO - Running setup.py install for mozdevice 05:43:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozfile 05:43:53 INFO - Running setup.py install for mozhttpd 05:43:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozinfo 05:43:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozInstall 05:43:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:43:53 INFO - Running setup.py install for mozleak 05:43:54 INFO - Running setup.py install for mozlog 05:43:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for moznetwork 05:43:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozprocess 05:43:54 INFO - Running setup.py install for mozprofile 05:43:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozrunner 05:43:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Running setup.py install for mozscreenshot 05:43:54 INFO - Running setup.py install for moztest 05:43:54 INFO - Running setup.py install for mozversion 05:43:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:43:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:54 INFO - Cleaning up... 05:43:54 INFO - Return code: 0 05:43:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:54 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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:54 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:43:54 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:43:54 INFO - Using env: {'DISPLAY': ':0', 05:43:54 INFO - 'HOME': '/home/cltbld', 05:43:54 INFO - 'LANG': 'en_US.UTF-8', 05:43:54 INFO - 'LANGUAGE': 'en_US:en', 05:43:54 INFO - 'LOGNAME': 'cltbld', 05:43:54 INFO - 'MAIL': '/var/mail/cltbld', 05:43:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:54 INFO - 'MOZ_NO_REMOTE': '1', 05:43:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:54 INFO - 'NO_EM_RESTART': '1', 05:43:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:54 INFO - 'SHELL': '/bin/bash', 05:43:54 INFO - 'SHLVL': '1', 05:43:54 INFO - 'TERM': 'linux', 05:43:54 INFO - 'TMOUT': '86400', 05:43:54 INFO - 'USER': 'cltbld', 05:43:54 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:54 INFO - '_': '/tools/buildbot/bin/python'} 05:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:55 INFO - Running setup.py (path:/tmp/pip-fHatnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:55 INFO - Running setup.py (path:/tmp/pip-fGrZwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:55 INFO - Running setup.py (path:/tmp/pip-hqZJqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:55 INFO - Running setup.py (path:/tmp/pip-DGPkBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:55 INFO - Running setup.py (path:/tmp/pip-hwHzdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 INFO - Running setup.py (path:/tmp/pip-eTipfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 INFO - Running setup.py (path:/tmp/pip-5XXbT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 INFO - Running setup.py (path:/tmp/pip-idzrJs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 INFO - Running setup.py (path:/tmp/pip-ykxcOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 INFO - Running setup.py (path:/tmp/pip-2hnpca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 INFO - Running setup.py (path:/tmp/pip-wyqkG2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 INFO - Running setup.py (path:/tmp/pip-LbrM8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:55 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:43:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:56 INFO - Running setup.py (path:/tmp/pip-q81GG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:56 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:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:56 INFO - Running setup.py (path:/tmp/pip-YlhjW7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:56 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:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:56 INFO - Running setup.py (path:/tmp/pip-AUPWJi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:56 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:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:56 INFO - Running setup.py (path:/tmp/pip-6G583r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:56 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:43:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:56 INFO - Running setup.py (path:/tmp/pip-HqfCFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:56 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:43:57 INFO - Downloading blessings-1.5.1.tar.gz 05:43:57 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:43:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:58 INFO - Installing collected packages: blessings 05:43:58 INFO - Running setup.py install for blessings 05:43:58 INFO - Successfully installed blessings 05:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:43:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Current package versions: 05:43:58 INFO - argparse == 1.2.1 05:43:58 INFO - blessings == 1.5.1 05:43:58 INFO - blobuploader == 1.2.4 05:43:58 INFO - docopt == 0.6.1 05:43:58 INFO - manifestparser == 1.1 05:43:58 INFO - mozInstall == 1.12 05:43:58 INFO - mozcrash == 0.16 05:43:58 INFO - mozdebug == 0.1 05:43:58 INFO - mozdevice == 0.47 05:43:58 INFO - mozfile == 1.2 05:43:58 INFO - mozhttpd == 0.7 05:43:58 INFO - mozinfo == 0.9 05:43:58 INFO - mozleak == 0.1 05:43:58 INFO - mozlog == 3.0 05:43:58 INFO - moznetwork == 0.27 05:43:58 INFO - mozprocess == 0.22 05:43:58 INFO - mozprofile == 0.27 05:43:58 INFO - mozrunner == 6.11 05:43:58 INFO - mozscreenshot == 0.1 05:43:58 INFO - mozsystemmonitor == 0.0 05:43:58 INFO - moztest == 0.7 05:43:58 INFO - mozversion == 1.4 05:43:58 INFO - psutil == 3.1.1 05:43:58 INFO - requests == 1.2.3 05:43:58 INFO - wsgiref == 0.1.2 05:43:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:58 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 0x7fb4371b8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dcc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, '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': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', '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:43:58 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:43:58 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:43:58 INFO - Using env: {'DISPLAY': ':0', 05:43:58 INFO - 'HOME': '/home/cltbld', 05:43:58 INFO - 'LANG': 'en_US.UTF-8', 05:43:58 INFO - 'LANGUAGE': 'en_US:en', 05:43:58 INFO - 'LOGNAME': 'cltbld', 05:43:58 INFO - 'MAIL': '/var/mail/cltbld', 05:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:58 INFO - 'MOZ_NO_REMOTE': '1', 05:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:58 INFO - 'NO_EM_RESTART': '1', 05:43:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:58 INFO - 'SHELL': '/bin/bash', 05:43:58 INFO - 'SHLVL': '1', 05:43:58 INFO - 'TERM': 'linux', 05:43:58 INFO - 'TMOUT': '86400', 05:43:58 INFO - 'USER': 'cltbld', 05:43:58 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:58 INFO - '_': '/tools/buildbot/bin/python'} 05:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:58 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:43:58 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:43:58 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:43:58 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:43:58 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:43:58 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:43:58 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:43:58 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:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:43:58 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:43:58 INFO - Cleaning up... 05:43:58 INFO - Return code: 0 05:43:58 INFO - Running post-action listener: _resource_record_post_action 05:43:58 INFO - Running post-action listener: _start_resource_monitoring 05:43:58 INFO - Starting resource monitoring. 05:43:58 INFO - ##### 05:43:58 INFO - ##### Running install step. 05:43:58 INFO - ##### 05:43:58 INFO - Running pre-action listener: _resource_record_pre_action 05:43:58 INFO - Running main action method: install 05:43:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:43:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:43:58 INFO - Reading from file tmpfile_stdout 05:43:58 INFO - Output received: 05:43:58 INFO - Usage: mozinstall [options] installer 05:43:58 INFO - Options: 05:43:58 INFO - -h, --help show this help message and exit 05:43:58 INFO - -d DEST, --destination=DEST 05:43:58 INFO - Directory to install application into. [default: 05:43:58 INFO - "/builds/slave/test-pgo"] 05:43:58 INFO - --app=APP Application being installed. [default: firefox] 05:43:58 INFO - mkdir: /builds/slave/test-pgo/build/application 05:43:58 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:43:58 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:44:13 INFO - Reading from file tmpfile_stdout 05:44:13 INFO - Output received: 05:44:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:44:13 INFO - Running post-action listener: _resource_record_post_action 05:44:13 INFO - ##### 05:44:13 INFO - ##### Running run-tests step. 05:44:13 INFO - ##### 05:44:13 INFO - Running pre-action listener: _resource_record_pre_action 05:44:13 INFO - Running main action method: run_tests 05:44:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:44:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:44:13 INFO - Python 2.7.3 05:44:13 INFO - Return code: 0 05:44:13 INFO - grabbing minidump binary from tooltool 05:44: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:44:13 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 0x1e02a90>, '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 0x1e54f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e552e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:44:13 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:44:13 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:44:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:13 INFO - Return code: 0 05:44:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:44:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:44:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:44:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:44:13 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/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:44:13 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/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 05:44:13 INFO - Using env: {'DISPLAY': ':0', 05:44:13 INFO - 'HOME': '/home/cltbld', 05:44:13 INFO - 'LANG': 'en_US.UTF-8', 05:44:13 INFO - 'LANGUAGE': 'en_US:en', 05:44:13 INFO - 'LOGNAME': 'cltbld', 05:44:13 INFO - 'MAIL': '/var/mail/cltbld', 05:44:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:13 INFO - 'MOZ_NO_REMOTE': '1', 05:44:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:13 INFO - 'NO_EM_RESTART': '1', 05:44:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:44:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:44:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:44:13 INFO - 'SHELL': '/bin/bash', 05:44:13 INFO - 'SHLVL': '1', 05:44:13 INFO - 'TERM': 'linux', 05:44:13 INFO - 'TMOUT': '86400', 05:44:13 INFO - 'USER': 'cltbld', 05:44:13 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874', 05:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:13 INFO - '_': '/tools/buildbot/bin/python'} 05:44:13 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/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 05:44:13 INFO - mozversion INFO | application_buildid: 20151112030238 05:44:13 INFO - mozversion INFO | application_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:44:13 INFO - mozversion INFO | application_display_name: Nightly 05:44:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:13 INFO - mozversion INFO | application_name: Firefox 05:44:13 INFO - mozversion INFO | application_remotingname: firefox 05:44:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:44:13 INFO - mozversion INFO | application_vendor: Mozilla 05:44:13 INFO - mozversion INFO | application_version: 45.0a1 05:44:13 INFO - mozversion INFO | platform_buildid: 20151112030238 05:44:13 INFO - mozversion INFO | platform_changeset: 3cc3b1968524248450c465c4ea2ee5596ffa65f2 05:44:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:44:13 INFO - mozversion INFO | platform_version: 45.0a1 05:44:13 INFO - 2015-11-12 05:44:13,899 DEBUG : using testdate: 1447335853 05:44:13 INFO - 2015-11-12 05:44:13,899 DEBUG : actual date: 1447335853 05:44:13 INFO - 2015-11-12 05:44:13,908 INFO : starting webserver on 'localhost:35024' 05:44:13 INFO - 2015-11-12 05:44:13,909 INFO : Starting test suite talos-linux64-ix-014 05:44:13 INFO - 2015-11-12 05:44:13,910 INFO : Starting test dromaeo_css 05:44:13 INFO - 2015-11-12 05:44:13,910 DEBUG : operating with platform_type : linux_ 05:44:13 INFO - 2015-11-12 05:44:13,910 INFO : Initialising browser for dromaeo_css test... 05:44:13 INFO - 2015-11-12 05:44:13,923 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBobBx2/profile http://localhost:35024/getInfo.html 05:44:17 INFO - 2015-11-12 05:44:17,998 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:44:17 INFO - 2015-11-12 05:44:17,999 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:44:17 INFO - 2015-11-12 05:44:17,999 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:44:17 INFO - 2015-11-12 05:44:17,999 DEBUG : BROWSER_OUTPUT: __metrics 05:44:18 INFO - 2015-11-12 05:44:18,216 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:44:19 INFO - 2015-11-12 05:44:19,443 INFO : Browser initialized. 05:44:19 INFO - 2015-11-12 05:44:19,444 INFO : Running cycle 1/1 for dromaeo_css test... 05:44:19 INFO - 2015-11-12 05:44:19,444 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBobBx2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:44:31 INFO - 2015-11-12 05:44:31,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 141656064 05:44:31 INFO - 2015-11-12 05:44:31,268 DEBUG : BROWSER_OUTPUT: 05:45:22 INFO - 2015-11-12 05:45:22,014 DEBUG : BROWSER_OUTPUT: 1447335922014 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:47:31 INFO - 2015-11-12 05:47:31,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35024/tests/dromaeo/cssquery-ext.html) 05:47:32 INFO - 2015-11-12 05:47:32,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 242356224 05:47:32 INFO - 2015-11-12 05:47:32,655 DEBUG : BROWSER_OUTPUT: 05:50:35 INFO - 2015-11-12 05:50:35,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-ext.html (next: http://localhost:35024/tests/dromaeo/cssquery-jquery.html) 05:50:35 INFO - 2015-11-12 05:50:35,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 215486464 05:50:35 INFO - 2015-11-12 05:50:35,621 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-12 05:53:37,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35024/tests/dromaeo/cssquery-mootools.html) 05:53:38 INFO - 2015-11-12 05:53:38,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 207060992 05:53:38 INFO - 2015-11-12 05:53:38,066 DEBUG : BROWSER_OUTPUT: 05:56:39 INFO - 2015-11-12 05:56:39,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35024/tests/dromaeo/cssquery-prototype.html) 05:56:40 INFO - 2015-11-12 05:56:40,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 199266304 05:56:40 INFO - 2015-11-12 05:56:40,503 DEBUG : BROWSER_OUTPUT: 05:59:42 INFO - 2015-11-12 05:59:42,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35024/tests/dromaeo/cssquery-yui.html) 05:59:43 INFO - 2015-11-12 05:59:43,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 199839744 05:59:43 INFO - 2015-11-12 05:59:43,517 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/dromaeo/cssquery-yui.html (next: http://localhost:35024/tests/dromaeo/cssquery-dojo.html) 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 216195072 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:02:46 INFO - 2015-11-12 06:02:46,327 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3277.442834718098;3309.8841540546055;3352.078178500912;3363.89908302751;3365.74756893233;5335.306410166682;5447.319085114361;5457.481539253769;5476.698781567012;5485.478879506445;5421.322334708161;5472.1244600863865;5484.7531861066245;5523.696196709179;5566.610337276392;4946.530079642428;4966.379202599675;5005.949940500603;5013.67411118278;5047.192449208127;4989.900201995976;5060.569851562604;5098.898022039557;5119.667221630601;5180.974095129519;4881.145799485093;4974.278729584226;4978.9544195718945;4982.227754698028;5041.747912604374;5018;5025.924611130836;5035.874103147451;5054.570361519275;5075.568576670988;4859.902801943941;4968.552830245295;5001.349824522825;5009.874753131165;5050.747462626854;5237.711925844077;5302.708351040691;5303.893922121536;5307;5313.654612450178;5957.493613042897;5959.672218028007;5961.344252132262;5963.165156878041;5968.791092311748;5798.565107616903;5897.793577224819;5972.790952316648;5979.730912108966;6001.279846418414;5643.5203007743985;5645.463680950304;5649.548036157097;5663.037283661746;5676.943230567683;6106.248323414603;6109.602875813058;6132.448079672851;6137.96931015351;6141.631502109798;5740.339860915965;5768.884622307531;5852.8536786579825;5893.675847828411;5921.111833225051;6035.909461358083;6067.332593414721;6072.089186621954;6073.939260607337;6089.117078023751;5993.190919225936;6008.068749343859;6010.459058684652;6022.668753218615;6025.397460253939;5751.482366587027;5810.12848072784;5923.555733320019;5963.165156878041;5967.820965370959;4551.47658019332;4551.658625603093;4552.567506086916;4561.133384656904;4596.287575425815;3943.3099207638547;4051.0682543015273;4052.8378864845668;4058.3100872851687;4087.734297270668;5602.663840169603;5610.943890561124;5655.632383895034;5691.943080569225;5739.741711622987;6047.969760151171;6073.726682299307;6080.726367313481;6081.27024757032;6092.939070609325;5492.780288788484;5620.241267428926;5721.885562288731;5746.367899531048;5750.338711048199;5076.3908330999775;5159.535641792257;5164.225366195101;5165.14775062118;5196.506331898464;6086.69566521681;6092.5430592705725;6092.817215483543;6151.415615516519;6174.938250617526;5874.353821079592;5887.116932460165;5983;5994.580379373402;6001.909971350346;6146.200993870768;6196.597221180609;6205.596636218631;6221.2845522765465;6268.843278918063;5932.644041357532;5951.583389162717;5967.522598192048;6004.249468816398;6004.909926351195;5833.0375488044;5847.795327163529;5955.076963070731;5958.404159584007;6093.664848433379;5794.884102318014;5880.000399931936;5881.823545293648;5885.5880088395115;5893;5879.853003674943;5890.587658863838;5896.823095307148;5904.291485021825;5904.586678932434;5526.032944234823;5636.0418728815375;5659.462351076641;5742.397048309867;5786.189933409242;5830.53355731532;5877.089051197071;5908.05471124618;5908.379620139824;5962.314333851663;5578.748956297058;5760.0783874579865;5765.971170144123;5767.019606666793;5767.653940763567 06:02:46 INFO - 2015-11-12 06:02:46,329 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.0661375029271;582.7843697831802;595.3034949109542;602.8214839987825;605.3250625552507;38022.42966355507;38601.61398386015;38603;38636.420453693216;38699.613003869985;42677.35983960243;43179.3523097153;43208.56791432085;43234.351484727675;43240.56759432405;7609.162992070867;7701.614919254043;8661.437006594568;8751.168638979287;10108.44403557804;10214.080732734052;10328.483575821216;10332.741681457948;10347.844782328271;10349.534270957825;10345;10439;10450.372977621368;10464.633737819178;10467.790644187111;7827.25641064098;7987.400944929153;10378.844317335246;10556.155507559377;10571.629992950287;10109;10156.695299141038;10215.795684086352;10219.948900255526;10220.795584088351;38570.22859542821;39011.804940975395;39018.21963560741;39066.80466597677;39147.804260978795;3026.6973302669776;3131.3267647455905;3237.611486621597;3458.325626502833;3901.8049097545295;29313.267168320748;29371.55942660862;29387;29456.969006084684;29944;3392.7794693344854;3456.3087382523595;3515.050936247199;3530.435130379127;3546.3616549021167;275134;277161;278371;278568;279760;54711.17933231005;55188.44811551913;55418.44581554133;55469.1679624806;55693.44306556883;58285.417145827996;58344;58375;58646.12030819541;58709.41290587039;15234.619134521505;15317.846821531864;15330.693386132438;15364.462243821412;15393.692126157413;11653.18427710069;11714.414279286002;11724.179307448567;11725.530978760755;11740.178187526963;18598.16308266131;18829.52926176829;18983.33558325452;18989.90505047466;19065.42803715891;7403.407727381797;7584.962075189589;7591.734289299848;7699.807504812313;7721.189275126031;967.3953778888194;970.403202030746;985.1380042462845;1058.8994045565812;1100.2463312630873;27448.862755686092;27917.441651166864;28254.576181357297;28317.858410708228;28404.85797570999;1042.3745752548562;1044.3472829481575;1057.5769692123058;1065.142560239015;1114.4483480676954;14410;14648.633784155481;14687.632809179857;14771.335289911765;14865.405383784744;321127;326080;326170;326239;326986;45656.543434565894;46006;46006.07987840224;46146.307805382945;46164;1303.3157592264138;1311.3705421397592;1315.4738104758173;1339.651690560442;1344.1061693973593;25069.247922562354;25264.62103068492;26198.214053578424;26342.341441464116;26577.601335980362;42186.78906605447;42657;42729.35905961351;42741;42785;217713;217970;218670;219445;219788;26920.730792691822;27179.456410872066;29302.120936371943;30056.699433006266;30367.544486832274;36029.27941441209;36317.45523817092;37159.25681486409;37199.81400092982;39910.800445997585;33950;34009.65990340065;34227.14432139217;34372.82813585916;35060.47409288914;27318.180454586392;31780.36439271248;32025.83987080143;33841.83079084589;34336.82831585826;31172.688273117885;31669;31891.840540797148;31919.68080319167;32101;27904.860475697493;28797;30908.82730831309;40214;42150.36774448324;29844.85077574598;30627.54058689077;30911.536326955564;31248.531272030483;31512.842435787676 06:02:46 INFO - 2015-11-12 06:02:46,330 DEBUG : BROWSER_OUTPUT: |2;jquery.html;344.34851642353874;347.29672413362937;348.35380369414736;350.3798277049624;350.5775540473729;14608.4887028954;14981.850181498181;16620.335186592536;16834.579135521617;17383.130843457824;15742.685146297068;15914.920425397857;15927.920360398211;16273.267702953366;16617.83382166178;4956.3804524434445;4972.2044472884345;5008.624353173508;5037.319961805146;5044.344235249412;4018.5780493048246;4086.509618845743;5475.945240547603;5953.464188223059;6112.022076467766;6016.669083200422;6023.6988150592515;6025.969870150665;6038.154658347835;6052.667103309316;5866.208061911651;6009.609375390607;6011.398860113954;6013.789517366871;6015.819525414223;5261.6842989420375;5281.366236051698;5287.973560132214;5288.550473209782;5293.073712100367;21327.46681332979;21831.563368732535;21923.342299731034;22066.558668826532;22561.887190564106;2171.185805323004;2190.726159230096;2209.359285807114;2210.723659542557;2270.6594010898334;13605;14001.369938352798;14099.859001409957;14201.715965680733;14203.502877399242;1902.581432084953;1913.1390874106569;1916.281394477071;1931.449536881996;1962.1758861278297;65066.67466662684;67288.32711672918;67880.32119678789;68294;69128.3087169127;15096.773548396783;15612.92193539025;15674.529764107096;15722.921385393;15741.370345186064;24002;24073;24284.878575607363;24307.756922430905;24343.513129737305;9084.137006984325;9147.085291470932;9177.724668259963;9234.630614775468;9243.029481904437;7922.326602238759;7945.443818932619;7962.283394494408;7966.243206895336;8002.159773223728;7478.962605186939;7541.585212813238;7617.923820761722;7622.742247529096;7625.885611715828;1137.6643890052455;1154.7113221694576;1157.467306276002;2067.508652074247;2906.3606006678497;456.6734784629006;489.9902001959941;498.6459613674332;498.6982875360427;521.8904030153634;12147.75704485923;12156.513739450324;12190.268583884996;12287.385630718607;12428.56500022495;494.98020079197147;501.7140230068826;505.8659455244363;508.8168259426677;513.0867056639188;6148.262208534915;6261.8747625047245;6298.307186209513;6443.48452123829;6476.44565304333;484705;488097;554830;559218;561875;65686.67156664282;66207.66896165488;67392;67936.320636793;75592.24407755962;550.3753240072466;563.9989019490355;565.7001789051809;569.2798609758659;569.8888716700286;10822.729431764268;10905.618303359344;11156.609518666808;11183.161262905152;11213.15901307389;20841.791582084592;30310.242243944078;32749.345013100083;33109.66890331066;34732.65267347294;44039.77980110207;44978.77510612426;47308.763456182496;47604.52395476001;48576.75711621419;6696.732130714717;6756.391924726799;6923.480738944499;6930.688119034555;6933.064036355229;12248.142630015813;12390.685704387133;12543.87456125427;12623.810642840548;12633.2420054797;10862.076723478593;10990.560377584807;11086.833697494705;11145.777084458428;11166.944165279121;10638.84041739359;10768.40773757451;10929;10961.342319460859;11153.21927465102;10666.413347265974;10762.08522275584;10886.891131088587;10914.290571112851;10914.563417463212;6660.666966651551;6810.965945170441;6814.693338799865;6820.147481564804;6932.0988271524375;8926.062763410007;10421.114205292635;10567.89432105669;11045;11066.059384952046 06:02:46 INFO - 2015-11-12 06:02:46,334 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1468.1044562816683;1513.9015963962343;1579.8341174176703;1635.5911022244438;1785.5000599832044;6971.895421568681;7482.214367491417;7758.922410775897;7775.066991960958;7776.105747839;7502.512336698111;7636.7708968730885;7642.694292228318;7656.425768067389;7711.961440192791;1938.3797184900836;1978.179055691886;2220.589190999662;2225.5771403433378;2229.3312006398096;2246;2248.033345661365;2250.9983057539403;2251.4258863989658;2251.786080322375;2152.924647637333;2236.686863839064;2237;2238.037643813168;2241.4956634757214;1962.5486138188226;1995.381431756153;2153.278651651691;2200.8239340852692;2200.8899555022185;2233.8212942964524;2250.9212177573704;2257.0745994142485;2273.59075366434;2275.055851821492;7630.961845190794;7782.571958542278;7789.091672540264;7792.142864284924;7797.025371828521;4491.573300536444;4551.089782043605;4559.407277053995;4584.083183363341;4584.839530616412;2879.280179955011;2939.103573410109;2963.140689200151;2972.9405411891858;2993.580898674187;950.064186776025;952.7475219066953;961.5769061612868;977.858210559472;997.0478193325357;10534.683959481228;10554.050135487843;10558.419286939215;10562.841557376645;10564.418956957365;4087.8569250076102;4167.604077612622;4217.514985776675;4244.745315281093;4252.659787217015;9065.546722663841;9095.454272743524;9096;9098.86351704725;9101.772455688528;4633.72197668141;4656.95343046572;4659.091477161988;4664;4673.883152921204;4249.532551419341;4249.723767955073;4255.063885945087;4261.659067274611;4265.1043280910735;3556.9110772230383;3586.8744593939086;3609.6029436761937;3612.349777040158;3627;1183.2663748475827;1187.252031220343;1189.5598628507507;1193.7373777768878;1204.4339160594507;924.6347692661361;1285.832841730569;1288.3944546063335;1300.3693208793727;1316.1116246533552;6336.968315158395;7147.857042859114;7252.456065795086;7259.237780033126;7265.273472652798;678.6572780745691;692.2074225012333;695.3776370148789;699.7515881861866;706.1949377709416;5370.248165256867;5393.622446428791;5412.0258353495965;5413.53984911287;5422.457754224625;8755.518446485377;8787.780305492413;8915.910840891638;9011.864822027675;9154.954225228965;8901.243394311427;8907.643694252158;8941.016488186295;8984.640614375483;9019.954900225588;6856.794296171123;6976.4767642426;6991.825204369931;7012.509124361246;7014.438844892396;6552.410283074546;6582.80251592453;6584.407403333723;6616.239132499824;6624.7412991531455;7619.961900190464;7734.845303093794;7977.242161994601;7989.360851131779;7996.960015200119;8070.273675369245;8081.878771818545;8304.418690691593;8325.084240733635;8446.197611226924;6631.972044333136;6765.086713293643;6777.525573210025;6779.830504237433;6795.830104247433;7470.4770666052855;7536.623168841646;7548.169701332739;7552.169261381134;7563.357114645317;6999.300069993164;7022.157341119098;7048.859022819617;7166.749163779243;7170.498065135391;6812.284710105566;6860.794176174722;6921.065656136358;7026.824329391806;7056.6118863463;5954.940450595439;6046.667433291212;6511.283758786624;6656.900146497903;6691.2639609643875;6150.231221097363;6181.072839073995;6239.438450539473;6239.812805615838;6251.499880009679;6095.207623008981;6133.049377346519;6164.106204600397;6164.352742961924;6166.229221347332 06:02:46 INFO - 2015-11-12 06:02:46,334 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.09695561560784;319.2895806829803;322.20254869198726;323.3113468312494;328.7961463892387;5677.43225677432;5728.283964504437;5761.049426844571;5775.855603609906;5798.5361171106315;5614.522765564931;5660.433956604337;5670.858228544288;5727.971360143204;5739.139129130633;4398.098389830093;4417.983863711348;4419.955800441995;4420.31485119807;4420.403245561856;4262.78686065697;4335.371371151197;4344.522102568731;4417.469903611571;4463.575960283784;4416.425864637593;4424.690271680967;4431.512533621299;4438.223310920592;4449.466064072316;4408.625266852321;4417.690761646686;4422;4423.447069116361;4425.247707889666;3892.163184915257;3893.143508428141;3893.7079719021185;3894.1432884765304;3896.5713771485116;5401.675899446046;5501.367342755594;5512.779488820443;5555.416681248451;5567.972160139214;5154.768035438415;5154.92267615986;5158.045761534128;5161.303224064741;5163.3545806774155;6068.453839154453;6077.209962704865;6079.240094988127;6079.908801367983;6106.511479081707;4073.4704488416614;4121.175764847013;4238.279492486254;4295.098029413827;4307.956920430787;6238.376162383725;6245.56281060326;6251.312355640921;6251.74993000284;6253.6873156342;4370.912581748411;4376.015396535754;4396.626286765597;4400.22995975703;4409;4341.6526677865695;4413.7572433515825;4418.226810308183;4420.668449866273;4456.7548784817145;5104.821331253463;5105.7191854448365;5107.668001579886;5155.587552995751;5160.045391602491;6133.202683651097;6162.568620196633;6167.044108163242;6167.753289868445;6169.352218017133;1621.8459246371576;1639.8688104951575;1639.8934069285458;1641.499342700488;1641.8029836419705;1082.4587706146926;1094.3215206571977;1099.7470581766238;1100.2518287564533;1127.8984891359817;5974.970125149433;5976.043832986701;5980.55145864062;5987.221661184105;5996.67018313997;6342.778002769881;6346.587471814318;6346.682665866781;6350.872982540416;6357.841053973688;5973.731182096816;5978.432048955342;5980.13288073227;5984.700764961734;5984.850378740566;3479;3546.840392182358;3549.4675798629896;3550.520679708258;3553.893383198508;6368.840778980562;6407.935920640827;6415.26224484181;6420.7431702731365;6427.100205971168;6440.420362167428;6468.902966455507;6476.384743449365;6478.319776423407;6481.222253329536;6321.1782468278825;6469.902951455732;6474.546781725328;6475.222973243241;6585.835354116185;6407.199100112486;6408.679566021773;6409.198850143732;6411.51913606472;6417.48660107181;6091.939080609137;6159.907601386072;6200.968995154995;6267.655278959701;6275.811725648238;6474.320196379501;6493.935060649522;6495.740170393131;6498.252700939453;6502.349765023459;4218.303979843292;4218.451601291812;4228.767417792051;4233.470816147981;4234.237837189212;6179.876402471836;6294.779682711083;6303.684815759286;6314.84212894663;6322.241331040304;6168.136460895388;6171.722272497838;6176.227971503562;6176.320604733565;6178.505719542336;6157.076438534076;6158.846028849314;6163.291221509584;6163.3528479509005;6170.568060235741;5921.052631578927;6036.215292012186;6042.1540984261355;6043.184170136975;6049.30433000193;6148.292946311231;6175.69121543912;6186.845328866814;6190.1952746142715;6192.473639740672;6000.549958753199;6017.608855424383;6021.2473440819895;6031.819045428644;6053.364396738455 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.9428848547873;703.1393336539941;707.5188871567335;712.3446429285058;730.550711312543;12591.244525328475;13017.088803783727;13681.452741890313;13697.17816930985;13707.725845483084;12987.610371688865;13090;13090.47638094475;13101;13104.41030153643;669.0666520204336;672.1732269308753;780.8555417247799;797.5852556670528;799.6241766369797;795.7334293011847;796.7689370082669;797.4776521378507;801.046754362307;802.9962546816479;832.342449464922;832.5421018439864;836.4688422851473;842;842.5787106446777;688.0333131949594;696.7596179318152;821.0844907927677;832.1719888710771;836.3100442135202;613.6962203709148;615.2678312807744;616.300498933709;616.4575173847031;617.0497433951709;12845.807312890314;13018.934905325508;13022.153560018569;13023.86976130236;13037.413316400785;11311.604093856758;11749.118816088827;11903.47085072408;12054.879451205463;12185.147039707224;9399.718008459757;9444.622215111387;9544.665936692183;9678.419294842262;9711.174550163245;3462.3940810358085;3489.180042689966;3510;3523.4890940813693;3594.6405359463843;48912.51087489115;49660.751696241285;49733.502664973246;49815.754606134775;49854.25218621687;9514.429134251828;9624.085711857362;9702.320837541445;9779.217662587118;10060.69817905464;17534.912325438545;17578.12109394525;17581.120943952752;17594.64810703779;17594.91202543979;7008.544444611084;7013.824654383681;7031.402330801837;7113.786586402416;7203.567785932861;4127.669786417079;4128.153728485653;4145.585441455831;4194.454720886265;4199.811008504625;2890.2485353807742;2912.51943429336;2917.3873486567636;2918.8102773319665;2925.8975935842145;439.7515403796908;446.76991349455056;453.42415132781844;460.45666113985817;463.78665813726064;516.2591680937866;549.5850632772311;550.1088237055994;570.8886767080462;626.5958456795341;8757.781055473537;8761.123887611187;8955.507447090473;8999.955000225087;9063.501507417155;492.20103986135183;499.56787378916977;610.4963405190647;635.7870113511933;656.3239862941178;3995.580464051233;4049.797510124541;4071.0840060986634;4074.4295798588223;4088.1619268049976;61538;61577.38422615806;61672;61731;61818.69090654518;54486;56526.43473565212;56540.43459565434;56543.15185272142;56550;50206;50848;51378.74310628423;51968.582670473435;51988.74005629947;8103.351731861555;8389.874151887605;8392.20274073962;8499.532525710898;8542.82914341722;34903.82548087243;35583;36185;36213.818930905174;36307.45538816867;42778.35832462453;43166.35250471308;46426.07147857091;47097.293540596234;47381.52618473771;7234.276572342724;7500.699972001059;7578.621068946421;7915.168907264654;7942.364610831235;10318.535665894902;10565.471726413802;10570.630027948984;10575.206859485415;10842.512086955949;10365.9481702591;10431.68704938853;10466.110380617733;10880.891191087987;10912.454377280945;9411.670591529264;9541.332106752461;9940.403575785476;9946.850797237903;9966.800663986534;8765.474071555727;10094.798104038025;10316.587336506456;10462.947685261524;10484.318519296221;9463.763405914908;9464.526773661428;9497.857532136884;9706.805863882824;9820.656277030555;9423.905760942303;9676.81099001429;9762.85355719679;9843.60625574969;9938.950305248427 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,847 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: __startTimestamp1447336966326__endTimestamp 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,335 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5530.56 Median:5760.08 stddev:634.06 (11.0%) stddev-sans-first:610.87 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: Values: 3277.4 3309.9 3352.1 3363.9 3365.7 5335.3 5447.3 5457.5 5476.7 5485.5 5421.3 5472.1 5484.8 5523.7 5566.6 4946.5 4966.4 5005.9 5013.7 5047.2 4989.9 5060.6 5098.9 5119.7 5181.0 4881.1 4974.3 4979.0 4982.2 5041.7 5018.0 5025.9 5035.9 5054.6 5075.6 4859.9 4968.6 5001.3 5009.9 5050.7 5237.7 5302.7 5303.9 5307.0 5313.7 5957.5 5959.7 5961.3 5963.2 5968.8 5798.6 5897.8 5972.8 5979.7 6001.3 5643.5 5645.5 5649.5 5663.0 5676.9 6106.2 6109.6 6132.4 6138.0 6141.6 5740.3 5768.9 5852.9 5893.7 5921.1 6035.9 6067.3 6072.1 6073.9 6089.1 5993.2 6008.1 6010.5 6022.7 6025.4 5751.5 5810.1 5923.6 5963.2 5967.8 4551.5 4551.7 4552.6 4561.1 4596.3 3943.3 4051.1 4052.8 4058.3 4087.7 5602.7 5610.9 5655.6 5691.9 5739.7 6048.0 6073.7 6080.7 6081.3 6092.9 5492.8 5620.2 5721.9 5746.4 5750.3 5076.4 5159.5 5164.2 5165.1 5196.5 6086.7 6092.5 6092.8 6151.4 6174.9 5874.4 5887.1 5983.0 5994.6 6001.9 6146.2 6196.6 6205.6 6221.3 6268.8 5932.6 5951.6 5967.5 6004.2 6004.9 5833.0 5847.8 5955.1 5958.4 6093.7 5794.9 5880.0 5881.8 5885.6 5893.0 5879.9 5890.6 5896.8 5904.3 5904.6 5526.0 5636.0 5659.5 5742.4 5786.2 5830.5 5877.1 5908.1 5908.4 5962.3 5578.7 5760.1 5766.0 5767.0 5767.7 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44030.86 Median:17189.93 stddev:72416.92 (421.3%) stddev-sans-first:72546.51 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: Values: 560.1 582.8 595.3 602.8 605.3 38022.4 38601.6 38603.0 38636.4 38699.6 42677.4 43179.4 43208.6 43234.4 43240.6 7609.2 7701.6 8661.4 8751.2 10108.4 10214.1 10328.5 10332.7 10347.8 10349.5 10345.0 10439.0 10450.4 10464.6 10467.8 7827.3 7987.4 10378.8 10556.2 10571.6 10109.0 10156.7 10215.8 10219.9 10220.8 38570.2 39011.8 39018.2 39066.8 39147.8 3026.7 3131.3 3237.6 3458.3 3901.8 29313.3 29371.6 29387.0 29457.0 29944.0 3392.8 3456.3 3515.1 3530.4 3546.4 275134.0 277161.0 278371.0 278568.0 279760.0 54711.2 55188.4 55418.4 55469.2 55693.4 58285.4 58344.0 58375.0 58646.1 58709.4 15234.6 15317.8 15330.7 15364.5 15393.7 11653.2 11714.4 11724.2 11725.5 11740.2 18598.2 18829.5 18983.3 18989.9 19065.4 7403.4 7585.0 7591.7 7699.8 7721.2 967.4 970.4 985.1 1058.9 1100.2 27448.9 27917.4 28254.6 28317.9 28404.9 1042.4 1044.3 1057.6 1065.1 1114.4 14410.0 14648.6 14687.6 14771.3 14865.4 321127.0 326080.0 326170.0 326239.0 326986.0 45656.5 46006.0 46006.1 46146.3 46164.0 1303.3 1311.4 1315.5 1339.7 1344.1 25069.2 25264.6 26198.2 26342.3 26577.6 42186.8 42657.0 42729.4 42741.0 42785.0 217713.0 217970.0 218670.0 219445.0 219788.0 26920.7 27179.5 29302.1 30056.7 30367.5 36029.3 36317.5 37159.3 37199.8 39910.8 33950.0 34009.7 34227.1 34372.8 35060.5 27318.2 31780.4 32025.8 33841.8 34336.8 31172.7 31669.0 31891.8 31919.7 32101.0 27904.9 28797.0 30908.8 40214.0 42150.4 29844.9 30627.5 30911.5 31248.5 31512.8 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,336 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28039.59 Median:24063.14 stddev:86746.90 (360.5%) stddev-sans-first:86965.32 06:02:46 INFO - 2015-11-12 06:02:46,337 DEBUG : BROWSER_OUTPUT: Values: 344.3 347.3 348.4 350.4 350.6 14608.5 14981.9 16620.3 16834.6 17383.1 15742.7 15914.9 15927.9 16273.3 16617.8 4956.4 4972.2 5008.6 5037.3 5044.3 4018.6 4086.5 5475.9 5953.5 6112.0 6016.7 6023.7 6026.0 6038.2 6052.7 5866.2 6009.6 6011.4 6013.8 6015.8 5261.7 5281.4 5288.0 5288.6 5293.1 21327.5 21831.6 21923.3 22066.6 22561.9 2171.2 2190.7 2209.4 2210.7 2270.7 13605.0 14001.4 14099.9 14201.7 14203.5 1902.6 1913.1 1916.3 1931.4 1962.2 65066.7 67288.3 67880.3 68294.0 69128.3 15096.8 15612.9 15674.5 15722.9 15741.4 24002.0 24073.0 24284.9 24307.8 24343.5 9084.1 9147.1 9177.7 9234.6 9243.0 7922.3 7945.4 7962.3 7966.2 8002.2 7479.0 7541.6 7617.9 7622.7 7625.9 1137.7 1154.7 1157.5 2067.5 2906.4 456.7 490.0 498.6 498.7 521.9 12147.8 12156.5 12190.3 12287.4 12428.6 495.0 501.7 505.9 508.8 513.1 6148.3 6261.9 6298.3 6443.5 6476.4 484705.0 488097.0 554830.0 559218.0 561875.0 65686.7 66207.7 67392.0 67936.3 75592.2 550.4 564.0 565.7 569.3 569.9 10822.7 10905.6 11156.6 11183.2 11213.2 20841.8 30310.2 32749.3 33109.7 34732.7 44039.8 44978.8 47308.8 47604.5 48576.8 6696.7 6756.4 6923.5 6930.7 6933.1 12248.1 12390.7 12543.9 12623.8 12633.2 10862.1 10990.6 11086.8 11145.8 11166.9 10638.8 10768.4 10929.0 10961.3 11153.2 10666.4 10762.1 10886.9 10914.3 10914.6 6660.7 6811.0 6814.7 6820.1 6932.1 8926.1 10421.1 10567.9 11045.0 11066.1 06:02:46 INFO - 2015-11-12 06:02:46,338 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,338 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5290.40 Median:6294.23 stddev:2752.40 (43.7%) stddev-sans-first:2745.13 06:02:46 INFO - 2015-11-12 06:02:46,339 DEBUG : BROWSER_OUTPUT: Values: 1468.1 1513.9 1579.8 1635.6 1785.5 6971.9 7482.2 7758.9 7775.1 7776.1 7502.5 7636.8 7642.7 7656.4 7712.0 1938.4 1978.2 2220.6 2225.6 2229.3 2246.0 2248.0 2251.0 2251.4 2251.8 2152.9 2236.7 2237.0 2238.0 2241.5 1962.5 1995.4 2153.3 2200.8 2200.9 2233.8 2250.9 2257.1 2273.6 2275.1 7631.0 7782.6 7789.1 7792.1 7797.0 4491.6 4551.1 4559.4 4584.1 4584.8 2879.3 2939.1 2963.1 2972.9 2993.6 950.1 952.7 961.6 977.9 997.0 10534.7 10554.1 10558.4 10562.8 10564.4 4087.9 4167.6 4217.5 4244.7 4252.7 9065.5 9095.5 9096.0 9098.9 9101.8 4633.7 4657.0 4659.1 4664.0 4673.9 4249.5 4249.7 4255.1 4261.7 4265.1 3556.9 3586.9 3609.6 3612.3 3627.0 1183.3 1187.3 1189.6 1193.7 1204.4 924.6 1285.8 1288.4 1300.4 1316.1 6337.0 7147.9 7252.5 7259.2 7265.3 678.7 692.2 695.4 699.8 706.2 5370.2 5393.6 5412.0 5413.5 5422.5 8755.5 8787.8 8915.9 9011.9 9155.0 8901.2 8907.6 8941.0 8984.6 9020.0 6856.8 6976.5 6991.8 7012.5 7014.4 6552.4 6582.8 6584.4 6616.2 6624.7 7620.0 7734.8 7977.2 7989.4 7997.0 8070.3 8081.9 8304.4 8325.1 8446.2 6632.0 6765.1 6777.5 6779.8 6795.8 7470.5 7536.6 7548.2 7552.2 7563.4 6999.3 7022.2 7048.9 7166.7 7170.5 6812.3 6860.8 6921.1 7026.8 7056.6 5954.9 6046.7 6511.3 6656.9 6691.3 6150.2 6181.1 6239.4 6239.8 6251.5 6095.2 6133.0 6164.1 6164.4 6166.2 06:02:46 INFO - 2015-11-12 06:02:46,339 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,339 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5129.74 Median:5947.39 stddev:1527.15 (25.7%) stddev-sans-first:1488.13 06:02:46 INFO - 2015-11-12 06:02:46,339 DEBUG : BROWSER_OUTPUT: Values: 319.1 319.3 322.2 323.3 328.8 5677.4 5728.3 5761.0 5775.9 5798.5 5614.5 5660.4 5670.9 5728.0 5739.1 4398.1 4418.0 4420.0 4420.3 4420.4 4262.8 4335.4 4344.5 4417.5 4463.6 4416.4 4424.7 4431.5 4438.2 4449.5 4408.6 4417.7 4422.0 4423.4 4425.2 3892.2 3893.1 3893.7 3894.1 3896.6 5401.7 5501.4 5512.8 5555.4 5568.0 5154.8 5154.9 5158.0 5161.3 5163.4 6068.5 6077.2 6079.2 6079.9 6106.5 4073.5 4121.2 4238.3 4295.1 4308.0 6238.4 6245.6 6251.3 6251.7 6253.7 4370.9 4376.0 4396.6 4400.2 4409.0 4341.7 4413.8 4418.2 4420.7 4456.8 5104.8 5105.7 5107.7 5155.6 5160.0 6133.2 6162.6 6167.0 6167.8 6169.4 1621.8 1639.9 1639.9 1641.5 1641.8 1082.5 1094.3 1099.7 1100.3 1127.9 5975.0 5976.0 5980.6 5987.2 5996.7 6342.8 6346.6 6346.7 6350.9 6357.8 5973.7 5978.4 5980.1 5984.7 5984.9 3479.0 3546.8 3549.5 3550.5 3553.9 6368.8 6407.9 6415.3 6420.7 6427.1 6440.4 6468.9 6476.4 6478.3 6481.2 6321.2 6469.9 6474.5 6475.2 6585.8 6407.2 6408.7 6409.2 6411.5 6417.5 6091.9 6159.9 6201.0 6267.7 6275.8 6474.3 6493.9 6495.7 6498.3 6502.3 4218.3 4218.5 4228.8 4233.5 4234.2 6179.9 6294.8 6303.7 6314.8 6322.2 6168.1 6171.7 6176.2 6176.3 6178.5 6157.1 6158.8 6163.3 6163.4 6170.6 5921.1 6036.2 6042.2 6043.2 6049.3 6148.3 6175.7 6186.8 6190.2 6192.5 6000.5 6017.6 6021.2 6031.8 6053.4 06:02:46 INFO - 2015-11-12 06:02:46,340 DEBUG : BROWSER_OUTPUT: 06:02:46 INFO - 2015-11-12 06:02:46,340 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13916.63 Median:28538.27 stddev:17122.81 (60.0%) stddev-sans-first:17141.96 06:02:46 INFO - 2015-11-12 06:02:46,341 DEBUG : BROWSER_OUTPUT: Values: 671.9 703.1 707.5 712.3 730.6 12591.2 13017.1 13681.5 13697.2 13707.7 12987.6 13090.0 13090.5 13101.0 13104.4 669.1 672.2 780.9 797.6 799.6 795.7 796.8 797.5 801.0 803.0 832.3 832.5 836.5 842.0 842.6 688.0 696.8 821.1 832.2 836.3 613.7 615.3 616.3 616.5 617.0 12845.8 13018.9 13022.2 13023.9 13037.4 11311.6 11749.1 11903.5 12054.9 12185.1 9399.7 9444.6 9544.7 9678.4 9711.2 3462.4 3489.2 3510.0 3523.5 3594.6 48912.5 49660.8 49733.5 49815.8 49854.3 9514.4 9624.1 9702.3 9779.2 10060.7 17534.9 17578.1 17581.1 17594.6 17594.9 7008.5 7013.8 7031.4 7113.8 7203.6 4127.7 4128.2 4145.6 4194.5 4199.8 2890.2 2912.5 2917.4 2918.8 2925.9 439.8 446.8 453.4 460.5 463.8 516.3 549.6 550.1 570.9 626.6 8757.8 8761.1 8955.5 9000.0 9063.5 492.2 499.6 610.5 635.8 656.3 3995.6 4049.8 4071.1 4074.4 4088.2 61538.0 61577.4 61672.0 61731.0 61818.7 54486.0 56526.4 56540.4 56543.2 56550.0 50206.0 50848.0 51378.7 51968.6 51988.7 8103.4 8389.9 8392.2 8499.5 8542.8 34903.8 35583.0 36185.0 36213.8 36307.5 42778.4 43166.4 46426.1 47097.3 47381.5 7234.3 7500.7 7578.6 7915.2 7942.4 10318.5 10565.5 10570.6 10575.2 10842.5 10365.9 10431.7 10466.1 10880.9 10912.5 9411.7 9541.3 9940.4 9946.9 9966.8 8765.5 10094.8 10316.6 10462.9 10484.3 9463.8 9464.5 9497.9 9706.8 9820.7 9423.9 9676.8 9762.9 9843.6 9939.0 06:02:46 INFO - 2015-11-12 06:02:46,341 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:02:46 INFO - 2015-11-12 06:02:46,341 DEBUG : BROWSER_OUTPUT: 06:02:47 INFO - 2015-11-12 06:02:47,033 INFO : Browser exited with error code: 0 06:02:47 INFO - 2015-11-12 06:02:47,052 INFO : Completed test dromaeo_css (00:18:33) 06:02:47 INFO - 2015-11-12 06:02:47,052 INFO : Starting test kraken 06:02:47 INFO - 2015-11-12 06:02:47,052 DEBUG : operating with platform_type : linux_ 06:02:47 INFO - 2015-11-12 06:02:47,052 INFO : Initialising browser for kraken test... 06:02:47 INFO - 2015-11-12 06:02:47,058 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn5ivWw/profile http://localhost:35024/getInfo.html 06:02:51 INFO - 2015-11-12 06:02:51,034 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:02:51 INFO - 2015-11-12 06:02:51,034 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:02:51 INFO - 2015-11-12 06:02:51,034 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:02:51 INFO - 2015-11-12 06:02:51,034 DEBUG : BROWSER_OUTPUT: __metrics 06:02:51 INFO - 2015-11-12 06:02:51,211 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:02:52 INFO - 2015-11-12 06:02:52,427 INFO : Browser initialized. 06:02:52 INFO - 2015-11-12 06:02:52,428 INFO : Running cycle 1/1 for kraken test... 06:02:52 INFO - 2015-11-12 06:02:52,428 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn5ivWw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:03:04 INFO - 2015-11-12 06:03:04,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 141709312 06:03:04 INFO - 2015-11-12 06:03:04,226 DEBUG : BROWSER_OUTPUT: 06:03:06 INFO - 2015-11-12 06:03:06,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35024/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:07 INFO - 2015-11-12 06:03:07,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 183459840 06:03:07 INFO - 2015-11-12 06:03:07,287 DEBUG : BROWSER_OUTPUT: 06:03:09 INFO - 2015-11-12 06:03:09,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35024/tests/kraken/driver.html?testName=audio-dft) 06:03:10 INFO - 2015-11-12 06:03:10,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 171806720 06:03:10 INFO - 2015-11-12 06:03:10,451 DEBUG : BROWSER_OUTPUT: 06:03:13 INFO - 2015-11-12 06:03:13,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35024/tests/kraken/driver.html?testName=audio-fft) 06:03:13 INFO - 2015-11-12 06:03:13,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 152215552 06:03:13 INFO - 2015-11-12 06:03:13,871 DEBUG : BROWSER_OUTPUT: 06:03:15 INFO - 2015-11-12 06:03:15,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35024/tests/kraken/driver.html?testName=audio-oscillator) 06:03:16 INFO - 2015-11-12 06:03:16,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 154693632 06:03:16 INFO - 2015-11-12 06:03:16,384 DEBUG : BROWSER_OUTPUT: 06:03:18 INFO - 2015-11-12 06:03:18,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:03:19 INFO - 2015-11-12 06:03:19,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 155099136 06:03:19 INFO - 2015-11-12 06:03:19,120 DEBUG : BROWSER_OUTPUT: 06:03:21 INFO - 2015-11-12 06:03:21,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35024/tests/kraken/driver.html?testName=imaging-darkroom) 06:03:22 INFO - 2015-11-12 06:03:22,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 156164096 06:03:22 INFO - 2015-11-12 06:03:22,558 DEBUG : BROWSER_OUTPUT: 06:03:25 INFO - 2015-11-12 06:03:25,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35024/tests/kraken/driver.html?testName=imaging-desaturate) 06:03:26 INFO - 2015-11-12 06:03:26,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 156950528 06:03:26 INFO - 2015-11-12 06:03:26,506 DEBUG : BROWSER_OUTPUT: 06:03:29 INFO - 2015-11-12 06:03:29,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35024/tests/kraken/driver.html?testName=json-parse-financial) 06:03:29 INFO - 2015-11-12 06:03:29,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 156188672 06:03:29 INFO - 2015-11-12 06:03:29,823 DEBUG : BROWSER_OUTPUT: 06:03:31 INFO - 2015-11-12 06:03:31,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:03:31 INFO - 2015-11-12 06:03:31,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 166092800 06:03:31 INFO - 2015-11-12 06:03:31,959 DEBUG : BROWSER_OUTPUT: 06:03:33 INFO - 2015-11-12 06:03:33,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:03:34 INFO - 2015-11-12 06:03:34,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 166834176 06:03:34 INFO - 2015-11-12 06:03:34,337 DEBUG : BROWSER_OUTPUT: 06:03:36 INFO - 2015-11-12 06:03:36,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:03:36 INFO - 2015-11-12 06:03:36,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 177143808 06:03:36 INFO - 2015-11-12 06:03:36,996 DEBUG : BROWSER_OUTPUT: 06:03:39 INFO - 2015-11-12 06:03:39,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:03:39 INFO - 2015-11-12 06:03:39,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 180924416 06:03:39 INFO - 2015-11-12 06:03:39,944 DEBUG : BROWSER_OUTPUT: 06:03:42 INFO - 2015-11-12 06:03:42,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:43 INFO - 2015-11-12 06:03:43,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 180523008 06:03:43 INFO - 2015-11-12 06:03:43,069 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35024/tests/kraken/driver.html?testName=ai-astar) 06:03:44 INFO - 2015-11-12 06:03:44,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 240275456 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;104;110;111;110;100;111;109;109 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;127;157;158;128;151;150;128;168;127 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;160;160;161;163;162;161 06:03:44 INFO - 2015-11-12 06:03:44,988 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;83;92;72;72;72;105;91;77 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;96;137;90;92;91;131;90;90;138 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;109;109;110;109 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;144;145;145;145;145;145 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;95;95;96;96;95 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;60;59;59;60;62;69;58;57 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;66;67;66;66;67;66;67;67 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;86;86;84;95;85;93;85;85 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;117;114;128;122;117;117;113;117;118 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;158;154;153;157;141;149;150;148;139 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;66;66;66;69;68;67;66;66 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 06:03:44 INFO - 2015-11-12 06:03:44,989 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:03:44 INFO - 2015-11-12 06:03:44,990 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337024986__endTimestamp 06:03:44 INFO - 2015-11-12 06:03:44,990 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:3.69 (3.4%) stddev-sans-first:3.91 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 104.0 110.0 111.0 110.0 100.0 111.0 109.0 109.0 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.50 stddev:15.42 (10.2%) stddev-sans-first:16.26 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: Values: 149.0 127.0 157.0 158.0 128.0 151.0 150.0 128.0 168.0 127.0 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,993 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 160.0 160.0 161.0 163.0 162.0 161.0 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:74.50 stddev:11.82 (15.9%) stddev-sans-first:12.02 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 83.0 92.0 72.0 72.0 72.0 105.0 91.0 77.0 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:90.00 stddev:21.43 (23.8%) stddev-sans-first:22.08 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: Values: 90.0 96.0 137.0 90.0 92.0 91.0 131.0 90.0 90.0 138.0 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 06:03:44 INFO - 2015-11-12 06:03:44,994 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 06:03:44 INFO - 2015-11-12 06:03:44,995 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,995 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:03:44 INFO - 2015-11-12 06:03:44,995 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 06:03:44 INFO - 2015-11-12 06:03:44,995 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:3.33 (5.6%) stddev-sans-first:3.50 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 60.0 59.0 59.0 60.0 62.0 69.0 58.0 57.0 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 66.0 67.0 66.0 66.0 67.0 66.0 67.0 67.0 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:4.14 (4.8%) stddev-sans-first:4.06 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 86.0 86.0 84.0 95.0 85.0 93.0 85.0 85.0 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:117.00 stddev:4.24 (3.6%) stddev-sans-first:4.48 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 114.0 128.0 122.0 117.0 117.0 113.0 117.0 118.0 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: 06:03:44 INFO - 2015-11-12 06:03:44,996 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:151.50 stddev:6.67 (4.4%) stddev-sans-first:6.57 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: Values: 142.0 158.0 154.0 153.0 157.0 141.0 149.0 150.0 148.0 139.0 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.09 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 66.0 66.0 66.0 69.0 68.0 67.0 66.0 66.0 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:03:45 INFO - 2015-11-12 06:03:44,997 DEBUG : BROWSER_OUTPUT: 06:03:45 INFO - 2015-11-12 06:03:45,785 INFO : Browser exited with error code: 0 06:03:45 INFO - 2015-11-12 06:03:45,834 INFO : Completed test kraken (00:00:58) 06:03:45 INFO - 2015-11-12 06:03:45,834 INFO : Starting test v8_7 06:03:45 INFO - 2015-11-12 06:03:45,834 DEBUG : operating with platform_type : linux_ 06:03:45 INFO - 2015-11-12 06:03:45,834 INFO : Initialising browser for v8_7 test... 06:03:45 INFO - 2015-11-12 06:03:45,841 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOzjEIX/profile http://localhost:35024/getInfo.html 06:03:49 INFO - 2015-11-12 06:03:49,904 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:03:49 INFO - 2015-11-12 06:03:49,905 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:03:49 INFO - 2015-11-12 06:03:49,905 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:03:49 INFO - 2015-11-12 06:03:49,905 DEBUG : BROWSER_OUTPUT: __metrics 06:03:50 INFO - 2015-11-12 06:03:50,074 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:03:51 INFO - 2015-11-12 06:03:51,309 INFO : Browser initialized. 06:03:51 INFO - 2015-11-12 06:03:51,310 INFO : Running cycle 1/1 for v8_7 test... 06:03:51 INFO - 2015-11-12 06:03:51,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOzjEIX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:04:03 INFO - 2015-11-12 06:04:03,050 DEBUG : BROWSER_OUTPUT: RSS: Main: 139501568 06:04:03 INFO - 2015-11-12 06:04:03,051 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35024/tests/v8_7/run.html (next: http://localhost:35024/tests/v8_7/run.html) 06:04:24 INFO - 2015-11-12 06:04:24,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 620392448 06:04:24 INFO - 2015-11-12 06:04:24,765 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,765 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:04:24 INFO - 2015-11-12 06:04:24,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:04:24 INFO - 2015-11-12 06:04:24,765 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:04:24 INFO - 2015-11-12 06:04:24,766 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:04:24 INFO - 2015-11-12 06:04:24,766 DEBUG : BROWSER_OUTPUT: |0;Richards;162.86644951140065 06:04:24 INFO - 2015-11-12 06:04:24,766 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.6108422071636 06:04:24 INFO - 2015-11-12 06:04:24,766 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.6569883290635 06:04:24 INFO - 2015-11-12 06:04:24,766 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |6;Boyer;11744.186046511628 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |7;RegExp;25743.589743589742 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |8;Splay;624.8447204968944 06:04:24 INFO - 2015-11-12 06:04:24,767 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:04:24 INFO - 2015-11-12 06:04:24,768 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:04:24 INFO - 2015-11-12 06:04:24,768 DEBUG : BROWSER_OUTPUT: __startTimestamp1447337064762__endTimestamp 06:04:24 INFO - 2015-11-12 06:04:24,768 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,768 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:04:24 INFO - 2015-11-12 06:04:24,768 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.87 Median:162.87 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: Values: 162.9 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.61 Median:193.61 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: Values: 193.6 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,769 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.66 Median:284.66 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: Values: 284.7 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: Values: 5065.7 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: Values: 1102.5 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,770 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: Values: 794.3 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11744.19 Median:11744.19 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: Values: 11744.2 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: Values: 25743.6 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,771 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:624.84 Median:624.84 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: Values: 624.8 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:04:24 INFO - 2015-11-12 06:04:24,772 DEBUG : BROWSER_OUTPUT: 06:04:25 INFO - 2015-11-12 06:04:25,581 INFO : Browser exited with error code: 0 06:04:25 INFO - 2015-11-12 06:04:25,600 INFO : Completed test v8_7 (00:00:39) 06:04:25 INFO - 2015-11-12 06:04:25,726 INFO : Completed test suite (00:20:11) 06:04:25 INFO - 2015-11-12 06:04:25,726 DEBUG : Working with test: dromaeo_css 06:04:25 INFO - 2015-11-12 06:04:25,726 DEBUG : Generating results file: dromaeo_css 06:04:25 INFO - 2015-11-12 06:04:25,727 DEBUG : Working with test: kraken 06:04:25 INFO - 2015-11-12 06:04:25,727 DEBUG : Generating results file: kraken 06:04:25 INFO - 2015-11-12 06:04:25,728 INFO : javascript benchmark 06:04:25 INFO - 2015-11-12 06:04:25,728 DEBUG : Working with test: v8_7 06:04:25 INFO - 2015-11-12 06:04:25,728 DEBUG : Generating results file: v8_7 06:04:25 INFO - 2015-11-12 06:04:25,728 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:25 INFO - 2015-11-12 06:04:25,784 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:04:25 INFO - 2015-11-12 06:04:25,784 DEBUG : process_Request line: dromaeo_css 6792.36 graph.html#tests=[[72,1,35]] 06:04:25 INFO - 2015-11-12 06:04:25,784 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:25 INFO - 2015-11-12 06:04:25,812 DEBUG : process_Request line: kraken 1496.40 graph.html#tests=[[232,1,35]] 06:04:25 INFO - 2015-11-12 06:04:25,813 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:04:25 INFO - 2015-11-12 06:04:25,860 DEBUG : process_Request line: v8_7 21054.34 graph.html#tests=[[230,1,35]] 06:04:25 INFO - 2015-11-12 06:04:25,862 INFO : javascript benchmark 06:04:25 INFO - 2015-11-12 06:04:25,865 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [344.34851642353874, 347.29672413362937, 348.35380369414736, 350.3798277049624, 350.5775540473729, 14608.4887028954, 14981.850181498181, 16620.335186592536, 16834.579135521617, 17383.130843457824, 15742.685146297068, 15914.920425397857, 15927.920360398211, 16273.267702953366, 16617.83382166178, 4956.3804524434445, 4972.2044472884345, 5008.624353173508, 5037.319961805146, 5044.344235249412, 4018.5780493048246, 4086.509618845743, 5475.945240547603, 5953.464188223059, 6112.022076467766, 6016.669083200422, 6023.6988150592515, 6025.969870150665, 6038.154658347835, 6052.667103309316, 5866.208061911651, 6009.609375390607, 6011.398860113954, 6013.789517366871, 6015.819525414223, 5261.6842989420375, 5281.366236051698, 5287.973560132214, 5288.550473209782, 5293.073712100367, 21327.46681332979, 21831.563368732535, 21923.342299731034, 22066.558668826532, 22561.887190564106, 2171.185805323004, 2190.726159230096, 2209.359285807114, 2210.723659542557, 2270.6594010898334, 13605.0, 14001.369938352798, 14099.859001409957, 14201.715965680733, 14203.502877399242, 1902.581432084953, 1913.1390874106569, 1916.281394477071, 1931.449536881996, 1962.1758861278297, 65066.67466662684, 67288.32711672918, 67880.32119678789, 68294.0, 69128.3087169127, 15096.773548396783, 15612.92193539025, 15674.529764107096, 15722.921385393, 15741.370345186064, 24002.0, 24073.0, 24284.878575607363, 24307.756922430905, 24343.513129737305, 9084.137006984325, 9147.085291470932, 9177.724668259963, 9234.630614775468, 9243.029481904437, 7922.326602238759, 7945.443818932619, 7962.283394494408, 7966.243206895336, 8002.159773223728, 7478.962605186939, 7541.585212813238, 7617.923820761722, 7622.742247529096, 7625.885611715828, 1137.6643890052455, 1154.7113221694576, 1157.467306276002, 2067.508652074247, 2906.3606006678497, 456.6734784629006, 489.9902001959941, 498.6459613674332, 498.6982875360427, 521.8904030153634, 12147.75704485923, 12156.513739450324, 12190.268583884996, 12287.385630718607, 12428.56500022495, 494.98020079197147, 501.7140230068826, 505.8659455244363, 508.8168259426677, 513.0867056639188, 6148.262208534915, 6261.8747625047245, 6298.307186209513, 6443.48452123829, 6476.44565304333, 484705.0, 488097.0, 554830.0, 559218.0, 561875.0, 65686.67156664282, 66207.66896165488, 67392.0, 67936.320636793, 75592.24407755962, 550.3753240072466, 563.9989019490355, 565.7001789051809, 569.2798609758659, 569.8888716700286, 10822.729431764268, 10905.618303359344, 11156.609518666808, 11183.161262905152, 11213.15901307389, 20841.791582084592, 30310.242243944078, 32749.345013100083, 33109.66890331066, 34732.65267347294, 44039.77980110207, 44978.77510612426, 47308.763456182496, 47604.52395476001, 48576.75711621419, 6696.732130714717, 6756.391924726799, 6923.480738944499, 6930.688119034555, 6933.064036355229, 12248.142630015813, 12390.685704387133, 12543.87456125427, 12623.810642840548, 12633.2420054797, 10862.076723478593, 10990.560377584807, 11086.833697494705, 11145.777084458428, 11166.944165279121, 10638.84041739359, 10768.40773757451, 10929.0, 10961.342319460859, 11153.21927465102, 10666.413347265974, 10762.08522275584, 10886.891131088587, 10914.290571112851, 10914.563417463212, 6660.666966651551, 6810.965945170441, 6814.693338799865, 6820.147481564804, 6932.0988271524375, 8926.062763410007, 10421.114205292635, 10567.89432105669, 11045.0, 11066.059384952046], "dojo.html": [3277.442834718098, 3309.8841540546055, 3352.078178500912, 3363.89908302751, 3365.74756893233, 5335.306410166682, 5447.319085114361, 5457.481539253769, 5476.698781567012, 5485.478879506445, 5421.322334708161, 5472.1244600863865, 5484.7531861066245, 5523.696196709179, 5566.610337276392, 4946.530079642428, 4966.379202599675, 5005.949940500603, 5013.67411118278, 5047.192449208127, 4989.900201995976, 5060.569851562604, 5098.898022039557, 5119.667221630601, 5180.974095129519, 4881.145799485093, 4974.278729584226, 4978.9544195718945, 4982.227754698028, 5041.747912604374, 5018.0, 5025.924611130836, 5035.874103147451, 5054.570361519275, 5075.568576670988, 4859.902801943941, 4968.552830245295, 5001.349824522825, 5009.874753131165, 5050.747462626854, 5237.711925844077, 5302.708351040691, 5303.893922121536, 5307.0, 5313.654612450178, 5957.493613042897, 5959.672218028007, 5961.344252132262, 5963.165156878041, 5968.791092311748, 5798.565107616903, 5897.793577224819, 5972.790952316648, 5979.730912108966, 6001.279846418414, 5643.5203007743985, 5645.463680950304, 5649.548036157097, 5663.037283661746, 5676.943230567683, 6106.248323414603, 6109.602875813058, 6132.448079672851, 6137.96931015351, 6141.631502109798, 5740.339860915965, 5768.884622307531, 5852.8536786579825, 5893.675847828411, 5921.111833225051, 6035.909461358083, 6067.332593414721, 6072.089186621954, 6073.939260607337, 6089.117078023751, 5993.190919225936, 6008.068749343859, 6010.459058684652, 6022.668753218615, 6025.397460253939, 5751.482366587027, 5810.12848072784, 5923.555733320019, 5963.165156878041, 5967.820965370959, 4551.47658019332, 4551.658625603093, 4552.567506086916, 4561.133384656904, 4596.287575425815, 3943.3099207638547, 4051.0682543015273, 4052.8378864845668, 4058.3100872851687, 4087.734297270668, 5602.663840169603, 5610.943890561124, 5655.632383895034, 5691.943080569225, 5739.741711622987, 6047.969760151171, 6073.726682299307, 6080.726367313481, 6081.27024757032, 6092.939070609325, 5492.780288788484, 5620.241267428926, 5721.885562288731, 5746.367899531048, 5750.338711048199, 5076.3908330999775, 5159.535641792257, 5164.225366195101, 5165.14775062118, 5196.506331898464, 6086.69566521681, 6092.5430592705725, 6092.817215483543, 6151.415615516519, 6174.938250617526, 5874.353821079592, 5887.116932460165, 5983.0, 5994.580379373402, 6001.909971350346, 6146.200993870768, 6196.597221180609, 6205.596636218631, 6221.2845522765465, 6268.843278918063, 5932.644041357532, 5951.583389162717, 5967.522598192048, 6004.249468816398, 6004.909926351195, 5833.0375488044, 5847.795327163529, 5955.076963070731, 5958.404159584007, 6093.664848433379, 5794.884102318014, 5880.000399931936, 5881.823545293648, 5885.5880088395115, 5893.0, 5879.853003674943, 5890.587658863838, 5896.823095307148, 5904.291485021825, 5904.586678932434, 5526.032944234823, 5636.0418728815375, 5659.462351076641, 5742.397048309867, 5786.189933409242, 5830.53355731532, 5877.089051197071, 5908.05471124618, 5908.379620139824, 5962.314333851663, 5578.748956297058, 5760.0783874579865, 5765.971170144123, 5767.019606666793, 5767.653940763567], "mootools.html": [1468.1044562816683, 1513.9015963962343, 1579.8341174176703, 1635.5911022244438, 1785.5000599832044, 6971.895421568681, 7482.214367491417, 7758.922410775897, 7775.066991960958, 7776.105747839, 7502.512336698111, 7636.7708968730885, 7642.694292228318, 7656.425768067389, 7711.961440192791, 1938.3797184900836, 1978.179055691886, 2220.589190999662, 2225.5771403433378, 2229.3312006398096, 2246.0, 2248.033345661365, 2250.9983057539403, 2251.4258863989658, 2251.786080322375, 2152.924647637333, 2236.686863839064, 2237.0, 2238.037643813168, 2241.4956634757214, 1962.5486138188226, 1995.381431756153, 2153.278651651691, 2200.8239340852692, 2200.8899555022185, 2233.8212942964524, 2250.9212177573704, 2257.0745994142485, 2273.59075366434, 2275.055851821492, 7630.961845190794, 7782.571958542278, 7789.091672540264, 7792.142864284924, 7797.025371828521, 4491.573300536444, 4551.089782043605, 4559.407277053995, 4584.083183363341, 4584.839530616412, 2879.280179955011, 2939.103573410109, 2963.140689200151, 2972.9405411891858, 2993.580898674187, 950.064186776025, 952.7475219066953, 961.5769061612868, 977.858210559472, 997.0478193325357, 10534.683959481228, 10554.050135487843, 10558.419286939215, 10562.841557376645, 10564.418956957365, 4087.8569250076102, 4167.604077612622, 4217.514985776675, 4244.745315281093, 4252.659787217015, 9065.546722663841, 9095.454272743524, 9096.0, 9098.86351704725, 9101.772455688528, 4633.72197668141, 4656.95343046572, 4659.091477161988, 4664.0, 4673.883152921204, 4249.532551419341, 4249.723767955073, 4255.063885945087, 4261.659067274611, 4265.1043280910735, 3556.9110772230383, 3586.8744593939086, 3609.6029436761937, 3612.349777040158, 3627.0, 1183.2663748475827, 1187.252031220343, 1189.5598628507507, 1193.7373777768878, 1204.4339160594507, 924.6347692661361, 1285.832841730569, 1288.3944546063335, 1300.3693208793727, 1316.1116246533552, 6336.968315158395, 7147.857042859114, 7252.456065795086, 7259.237780033126, 7265.273472652798, 678.6572780745691, 692.2074225012333, 695.3776370148789, 699.7515881861866, 706.1949377709416, 5370.248165256867, 5393.622446428791, 5412.0258353495965, 5413.53984911287, 5422.457754224625, 8755.518446485377, 8787.780305492413, 8915.910840891638, 9011.864822027675, 9154.954225228965, 8901.243394311427, 8907.643694252158, 8941.016488186295, 8984.640614375483, 9019.954900225588, 6856.794296171123, 6976.4767642426, 6991.825204369931, 7012.509124361246, 7014.438844892396, 6552.410283074546, 6582.80251592453, 6584.407403333723, 6616.239132499824, 6624.7412991531455, 7619.961900190464, 7734.845303093794, 7977.242161994601, 7989.360851131779, 7996.960015200119, 8070.273675369245, 8081.878771818545, 8304.418690691593, 8325.084240733635, 8446.197611226924, 6631.972044333136, 6765.086713293643, 6777.525573210025, 6779.830504237433, 6795.830104247433, 7470.4770666052855, 7536.623168841646, 7548.169701332739, 7552.169261381134, 7563.357114645317, 6999.300069993164, 7022.157341119098, 7048.859022819617, 7166.749163779243, 7170.498065135391, 6812.284710105566, 6860.794176174722, 6921.065656136358, 7026.824329391806, 7056.6118863463, 5954.940450595439, 6046.667433291212, 6511.283758786624, 6656.900146497903, 6691.2639609643875, 6150.231221097363, 6181.072839073995, 6239.438450539473, 6239.812805615838, 6251.499880009679, 6095.207623008981, 6133.049377346519, 6164.106204600397, 6164.352742961924, 6166.229221347332], "ext.html": [560.0661375029271, 582.7843697831802, 595.3034949109542, 602.8214839987825, 605.3250625552507, 38022.42966355507, 38601.61398386015, 38603.0, 38636.420453693216, 38699.613003869985, 42677.35983960243, 43179.3523097153, 43208.56791432085, 43234.351484727675, 43240.56759432405, 7609.162992070867, 7701.614919254043, 8661.437006594568, 8751.168638979287, 10108.44403557804, 10214.080732734052, 10328.483575821216, 10332.741681457948, 10347.844782328271, 10349.534270957825, 10345.0, 10439.0, 10450.372977621368, 10464.633737819178, 10467.790644187111, 7827.25641064098, 7987.400944929153, 10378.844317335246, 10556.155507559377, 10571.629992950287, 10109.0, 10156.695299141038, 10215.795684086352, 10219.948900255526, 10220.795584088351, 38570.22859542821, 39011.804940975395, 39018.21963560741, 39066.80466597677, 39147.804260978795, 3026.6973302669776, 3131.3267647455905, 3237.611486621597, 3458.325626502833, 3901.8049097545295, 29313.267168320748, 29371.55942660862, 29387.0, 29456.969006084684, 29944.0, 3392.7794693344854, 3456.3087382523595, 3515.050936247199, 3530.435130379127, 3546.3616549021167, 275134.0, 277161.0, 278371.0, 278568.0, 279760.0, 54711.17933231005, 55188.44811551913, 55418.44581554133, 55469.1679624806, 55693.44306556883, 58285.417145827996, 58344.0, 58375.0, 58646.12030819541, 58709.41290587039, 15234.619134521505, 15317.846821531864, 15330.693386132438, 15364.462243821412, 15393.692126157413, 11653.18427710069, 11714.414279286002, 11724.179307448567, 11725.530978760755, 11740.178187526963, 18598.16308266131, 18829.52926176829, 18983.33558325452, 18989.90505047466, 19065.42803715891, 7403.407727381797, 7584.962075189589, 7591.734289299848, 7699.807504812313, 7721.189275126031, 967.3953778888194, 970.403202030746, 985.1380042462845, 1058.8994045565812, 1100.2463312630873, 27448.862755686092, 27917.441651166864, 28254.576181357297, 28317.858410708228, 28404.85797570999, 1042.3745752548562, 1044.3472829481575, 1057.5769692123058, 1065.142560239015, 1114.4483480676954, 14410.0, 14648.633784155481, 14687.632809179857, 14771.335289911765, 14865.405383784744, 321127.0, 326080.0, 326170.0, 326239.0, 326986.0, 45656.543434565894, 46006.0, 46006.07987840224, 46146.307805382945, 46164.0, 1303.3157592264138, 1311.3705421397592, 1315.4738104758173, 1339.651690560442, 1344.1061693973593, 25069.247922562354, 25264.62103068492, 26198.214053578424, 26342.341441464116, 26577.601335980362, 42186.78906605447, 42657.0, 42729.35905961351, 42741.0, 42785.0, 217713.0, 217970.0, 218670.0, 219445.0, 219788.0, 26920.730792691822, 27179.456410872066, 29302.120936371943, 30056.699433006266, 30367.544486832274, 36029.27941441209, 36317.45523817092, 37159.25681486409, 37199.81400092982, 39910.800445997585, 33950.0, 34009.65990340065, 34227.14432139217, 34372.82813585916, 35060.47409288914, 27318.180454586392, 31780.36439271248, 32025.83987080143, 33841.83079084589, 34336.82831585826, 31172.688273117885, 31669.0, 31891.840540797148, 31919.68080319167, 32101.0, 27904.860475697493, 28797.0, 30908.82730831309, 40214.0, 42150.36774448324, 29844.85077574598, 30627.54058689077, 30911.536326955564, 31248.531272030483, 31512.842435787676], "prototype.html": [319.09695561560784, 319.2895806829803, 322.20254869198726, 323.3113468312494, 328.7961463892387, 5677.43225677432, 5728.283964504437, 5761.049426844571, 5775.855603609906, 5798.5361171106315, 5614.522765564931, 5660.433956604337, 5670.858228544288, 5727.971360143204, 5739.139129130633, 4398.098389830093, 4417.983863711348, 4419.955800441995, 4420.31485119807, 4420.403245561856, 4262.78686065697, 4335.371371151197, 4344.522102568731, 4417.469903611571, 4463.575960283784, 4416.425864637593, 4424.690271680967, 4431.512533621299, 4438.223310920592, 4449.466064072316, 4408.625266852321, 4417.690761646686, 4422.0, 4423.447069116361, 4425.247707889666, 3892.163184915257, 3893.143508428141, 3893.7079719021185, 3894.1432884765304, 3896.5713771485116, 5401.675899446046, 5501.367342755594, 5512.779488820443, 5555.416681248451, 5567.972160139214, 5154.768035438415, 5154.92267615986, 5158.045761534128, 5161.303224064741, 5163.3545806774155, 6068.453839154453, 6077.209962704865, 6079.240094988127, 6079.908801367983, 6106.511479081707, 4073.4704488416614, 4121.175764847013, 4238.279492486254, 4295.098029413827, 4307.956920430787, 6238.376162383725, 6245.56281060326, 6251.312355640921, 6251.74993000284, 6253.6873156342, 4370.912581748411, 4376.015396535754, 4396.626286765597, 4400.22995975703, 4409.0, 4341.6526677865695, 4413.7572433515825, 4418.226810308183, 4420.668449866273, 4456.7548784817145, 5104.821331253463, 5105.7191854448365, 5107.668001579886, 5155.587552995751, 5160.045391602491, 6133.202683651097, 6162.568620196633, 6167.044108163242, 6167.753289868445, 6169.352218017133, 1621.8459246371576, 1639.8688104951575, 1639.8934069285458, 1641.499342700488, 1641.8029836419705, 1082.4587706146926, 1094.3215206571977, 1099.7470581766238, 1100.2518287564533, 1127.8984891359817, 5974.970125149433, 5976.043832986701, 5980.55145864062, 5987.221661184105, 5996.67018313997, 6342.778002769881, 6346.587471814318, 6346.682665866781, 6350.872982540416, 6357.841053973688, 5973.731182096816, 5978.432048955342, 5980.13288073227, 5984.700764961734, 5984.850378740566, 3479.0, 3546.840392182358, 3549.4675798629896, 3550.520679708258, 3553.893383198508, 6368.840778980562, 6407.935920640827, 6415.26224484181, 6420.7431702731365, 6427.100205971168, 6440.420362167428, 6468.902966455507, 6476.384743449365, 6478.319776423407, 6481.222253329536, 6321.1782468278825, 6469.902951455732, 6474.546781725328, 6475.222973243241, 6585.835354116185, 6407.199100112486, 6408.679566021773, 6409.198850143732, 6411.51913606472, 6417.48660107181, 6091.939080609137, 6159.907601386072, 6200.968995154995, 6267.655278959701, 6275.811725648238, 6474.320196379501, 6493.935060649522, 6495.740170393131, 6498.252700939453, 6502.349765023459, 4218.303979843292, 4218.451601291812, 4228.767417792051, 4233.470816147981, 4234.237837189212, 6179.876402471836, 6294.779682711083, 6303.684815759286, 6314.84212894663, 6322.241331040304, 6168.136460895388, 6171.722272497838, 6176.227971503562, 6176.320604733565, 6178.505719542336, 6157.076438534076, 6158.846028849314, 6163.291221509584, 6163.3528479509005, 6170.568060235741, 5921.052631578927, 6036.215292012186, 6042.1540984261355, 6043.184170136975, 6049.30433000193, 6148.292946311231, 6175.69121543912, 6186.845328866814, 6190.1952746142715, 6192.473639740672, 6000.549958753199, 6017.608855424383, 6021.2473440819895, 6031.819045428644, 6053.364396738455], "yui.html": [671.9428848547873, 703.1393336539941, 707.5188871567335, 712.3446429285058, 730.550711312543, 12591.244525328475, 13017.088803783727, 13681.452741890313, 13697.17816930985, 13707.725845483084, 12987.610371688865, 13090.0, 13090.47638094475, 13101.0, 13104.41030153643, 669.0666520204336, 672.1732269308753, 780.8555417247799, 797.5852556670528, 799.6241766369797, 795.7334293011847, 796.7689370082669, 797.4776521378507, 801.046754362307, 802.9962546816479, 832.342449464922, 832.5421018439864, 836.4688422851473, 842.0, 842.5787106446777, 688.0333131949594, 696.7596179318152, 821.0844907927677, 832.1719888710771, 836.3100442135202, 613.6962203709148, 615.2678312807744, 616.300498933709, 616.4575173847031, 617.0497433951709, 12845.807312890314, 13018.934905325508, 13022.153560018569, 13023.86976130236, 13037.413316400785, 11311.604093856758, 11749.118816088827, 11903.47085072408, 12054.879451205463, 12185.147039707224, 9399.718008459757, 9444.622215111387, 9544.665936692183, 9678.419294842262, 9711.174550163245, 3462.3940810358085, 3489.180042689966, 3510.0, 3523.4890940813693, 3594.6405359463843, 48912.51087489115, 49660.751696241285, 49733.502664973246, 49815.754606134775, 49854.25218621687, 9514.429134251828, 9624.085711857362, 9702.320837541445, 9779.217662587118, 10060.69817905464, 17534.912325438545, 17578.12109394525, 17581.120943952752, 17594.64810703779, 17594.91202543979, 7008.544444611084, 7013.824654383681, 7031.402330801837, 7113.786586402416, 7203.567785932861, 4127.669786417079, 4128.153728485653, 4145.585441455831, 4194.454720886265, 4199.811008504625, 2890.2485353807742, 2912.51943429336, 2917.3873486567636, 2918.8102773319665, 2925.8975935842145, 439.7515403796908, 446.76991349455056, 453.42415132781844, 460.45666113985817, 463.78665813726064, 516.2591680937866, 549.5850632772311, 550.1088237055994, 570.8886767080462, 626.5958456795341, 8757.781055473537, 8761.123887611187, 8955.507447090473, 8999.955000225087, 9063.501507417155, 492.20103986135183, 499.56787378916977, 610.4963405190647, 635.7870113511933, 656.3239862941178, 3995.580464051233, 4049.797510124541, 4071.0840060986634, 4074.4295798588223, 4088.1619268049976, 61538.0, 61577.38422615806, 61672.0, 61731.0, 61818.69090654518, 54486.0, 56526.43473565212, 56540.43459565434, 56543.15185272142, 56550.0, 50206.0, 50848.0, 51378.74310628423, 51968.582670473435, 51988.74005629947, 8103.351731861555, 8389.874151887605, 8392.20274073962, 8499.532525710898, 8542.82914341722, 34903.82548087243, 35583.0, 36185.0, 36213.818930905174, 36307.45538816867, 42778.35832462453, 43166.35250471308, 46426.07147857091, 47097.293540596234, 47381.52618473771, 7234.276572342724, 7500.699972001059, 7578.621068946421, 7915.168907264654, 7942.364610831235, 10318.535665894902, 10565.471726413802, 10570.630027948984, 10575.206859485415, 10842.512086955949, 10365.9481702591, 10431.68704938853, 10466.110380617733, 10880.891191087987, 10912.454377280945, 9411.670591529264, 9541.332106752461, 9940.403575785476, 9946.850797237903, 9966.800663986534, 8765.474071555727, 10094.798104038025, 10316.587336506456, 10462.947685261524, 10484.318519296221, 9463.763405914908, 9464.526773661428, 9497.857532136884, 9706.805863882824, 9820.656277030555, 9423.905760942303, 9676.81099001429, 9762.85355719679, 9843.60625574969, 9938.950305248427]}, "summary": {"lowerIsBetter": false, "suite": 6792.3618921689485, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8163.540046154743, "unit": "ms", "value": 8163.540046154743}, "dojo.html": {"lowerIsBetter": false, "filtered": 5488.350750673217, "unit": "ms", "value": 5488.350750673217}, "mootools.html": {"lowerIsBetter": false, "filtered": 4319.189601534733, "unit": "ms", "value": 4319.189601534733}, "ext.html": {"lowerIsBetter": false, "filtered": 18190.06174234257, "unit": "ms", "value": 18190.06174234257}, "prototype.html": {"lowerIsBetter": false, "filtered": 4638.72090073872, "unit": "ms", "value": 4638.72090073872}, "yui.html": {"lowerIsBetter": false, "filtered": 6013.54927498965, "unit": "ms", "value": 6013.54927498965}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-014"}, "testrun": {"date": 1447335853, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030238", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 163.0, 162.0, 161.0], "ai-astar": [109.0, 112.0, 104.0, 110.0, 111.0, 110.0, 100.0, 111.0, 109.0, 109.0], "imaging-gaussian-blur": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "audio-beat-detection": [149.0, 127.0, 157.0, 158.0, 128.0, 151.0, 150.0, 128.0, 168.0, 127.0], "json-stringify-tinderbox": [68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [142.0, 158.0, 154.0, 153.0, 157.0, 141.0, 149.0, 150.0, 148.0, 139.0], "json-parse-financial": [59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 62.0, 69.0, 58.0, 57.0], "stanford-crypto-sha256-iterative": [69.0, 67.0, 66.0, 66.0, 66.0, 69.0, 68.0, 67.0, 66.0, 66.0], "audio-fft": [71.0, 71.0, 83.0, 92.0, 72.0, 72.0, 72.0, 105.0, 91.0, 77.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [117.0, 117.0, 114.0, 128.0, 122.0, 117.0, 117.0, 113.0, 117.0, 118.0], "audio-oscillator": [90.0, 96.0, 137.0, 90.0, 92.0, 91.0, 131.0, 90.0, 90.0, 138.0], "stanford-crypto-aes": [82.0, 84.0, 86.0, 86.0, 84.0, 95.0, 85.0, 93.0, 85.0, 85.0], "imaging-desaturate": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 149.1, "unit": "ms", "value": 149.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.3, "unit": "ms", "value": 144.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.0, "unit": "ms", "value": 118.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 144.9, "unit": "ms", "value": 144.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 60.3, "unit": "ms", "value": 60.3}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.5, "unit": "ms", "value": 104.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.5, "unit": "ms", "value": 108.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.8, "unit": "ms", "value": 160.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.0, "unit": "ms", "value": 67.0}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.7, "unit": "ms", "value": 66.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.5, "unit": "ms", "value": 86.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.7, "unit": "ms", "value": 95.7}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-014"}, "testrun": {"date": 1447335853, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030238", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.6108422071636], "Encrypt": [284.6569883290635], "NavierStokes": [4835.748792270531], "Decrypt": [5065.656565656565], "Splay": [624.8447204968944], "Richards": [162.86644951140065], "RegExp": [25743.589743589742], "Earley": [794.2811755361398], "Boyer": [11744.186046511628], "RayTrace": [1102.5358324145534]}, "summary": {"lowerIsBetter": false, "suite": 21054.340430171167, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.49946999999986, "unit": "score", "value": 341.49946999999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 935.093853, "unit": "score", "value": 935.093853}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 130.41800198807155, "unit": "score", "value": 130.41800198807155}, "RegExp": {"lowerIsBetter": false, "filtered": 35.38686752988046, "unit": "score", "value": 35.38686752988046}, "Richards": {"lowerIsBetter": false, "filtered": 216.75427999999994, "unit": "score", "value": 216.75427999999994}, "Earley": {"lowerIsBetter": false, "filtered": 839.0769169999999, "unit": "score", "value": 839.0769169999999}, "Boyer": {"lowerIsBetter": false, "filtered": 56.7483346534653, "unit": "score", "value": 56.7483346534653}, "RayTrace": {"lowerIsBetter": false, "filtered": 671.170023, "unit": "score", "value": 671.170023}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-014"}, "testrun": {"date": 1447335853, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151112030238", "branch": "Firefox", "revision": "3cc3b1968524248450c465c4ea2ee5596ffa65f2"}}] 06:04:25 INFO - RETURN: dromaeo_css: 6792.36 06:04:25 INFO - RETURN: kraken: 1496.40 06:04:25 INFO - RETURN: v8_7: 21054.34 06:04:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21054.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1496.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6792.36"}}} 06:04:25 INFO - Return code: 0 06:04:25 INFO - # TBPL SUCCESS # 06:04:25 INFO - Running post-action listener: _resource_record_post_action 06:04:25 INFO - Running post-run listener: _resource_record_post_run 06:04:27 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 12288; Write bytes: 509468672; Read time: 280; Write time: 707660 06:04:27 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 195678208; Read time: 216; Write time: 377032 06:04:27 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 271032320; Read time: 64; Write time: 184816 06:04:27 INFO - Running post-run listener: _upload_blobber_files 06:04:27 INFO - Blob upload gear active. 06:04:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:04:27 INFO - Copying logs to upload dir... 06:04:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.460783 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-12 06:04:26.684805) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 06:04:26.688331) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010135 build_url: 'https://queue.taskcluster.net/v1/task/9AmsCazzTSqyTidO_IJbfA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 06:04:26.739054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:04:26.739424) ========= 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=01deea79d00cc2c334834894000001d2-1447333861.603580-1553930874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 06:04:26.788939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:04:26.789263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 06:04:26.789573) ========= ========= Total master_lag: 0.26 =========