builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1447426709.25 results: success (0) buildid: 20151113043003 builduid: eb375fef4dff40d395997682ff3f5a7e revision: faf815a0fa9b052a38bce00c0c2aa1e2c9610936 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.254037) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.254622) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.255010) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006563 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.276596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.276994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.287567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.287993) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.338309) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.338662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.339116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.339448) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 06:58:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.5M=0s 2015-11-13 06:58:30 (36.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.524260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.524661) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015558 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:29.575449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 06:58:29.575900) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev faf815a0fa9b052a38bce00c0c2aa1e2c9610936 --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 faf815a0fa9b052a38bce00c0c2aa1e2c9610936 --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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 06:58:30,602 truncating revision to first 12 chars 2015-11-13 06:58:30,602 Setting DEBUG logging. 2015-11-13 06:58:30,602 attempt 1/10 2015-11-13 06:58:30,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/faf815a0fa9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 06:58:31,574 unpacking tar archive at: mozilla-central-faf815a0fa9b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.244526 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 06:58:30.834701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:30.835108) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:30.844837) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:30.845392) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 06:58:30.846139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-13 06:58:30.846700) ========= /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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:58:31 INFO - MultiFileLogger online at 20151113 06:58:31 in /builds/slave/test-pgo 06:58:31 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 06:58:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:58:31 INFO - {'append_to_log': False, 06:58:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:58:31 INFO - 'blob_upload_branch': 'Firefox', 06:58:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:58:31 INFO - 'branch': 'Firefox', 06:58:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:58:31 INFO - 'config_files': ('talos/linux_config.py',), 06:58:31 INFO - 'default_actions': ('clobber', 06:58:31 INFO - 'read-buildbot-config', 06:58:31 INFO - 'download-and-extract', 06:58:31 INFO - 'populate-webroot', 06:58:31 INFO - 'create-virtualenv', 06:58:31 INFO - 'install', 06:58:31 INFO - 'run-tests'), 06:58:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:58:31 INFO - 'download_minidump_stackwalk': True, 06:58:31 INFO - 'download_symbols': 'ondemand', 06:58:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:58:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:58:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:58:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:58:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:58:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:58:31 INFO - 'installer_path': 'installer.exe', 06:58:31 INFO - 'log_level': 'info', 06:58:31 INFO - 'log_name': 'talos', 06:58:31 INFO - 'log_to_console': True, 06:58:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:58:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:58:31 INFO - 'opt_config_files': (), 06:58:31 INFO - 'pip_index': False, 06:58:31 INFO - 'sps_profile': False, 06:58:31 INFO - 'sps_profile_interval': 0, 06:58:31 INFO - 'suite': 'dromaeojs', 06:58:31 INFO - 'system_bits': '64', 06:58:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:58:31 INFO - 'title': 'talos-linux64-ix-023', 06:58:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:58:31 INFO - 'use_talos_json': True, 06:58:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:58:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:58:31 INFO - 'work_dir': 'build'} 06:58:31 INFO - ##### 06:58:31 INFO - ##### Running clobber step. 06:58:31 INFO - ##### 06:58:31 INFO - Running pre-action listener: _resource_record_pre_action 06:58:31 INFO - Running main action method: clobber 06:58:31 INFO - rmtree: /builds/slave/test-pgo/build 06:58:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - ##### 06:58:32 INFO - ##### Running read-buildbot-config step. 06:58:32 INFO - ##### 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: read_buildbot_config 06:58:32 INFO - Using buildbot properties: 06:58:32 INFO - { 06:58:32 INFO - "properties": { 06:58:32 INFO - "buildnumber": 550, 06:58:32 INFO - "product": "firefox", 06:58:32 INFO - "script_repo_revision": "production", 06:58:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:58:32 INFO - "repository": "", 06:58:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:58:32 INFO - "buildid": "20151113043003", 06:58:32 INFO - "slavename": "talos-linux64-ix-023", 06:58:32 INFO - "pgo_build": "True", 06:58:32 INFO - "basedir": "/builds/slave/test-pgo", 06:58:32 INFO - "project": "", 06:58:32 INFO - "platform": "ubuntu64_hw", 06:58:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:58:32 INFO - "slavebuilddir": "test", 06:58:32 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:58:32 INFO - "branch": "mozilla-central", 06:58:32 INFO - "repo_path": "mozilla-central", 06:58:32 INFO - "stage_platform": "linux64-pgo", 06:58:32 INFO - "builduid": "eb375fef4dff40d395997682ff3f5a7e", 06:58:32 INFO - "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936" 06:58:32 INFO - }, 06:58:32 INFO - "sourcestamp": { 06:58:32 INFO - "repository": "", 06:58:32 INFO - "hasPatch": false, 06:58:32 INFO - "project": "", 06:58:32 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:58:32 INFO - "changes": [ 06:58:32 INFO - { 06:58:32 INFO - "category": null, 06:58:32 INFO - "files": [ 06:58:32 INFO - { 06:58:32 INFO - "url": null, 06:58:32 INFO - "name": "https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:58:32 INFO - } 06:58:32 INFO - ], 06:58:32 INFO - "repository": "", 06:58:32 INFO - "rev": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936", 06:58:32 INFO - "who": "sendchange", 06:58:32 INFO - "when": 1447426456, 06:58:32 INFO - "number": 6658464, 06:58:32 INFO - "comments": "", 06:58:32 INFO - "project": "", 06:58:32 INFO - "at": "Fri 13 Nov 2015 06:54:16", 06:58:32 INFO - "branch": "mozilla-central-linux64-pgo-talos", 06:58:32 INFO - "revlink": "", 06:58:32 INFO - "properties": [ 06:58:32 INFO - [ 06:58:32 INFO - "buildid", 06:58:32 INFO - "20151113043003", 06:58:32 INFO - "Change" 06:58:32 INFO - ], 06:58:32 INFO - [ 06:58:32 INFO - "builduid", 06:58:32 INFO - "eb375fef4dff40d395997682ff3f5a7e", 06:58:32 INFO - "Change" 06:58:32 INFO - ], 06:58:32 INFO - [ 06:58:32 INFO - "pgo_build", 06:58:32 INFO - "True", 06:58:32 INFO - "Change" 06:58:32 INFO - ] 06:58:32 INFO - ], 06:58:32 INFO - "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936" 06:58:32 INFO - } 06:58:32 INFO - ], 06:58:32 INFO - "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936" 06:58:32 INFO - } 06:58:32 INFO - } 06:58:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - ##### 06:58:32 INFO - ##### Running download-and-extract step. 06:58:32 INFO - ##### 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: download_and_extract 06:58:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:32 INFO - https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/test_packages.json 06:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/test_packages.json 06:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:58:33 INFO - Downloaded 1302 bytes. 06:58:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:58:33 INFO - Using the following test package requirements: 06:58:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:58:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'jsshell-linux-x86_64.zip'], 06:58:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:58:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:58:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:58:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:58:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:58:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:58:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:58:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:58: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')]} 06:58:33 INFO - https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:34 INFO - Downloaded 22443701 bytes. 06:58:34 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 06:58:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:34 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 06:58:35 INFO - Return code: 0 06:58:35 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 06:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:35 INFO - https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:36 INFO - Downloaded 22443701 bytes. 06:58:36 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 06:58:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:58:36 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 06:58:37 INFO - Return code: 0 06:58: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')]} 06:58:37 INFO - https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:38 INFO - Downloaded 11131693 bytes. 06:58: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 06:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:58: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 06:58:39 INFO - Return code: 0 06:58:39 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')]} 06:58:39 INFO - https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0AqZTKR4ScekU4sv7816rQ/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 06:58:40 INFO - Downloaded 57163860 bytes. 06:58:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:58:40 INFO - mkdir: /builds/slave/test-pgo/properties 06:58:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:58:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:58:40 INFO - Contents: 06:58:40 INFO - build_url:https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:58:40 INFO - Running post-action listener: _resource_record_post_action 06:58:40 INFO - Running post-action listener: set_extra_try_arguments 06:58:40 INFO - ##### 06:58:40 INFO - ##### Running populate-webroot step. 06:58:40 INFO - ##### 06:58:40 INFO - Running pre-action listener: _resource_record_pre_action 06:58:40 INFO - Running main action method: populate_webroot 06:58:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:40 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:58:40 INFO - '../fennec_ids.txt'], 06:58:40 INFO - 'tests': ['tcheck2']}, 06:58:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:40 INFO - '--tppagecycles', 06:58:40 INFO - '7'], 06:58:40 INFO - 'tests': ['tsvgm']}}, 06:58:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:58:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:58:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'tests': ['damp', 'tps']}, 06:58:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['damp', 'tps']}, 06:58:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:58:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:40 INFO - 'other': {'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'other_l64': {'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'other_nol64': {'tests': ['a11yr', 06:58:40 INFO - 'ts_paint', 06:58:40 INFO - 'tpaint', 06:58:40 INFO - 'sessionrestore', 06:58:40 INFO - 'sessionrestore_no_auto_restore']}, 06:58:40 INFO - 'svgr': {'tests': ['tsvgx', 06:58:40 INFO - 'tsvgr_opacity', 06:58:40 INFO - 'tart', 06:58:40 INFO - 'tscrollx', 06:58:40 INFO - 'cart']}, 06:58:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['tsvgx', 06:58:40 INFO - 'tsvgr_opacity', 06:58:40 INFO - 'tart', 06:58:40 INFO - 'tscrollx', 06:58:40 INFO - 'cart']}, 06:58:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'tests': ['tp5o']}, 06:58:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'talos_options': ['--e10s'], 06:58:40 INFO - 'tests': ['tp5o']}, 06:58:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'talos_options': ['--xperf_path', 06:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:40 INFO - 'tests': ['tp5n']}, 06:58:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:40 INFO - 'talos_options': ['--e10s', 06:58:40 INFO - '--xperf_path', 06:58:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:40 INFO - 'tests': ['tp5n']}}, 06:58:40 INFO - 'talos.zip': {'path': '', 06:58:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:40 INFO - Running post-action listener: _resource_record_post_action 06:58:40 INFO - ##### 06:58:40 INFO - ##### Running create-virtualenv step. 06:58:40 INFO - ##### 06:58:40 INFO - Running pre-action listener: _resource_record_pre_action 06:58:40 INFO - Running main action method: create_virtualenv 06:58:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:58:40 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 06:58:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:58:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:40 INFO - Using real prefix '/usr' 06:58:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:58:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:43 INFO - Installing pip.................done. 06:58:43 INFO - Return code: 0 06:58:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:43 INFO - Using env: {'DISPLAY': ':0', 06:58:43 INFO - 'HOME': '/home/cltbld', 06:58:43 INFO - 'LANG': 'en_US.UTF-8', 06:58:43 INFO - 'LANGUAGE': 'en_US:en', 06:58:43 INFO - 'LOGNAME': 'cltbld', 06:58:43 INFO - 'MAIL': '/var/mail/cltbld', 06:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:43 INFO - 'MOZ_NO_REMOTE': '1', 06:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:43 INFO - 'NO_EM_RESTART': '1', 06:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:43 INFO - 'SHELL': '/bin/bash', 06:58:43 INFO - 'SHLVL': '1', 06:58:43 INFO - 'TERM': 'linux', 06:58:43 INFO - 'TMOUT': '86400', 06:58:43 INFO - 'USER': 'cltbld', 06:58:43 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:43 INFO - '_': '/tools/buildbot/bin/python'} 06:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58: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 06:58:43 INFO - Cleaning up... 06:58:43 INFO - Return code: 0 06:58:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:43 INFO - Using env: {'DISPLAY': ':0', 06:58:43 INFO - 'HOME': '/home/cltbld', 06:58:43 INFO - 'LANG': 'en_US.UTF-8', 06:58:43 INFO - 'LANGUAGE': 'en_US:en', 06:58:43 INFO - 'LOGNAME': 'cltbld', 06:58:43 INFO - 'MAIL': '/var/mail/cltbld', 06:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:43 INFO - 'MOZ_NO_REMOTE': '1', 06:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:43 INFO - 'NO_EM_RESTART': '1', 06:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:43 INFO - 'SHELL': '/bin/bash', 06:58:43 INFO - 'SHLVL': '1', 06:58:43 INFO - 'TERM': 'linux', 06:58:43 INFO - 'TMOUT': '86400', 06:58:43 INFO - 'USER': 'cltbld', 06:58:43 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:43 INFO - '_': '/tools/buildbot/bin/python'} 06:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:43 INFO - Downloading/unpacking psutil>=0.7.1 06:58:43 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 06:58:43 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 06:58:43 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 06:58:43 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 06:58:43 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 06:58:43 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 06:58:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:45 INFO - Installing collected packages: psutil 06:58:45 INFO - Running setup.py install for psutil 06:58:45 INFO - building 'psutil._psutil_linux' extension 06:58: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 06:58:45 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 06:58:45 INFO - building 'psutil._psutil_posix' extension 06:58:45 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 06:58:45 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 06:58:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:46 INFO - Successfully installed psutil 06:58:46 INFO - Cleaning up... 06:58:46 INFO - Return code: 0 06:58:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:46 INFO - Using env: {'DISPLAY': ':0', 06:58:46 INFO - 'HOME': '/home/cltbld', 06:58:46 INFO - 'LANG': 'en_US.UTF-8', 06:58:46 INFO - 'LANGUAGE': 'en_US:en', 06:58:46 INFO - 'LOGNAME': 'cltbld', 06:58:46 INFO - 'MAIL': '/var/mail/cltbld', 06:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:46 INFO - 'MOZ_NO_REMOTE': '1', 06:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:46 INFO - 'NO_EM_RESTART': '1', 06:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:46 INFO - 'SHELL': '/bin/bash', 06:58:46 INFO - 'SHLVL': '1', 06:58:46 INFO - 'TERM': 'linux', 06:58:46 INFO - 'TMOUT': '86400', 06:58:46 INFO - 'USER': 'cltbld', 06:58:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:46 INFO - '_': '/tools/buildbot/bin/python'} 06:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:58:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58: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) 06:58:48 INFO - Installing collected packages: mozsystemmonitor 06:58:48 INFO - Running setup.py install for mozsystemmonitor 06:58:48 INFO - Successfully installed mozsystemmonitor 06:58:48 INFO - Cleaning up... 06:58:48 INFO - Return code: 0 06:58:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:48 INFO - Using env: {'DISPLAY': ':0', 06:58:48 INFO - 'HOME': '/home/cltbld', 06:58:48 INFO - 'LANG': 'en_US.UTF-8', 06:58:48 INFO - 'LANGUAGE': 'en_US:en', 06:58:48 INFO - 'LOGNAME': 'cltbld', 06:58:48 INFO - 'MAIL': '/var/mail/cltbld', 06:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:48 INFO - 'MOZ_NO_REMOTE': '1', 06:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:48 INFO - 'NO_EM_RESTART': '1', 06:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:48 INFO - 'SHELL': '/bin/bash', 06:58:48 INFO - 'SHLVL': '1', 06:58:48 INFO - 'TERM': 'linux', 06:58:48 INFO - 'TMOUT': '86400', 06:58:48 INFO - 'USER': 'cltbld', 06:58:48 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:48 INFO - '_': '/tools/buildbot/bin/python'} 06:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:58:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:50 INFO - Downloading docopt-0.6.1.tar.gz 06:58:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:58:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:50 INFO - Running setup.py install for blobuploader 06:58:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:58:50 INFO - Running setup.py install for requests 06:58:51 INFO - Running setup.py install for docopt 06:58:51 INFO - Successfully installed blobuploader requests docopt 06:58:51 INFO - Cleaning up... 06:58:51 INFO - Return code: 0 06:58:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:51 INFO - Using env: {'DISPLAY': ':0', 06:58:51 INFO - 'HOME': '/home/cltbld', 06:58:51 INFO - 'LANG': 'en_US.UTF-8', 06:58:51 INFO - 'LANGUAGE': 'en_US:en', 06:58:51 INFO - 'LOGNAME': 'cltbld', 06:58:51 INFO - 'MAIL': '/var/mail/cltbld', 06:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:51 INFO - 'MOZ_NO_REMOTE': '1', 06:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:51 INFO - 'NO_EM_RESTART': '1', 06:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:51 INFO - 'SHELL': '/bin/bash', 06:58:51 INFO - 'SHLVL': '1', 06:58:51 INFO - 'TERM': 'linux', 06:58:51 INFO - 'TMOUT': '86400', 06:58:51 INFO - 'USER': 'cltbld', 06:58:51 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:51 INFO - '_': '/tools/buildbot/bin/python'} 06:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:51 INFO - Running setup.py (path:/tmp/pip-CrgjvU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:51 INFO - Running setup.py (path:/tmp/pip-3vLw4k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:51 INFO - Running setup.py (path:/tmp/pip-_ezZd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:51 INFO - Running setup.py (path:/tmp/pip-eIDBbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:51 INFO - Running setup.py (path:/tmp/pip-PtI5oK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:52 INFO - Running setup.py (path:/tmp/pip-DQjQJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:52 INFO - Running setup.py (path:/tmp/pip-lJ1pHH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:52 INFO - Running setup.py (path:/tmp/pip-Vmcfvx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:52 INFO - Running setup.py (path:/tmp/pip-shkKEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:52 INFO - Running setup.py (path:/tmp/pip-VjdCXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:52 INFO - Running setup.py (path:/tmp/pip-VWfUdw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:52 INFO - Running setup.py (path:/tmp/pip-pb6oyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:52 INFO - Running setup.py (path:/tmp/pip-0T1Mc8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:52 INFO - Running setup.py (path:/tmp/pip-cygpqq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:52 INFO - Running setup.py (path:/tmp/pip-jTwnl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:52 INFO - Running setup.py (path:/tmp/pip-Se1O9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:52 INFO - Running setup.py (path:/tmp/pip-MkoYj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:52 INFO - Running setup.py install for manifestparser 06:58:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for mozcrash 06:58:53 INFO - Running setup.py install for mozdebug 06:58:53 INFO - Running setup.py install for mozdevice 06:58:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for mozfile 06:58:53 INFO - Running setup.py install for mozhttpd 06:58:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for mozinfo 06:58:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for mozInstall 06:58:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for mozleak 06:58:53 INFO - Running setup.py install for mozlog 06:58:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:58:53 INFO - Running setup.py install for moznetwork 06:58:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Running setup.py install for mozprocess 06:58:54 INFO - Running setup.py install for mozprofile 06:58:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Running setup.py install for mozrunner 06:58:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Running setup.py install for mozscreenshot 06:58:54 INFO - Running setup.py install for moztest 06:58:54 INFO - Running setup.py install for mozversion 06:58:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:54 INFO - Cleaning up... 06:58:54 INFO - Return code: 0 06:58:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:54 INFO - Using env: {'DISPLAY': ':0', 06:58:54 INFO - 'HOME': '/home/cltbld', 06:58:54 INFO - 'LANG': 'en_US.UTF-8', 06:58:54 INFO - 'LANGUAGE': 'en_US:en', 06:58:54 INFO - 'LOGNAME': 'cltbld', 06:58:54 INFO - 'MAIL': '/var/mail/cltbld', 06:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:54 INFO - 'MOZ_NO_REMOTE': '1', 06:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:54 INFO - 'NO_EM_RESTART': '1', 06:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:54 INFO - 'SHELL': '/bin/bash', 06:58:54 INFO - 'SHLVL': '1', 06:58:54 INFO - 'TERM': 'linux', 06:58:54 INFO - 'TMOUT': '86400', 06:58:54 INFO - 'USER': 'cltbld', 06:58:54 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:54 INFO - '_': '/tools/buildbot/bin/python'} 06:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:54 INFO - Running setup.py (path:/tmp/pip-p_VZy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:58:54 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)) 06:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58:54 INFO - Running setup.py (path:/tmp/pip-rXydgd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58:55 INFO - Running setup.py (path:/tmp/pip-ED0SuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58:55 INFO - Running setup.py (path:/tmp/pip-OtPQEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58:55 INFO - Running setup.py (path:/tmp/pip-qOsm8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58:55 INFO - Running setup.py (path:/tmp/pip-WsFwa9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58:55 INFO - Running setup.py (path:/tmp/pip-bhAioY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58:55 INFO - Running setup.py (path:/tmp/pip-YHs479-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58:55 INFO - Running setup.py (path:/tmp/pip-DJ2OBj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58:55 INFO - Running setup.py (path:/tmp/pip-ns9FQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58:55 INFO - Running setup.py (path:/tmp/pip-mGFinm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58:55 INFO - Running setup.py (path:/tmp/pip-D5W540-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:58: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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:55 INFO - Running setup.py (path:/tmp/pip-8K5OyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:58:55 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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:55 INFO - Running setup.py (path:/tmp/pip-jepcBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:58:55 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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:55 INFO - Running setup.py (path:/tmp/pip-NjBLBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:58:55 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)) 06:58:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:58:55 INFO - Running setup.py (path:/tmp/pip-NK3ZlL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:58: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)) 06:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58:56 INFO - Running setup.py (path:/tmp/pip-GJayxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:57 INFO - Downloading blessings-1.5.1.tar.gz 06:58: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 06:58:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:57 INFO - Installing collected packages: blessings 06:58:57 INFO - Running setup.py install for blessings 06:58:57 INFO - Successfully installed blessings 06:58:57 INFO - Cleaning up... 06:58:58 INFO - Return code: 0 06:58:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:58:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:58:58 INFO - Reading from file tmpfile_stdout 06:58:58 INFO - Current package versions: 06:58:58 INFO - argparse == 1.2.1 06:58:58 INFO - blessings == 1.5.1 06:58:58 INFO - blobuploader == 1.2.4 06:58:58 INFO - docopt == 0.6.1 06:58:58 INFO - manifestparser == 1.1 06:58:58 INFO - mozInstall == 1.12 06:58:58 INFO - mozcrash == 0.16 06:58:58 INFO - mozdebug == 0.1 06:58:58 INFO - mozdevice == 0.47 06:58:58 INFO - mozfile == 1.2 06:58:58 INFO - mozhttpd == 0.7 06:58:58 INFO - mozinfo == 0.9 06:58:58 INFO - mozleak == 0.1 06:58:58 INFO - mozlog == 3.0 06:58:58 INFO - moznetwork == 0.27 06:58:58 INFO - mozprocess == 0.22 06:58:58 INFO - mozprofile == 0.27 06:58:58 INFO - mozrunner == 6.11 06:58:58 INFO - mozscreenshot == 0.1 06:58:58 INFO - mozsystemmonitor == 0.0 06:58:58 INFO - moztest == 0.7 06:58:58 INFO - mozversion == 1.4 06:58:58 INFO - psutil == 3.1.1 06:58:58 INFO - requests == 1.2.3 06:58:58 INFO - wsgiref == 0.1.2 06:58:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:58: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')]} 06:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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')]} 06:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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 0x7fc927a80c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc5f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd206e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, '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': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', '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 06:58: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 06:58: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 06:58:58 INFO - Using env: {'DISPLAY': ':0', 06:58:58 INFO - 'HOME': '/home/cltbld', 06:58:58 INFO - 'LANG': 'en_US.UTF-8', 06:58:58 INFO - 'LANGUAGE': 'en_US:en', 06:58:58 INFO - 'LOGNAME': 'cltbld', 06:58:58 INFO - 'MAIL': '/var/mail/cltbld', 06:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:58 INFO - 'MOZ_NO_REMOTE': '1', 06:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:58 INFO - 'NO_EM_RESTART': '1', 06:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:58:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:58:58 INFO - 'SHELL': '/bin/bash', 06:58:58 INFO - 'SHLVL': '1', 06:58:58 INFO - 'TERM': 'linux', 06:58:58 INFO - 'TMOUT': '86400', 06:58:58 INFO - 'USER': 'cltbld', 06:58:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:58 INFO - '_': '/tools/buildbot/bin/python'} 06:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58: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)) 06:58:58 INFO - Cleaning up... 06:58:58 INFO - Return code: 0 06:58:58 INFO - Running post-action listener: _resource_record_post_action 06:58:58 INFO - Running post-action listener: _start_resource_monitoring 06:58:58 INFO - Starting resource monitoring. 06:58:58 INFO - ##### 06:58:58 INFO - ##### Running install step. 06:58:58 INFO - ##### 06:58:58 INFO - Running pre-action listener: _resource_record_pre_action 06:58:58 INFO - Running main action method: install 06:58:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:58:58 INFO - Reading from file tmpfile_stdout 06:58:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:58:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:58:58 INFO - Reading from file tmpfile_stdout 06:58:58 INFO - Output received: 06:58:58 INFO - Usage: mozinstall [options] installer 06:58:58 INFO - Options: 06:58:58 INFO - -h, --help show this help message and exit 06:58:58 INFO - -d DEST, --destination=DEST 06:58:58 INFO - Directory to install application into. [default: 06:58:58 INFO - "/builds/slave/test-pgo"] 06:58:58 INFO - --app=APP Application being installed. [default: firefox] 06:58:58 INFO - mkdir: /builds/slave/test-pgo/build/application 06:58: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'] 06:58: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 06:59:13 INFO - Reading from file tmpfile_stdout 06:59:13 INFO - Output received: 06:59:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:59:13 INFO - Running post-action listener: _resource_record_post_action 06:59:13 INFO - ##### 06:59:13 INFO - ##### Running run-tests step. 06:59:13 INFO - ##### 06:59:13 INFO - Running pre-action listener: _resource_record_pre_action 06:59:13 INFO - Running main action method: run_tests 06:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:59:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:59:13 INFO - Python 2.7.3 06:59:13 INFO - Return code: 0 06:59:13 INFO - grabbing minidump binary from tooltool 06:59: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')]} 06:59: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 0xd56a90>, '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 0xda8f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda92e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:59: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 06:59: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 06:59:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:13 INFO - Return code: 0 06:59:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:59:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:59: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/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:59: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/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 06:59:13 INFO - Using env: {'DISPLAY': ':0', 06:59:13 INFO - 'HOME': '/home/cltbld', 06:59:13 INFO - 'LANG': 'en_US.UTF-8', 06:59:13 INFO - 'LANGUAGE': 'en_US:en', 06:59:13 INFO - 'LOGNAME': 'cltbld', 06:59:13 INFO - 'MAIL': '/var/mail/cltbld', 06:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:13 INFO - 'MOZ_NO_REMOTE': '1', 06:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:13 INFO - 'NO_EM_RESTART': '1', 06:59:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:59:13 INFO - 'SHELL': '/bin/bash', 06:59:13 INFO - 'SHLVL': '1', 06:59:13 INFO - 'TERM': 'linux', 06:59:13 INFO - 'TMOUT': '86400', 06:59:13 INFO - 'USER': 'cltbld', 06:59:13 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932', 06:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:13 INFO - '_': '/tools/buildbot/bin/python'} 06:59: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/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 06:59:13 INFO - mozversion INFO | application_buildid: 20151113043003 06:59:13 INFO - mozversion INFO | application_changeset: faf815a0fa9b052a38bce00c0c2aa1e2c9610936 06:59:13 INFO - mozversion INFO | application_display_name: Nightly 06:59:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:13 INFO - mozversion INFO | application_name: Firefox 06:59:13 INFO - mozversion INFO | application_remotingname: firefox 06:59:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:59:13 INFO - mozversion INFO | application_vendor: Mozilla 06:59:13 INFO - mozversion INFO | application_version: 45.0a1 06:59:13 INFO - mozversion INFO | platform_buildid: 20151113043003 06:59:13 INFO - mozversion INFO | platform_changeset: faf815a0fa9b052a38bce00c0c2aa1e2c9610936 06:59:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:59:13 INFO - mozversion INFO | platform_version: 45.0a1 06:59:13 INFO - 2015-11-13 06:59:13,538 DEBUG : using testdate: 1447426753 06:59:13 INFO - 2015-11-13 06:59:13,538 DEBUG : actual date: 1447426753 06:59:13 INFO - 2015-11-13 06:59:13,547 INFO : starting webserver on 'localhost:50239' 06:59:13 INFO - 2015-11-13 06:59:13,548 INFO : Starting test suite talos-linux64-ix-023 06:59:13 INFO - 2015-11-13 06:59:13,548 INFO : Starting test dromaeo_css 06:59:13 INFO - 2015-11-13 06:59:13,548 DEBUG : operating with platform_type : linux_ 06:59:13 INFO - 2015-11-13 06:59:13,548 INFO : Initialising browser for dromaeo_css test... 06:59:13 INFO - 2015-11-13 06:59:13,555 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWRrJ5g/profile http://localhost:50239/getInfo.html 06:59:18 INFO - 2015-11-13 06:59:18,396 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:59:18 INFO - 2015-11-13 06:59:18,396 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:59:18 INFO - 2015-11-13 06:59:18,396 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:59:18 INFO - 2015-11-13 06:59:18,396 DEBUG : BROWSER_OUTPUT: __metrics 06:59:18 INFO - 2015-11-13 06:59:18,553 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:59:19 INFO - 2015-11-13 06:59:19,674 INFO : Browser initialized. 06:59:19 INFO - 2015-11-13 06:59:19,674 INFO : Running cycle 1/1 for dromaeo_css test... 06:59:19 INFO - 2015-11-13 06:59:19,675 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWRrJ5g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:59:31 INFO - 2015-11-13 06:59:31,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 140812288 06:59:31 INFO - 2015-11-13 06:59:31,372 DEBUG : BROWSER_OUTPUT: 07:00:22 INFO - 2015-11-13 07:00:22,068 DEBUG : BROWSER_OUTPUT: 1447426822064 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] 07:02:31 INFO - 2015-11-13 07:02:31,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50239/tests/dromaeo/cssquery-ext.html) 07:02:32 INFO - 2015-11-13 07:02:32,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 236769280 07:02:32 INFO - 2015-11-13 07:02:32,693 DEBUG : BROWSER_OUTPUT: 07:05:34 INFO - 2015-11-13 07:05:34,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-ext.html (next: http://localhost:50239/tests/dromaeo/cssquery-jquery.html) 07:05:35 INFO - 2015-11-13 07:05:35,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 221446144 07:05:35 INFO - 2015-11-13 07:05:35,536 DEBUG : BROWSER_OUTPUT: 07:08:37 INFO - 2015-11-13 07:08:37,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50239/tests/dromaeo/cssquery-mootools.html) 07:08:37 INFO - 2015-11-13 07:08:37,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 217284608 07:08:37 INFO - 2015-11-13 07:08:37,949 DEBUG : BROWSER_OUTPUT: 07:11:39 INFO - 2015-11-13 07:11:39,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50239/tests/dromaeo/cssquery-prototype.html) 07:11:40 INFO - 2015-11-13 07:11:40,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 203649024 07:11:40 INFO - 2015-11-13 07:11:40,308 DEBUG : BROWSER_OUTPUT: 07:14:42 INFO - 2015-11-13 07:14:42,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50239/tests/dromaeo/cssquery-yui.html) 07:14:43 INFO - 2015-11-13 07:14:43,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 202530816 07:14:43 INFO - 2015-11-13 07:14:43,286 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/dromaeo/cssquery-yui.html (next: http://localhost:50239/tests/dromaeo/cssquery-dojo.html) 07:17:45 INFO - 2015-11-13 07:17:45,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 244006912 07:17:45 INFO - 2015-11-13 07:17:45,808 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,808 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:17:45 INFO - 2015-11-13 07:17:45,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:17:45 INFO - 2015-11-13 07:17:45,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:17:45 INFO - 2015-11-13 07:17:45,809 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:17:45 INFO - 2015-11-13 07:17:45,809 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3224.290656055667;3239.6436391996886;3295.4233009223394;3295.835208239589;3324.4680851063817;5264.8157314494;5407.945920540794;5423.701696406701;5439.809606663767;5475;5518.19986102015;5527.060399732045;5564.4991950724425;5573.164025396192;5631.57763167762;5047.545720885119;5094.006668699596;5144.356955380577;5223.660462069954;5278.049951008817;4960.528749768784;5178.482151784829;5187.429382767911;5229.137192363255;5270.288511050997;4935.802567897298;5011.223260394645;5018.121828680003;5018.623603229772;5097.847064588068;5081.923771143399;5085.059264036166;5114.2584325273;5119.334486516766;5162.716050617215;4958.776855041532;5058.974705126488;5078.13671675816;5097.643164978453;5155.84532464023;5382.138857782775;5413.675179489243;5515.503604675599;5534.391216966131;5568.832935011957;6048.939510604881;6057.091436284549;6059.0608455689435;6066.787662431793;6072.2713274406915;5843.2695913010875;6006.579539432241;6008.8497787555225;6015.488683461911;6016.939830601682;5555.222268882319;5621.634593751393;5629.887402251973;5631.267935168484;5677.744501497401;6166.445019948226;6195.31851496335;6224.906626400608;6225.346338634468;6230.096635987757;5808.912866307009;5875.559333050039;5919.6152250103605;6011.7595296187665;6038.184845045863;6050.485708714808;6119.996026621653;6157.7229024694;6166.445019948226;6168.938310616926;6104.204497834925;6124.969375153185;6130.176452100485;6130.4671236227205;6136.557908891407;5836.941630583639;5908.911366329508;5957.940420595739;6021.187139736167;6091.405931131979;4620.168369693421;4629.0973260214605;4647.9767601161775;4649.395578574764;4677.204875171229;4120.608542188487;4130.6282434581035;4151.501819781645;4155.916881662411;4186.790660466964;5634.267545219095;5705.286839145107;5753.165790960287;5783.652980821164;5804.4195580442465;6020.698965051817;6030.547708921848;6038.033914573647;6041.577089603686;6041.909371359433;5614.606977511617;5670.886582268414;5696.544276457874;5701.572382071361;5702.401247868997;5146.2280657900865;5216.452272511332;5221.608379371486;5252.763625636855;5262.947370526323;6274.027525733519;6311;6316.842078948063;6317.842053948596;6317.936820631735;5829.7959571416495;5966.463018328198;6055.697215139314;6062.969685151546;6066.908996364969;6058.151858739692;6145.4161854623735;6150.7539698411565;6157.9384206157365;6161.045038019114;5972.104184372379;5989.910151347646;5995.760169593167;5998.610090344114;6000.69996500182;5803.303603567599;5886.352501224947;5941.22764040672;6088.634681919099;6108.786192483241;5732.283464566929;5772.682502462405;5792.189093526994;5797.768089276382;5810.07038873795;5828.7959921404245;5870.236869206976;5875.970620147043;5876.294844618502;5884.411558844081;5681.8863622726485;5733.5126514245085;5786.103154011135;5796.739146738491;5808.593398462067;5912.172295878667;5928.170056192223;5964.642121472725;5968.253968253968;5980.8803823924145;5790.710464476843;5794.3626201117;5795.072788353843;5795.246617939641;5798.884022319446 07:17:45 INFO - 2015-11-13 07:17:45,810 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.625730994152;580.8634970781867;585.6866576381635;596.1832289763023;599.4634801852345;30272.697273027265;40403.79798101009;40908.59091409085;40934.18131637365;40968.59031409685;42902.35646465298;43739.78130109353;43793.343099853446;44006.339904901455;44043;7714.961425192866;7881.645325960317;8809.515476648781;8986;8989.37074404792;10586.947065264701;10793.946030269837;10870.076043536308;10888.510017049211;10893.618723344685;10466.162706983461;10507.054365107138;10555.73610659732;10558.841617375745;10566.788664226711;7704.229577042307;7865.882011769828;10434.37393756377;10601.575936962512;10801.783964320748;10190;10220.846687299696;10287.074163325336;10313;10325.89674103257;34313;40789.18421631551;40952.590474095174;41038;41118.588814111776;2799.8320100794017;2879.827210367385;3484.6341134181052;3707.888763337104;3975.363941769303;30815.53776693329;30828.845855770578;31022.379552408824;31610.525842112387;31970.520442193385;3457.9827100864586;3517.683408493248;3537.504420635294;3579.3020361029608;3652.945205821915;268855;269914;270216;270330;270888.64555677294;61179.38820611737;61694.69152654298;61740.69129654323;61764;62033.93558837322;64337;64823.35176648267;64990.67504662446;65044.67477662676;65243.67378163174;13267.07130500875;13537;13561;13563.728725425437;13575.864241357658;11727.061835053175;11785.764284714258;11794.823077653842;11797;11814.113941454425;19707.113179906937;20547.8972605136;20582.588348232952;20584.382468525968;20612.175512979313;7412.147603025721;7533.20901305366;7565.6217189140325;7615.629186746328;7630.847383052308;866.8093019535818;884.2969838978028;951.3198063384713;957.7031120352713;1059.6662051453768;25798.8388638517;25913.481730365664;26030.219093427226;27725.58411623827;28296.575551366746;1012.3318609717551;1023.9078482936571;1126.7014241226082;1152.9365884876413;1156.300039407975;14252.643683907985;14541.636459088395;14544.41822327095;14833.332500037524;14851.108933464027;320779;324657;325125;325540;326481;53061.2040819388;53353.73323133437;53354.7332263344;53404.73297633487;53489.73255133777;1307.1764788183384;1308.967275818112;1313.7832257677567;1324.251797734277;1345.4281930179634;26751.598726019514;27439;27902.581461277692;27941.301467463476;27954.301142470787;46610.53389466062;47090.76454617705;47163.528364715916;47188.29217561808;47199.764001181145;293528;298389;301793;372552;379852;29784.851075744482;29856.25359366033;29960.85019574888;29965.400691986473;30019.54970675398;43932.341014884165;45048.77475612601;45113;45610;46263;37553.24893502169;37793.2441351177;38566.42150367803;39191.41212881752;39266.214675705756;35467;36408.27183456263;36751;37328.44007339838;38072.42891356687;33821.15447113842;34560.30879382348;34655.306893861474;34712.82643586766;34814.47778283378;32266.35467290688;33218.50172247466;33591.83204083964;34033.48949765805;34150.65849341475;22000.559988800454;22159;22209.333719988426;22357;22400.551988960455 07:17:45 INFO - 2015-11-13 07:17:45,811 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.507621943608;355.84342889128766;356.2732026665602;357.46380429355963;358.39968053510364;13950.651233719162;14220.146791192536;16825.663486730275;17074.82925170748;17640.382586609456;14123.576292711236;14758.704825903476;14911.478098266563;14995.47515836946;15131.621709457242;5208.166693329077;5419.972900135494;5426.484483974016;5427.511523962842;5434.809781657643;3964.742291751041;4091.0386059276047;5346.6524675896135;5394.244805727201;5829.766809327622;6007.4893634041155;6026.4576188143055;6035.034394496882;6045.3375321786425;6055.333913269536;5803.390643982384;5941.257342832146;5953.58324917256;5959.821205363846;5964.821055368346;5182.196759502283;5195.870103247411;5200.5059519345605;5201.635885488017;5214.322138122057;12644.873551264462;12957.481700732054;13133;13192.604221873358;13305.201687898758;2008.8593798434115;2023.7976202379791;2028.4016215216548;2042.5914817036653;2127.2448280860226;9492.193163581103;9503.762405939839;9528.190103841182;9570.617175312978;9682.273829462749;1613.3304678558384;1627.3002608878178;1673.2219517924223;1675.6983742926268;1696.346906441029;58722;60151;60723.39276607222;60944.39055609432;61784.69107654433;6926;6930.341617546325;6937.549059311129;6994.790156295319;7002.124734408199;8357.331413486907;8361.498310101291;8365.28895043928;8391;8400.201980811813;5321.36143662763;5324.281222035053;5330.880515091797;5418.8916221675345;5429.67421954684;5356.892862142735;5359.678419294854;5407.70257635826;5439.211314359396;5464.672119672832;3206.0862654143457;3218.871245150168;3222.774405791572;3237.967620323767;3251.2359595495514;1057.7144171073767;1083.631565267797;1134.1493879590307;1142.3089031136044;1175.9294442333487;388.18093822035485;398.2890540385456;430.4597729849019;474.4117294554727;515.9767810448463;8956.820863582692;9767;9993.900060999442;10173.880873103953;10655.62705305326;435.19271750902254;436.6921320469125;438.56801050964776;453.75270477589794;457.1451385908373;5523.944760552424;5695.45893140151;5720.77116915327;5725.227094342294;5745.770169193269;547657;549112;554557;555343;563280;69911.65044174746;75000.24999749933;76484;77001;77385.61307193428;500.0324372339462;513.6430181024152;514.5703337713052;515.2966201135498;518.7198912587161;10493.790124197321;10777.299475534066;10790.136789057013;10976.890231097586;11045.889541104487;36485;36572.451413229355;36608.0847978792;36763;36858.63141368552;48640;48885.75557122192;48896;50108.49891501039;50208.74895625498;6498.772542960974;6611.239707433707;6615;6615.272320044887;6617.205935287604;9452.385594936308;11786.646400607995;11860.05119590448;12142.878571214174;12224.71640477737;8766.956165219388;9157.221636161;10580.82575227444;10725.570977161138;10977.121830253402;10498.21263405263;10701;10786.838197426889;10838.403887785931;11029.503672334604;10724.839127412939;10735.194860385658;10928.453577320943;10958.342499450058;10968.945155274172;6646.734130634721;6699.598024118569;6715.429188518835;6716.462682985251;6775.186977562724;10311;10314.742131446774;10489.632862849763;10573.312734672221;10865.891341086488 07:17:45 INFO - 2015-11-13 07:17:45,811 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1568.4118455579157;1710.0936503653065;1740.7214845624703;1774.8935063896163;1779.3060706324536;6703.463722902168;7377.926220737791;7687.192844751305;7717.228277172294;7734.535927844333;7567.583782891938;7664.4634875558595;7668.731594394198;7680.423968202379;7682.807929801757;2000.829929455998;2038.8674736142177;2208.5693289808414;2293.266154830455;2314.9421264468356;2286.0284379138884;2287.359539328982;2287.714035745532;2297.8965946532444;2298.4598619324447;2244.9663255051187;2307.8038366738847;2311.872846993415;2312.9768702313013;2313.0169677886915;2011.3161525081468;2054.3220737156703;2248.9212877549207;2313.7223533175957;2315.8842057897205;2266.784655457729;2284.7829456201634;2313.1903833658253;2314.479242170515;2316.7683231676865;7688.461807673465;7742.496737712031;7768.922310776877;7776.65005074773;7781;4544.931826022612;4613.83851565197;4621.537846215385;4642.512536183686;4649.744264065475;2927.473054850126;2939.456200602874;2941.8381988990595;2963.3184367595572;3097.0399176255432;932.6409332407072;941.7410212191634;968.9273304502191;996.0288718499478;1003.5684655598089;10700.143988480902;10703.304285221435;10707.732306692316;10710.303830251009;10758.731031724114;4161.10536234711;4293.742375457483;4306.956930430718;4319.071399649028;4338.544452832471;9054.909450905538;9058.954705226432;9061;9065.909340906639;9088.909110908939;4510.413646226035;4542.704724192983;4555.589996900295;4558.088382323548;4558.703684260512;4147.854825081168;4149.771762553089;4157.417961485395;4157.521884983265;4169.583041695867;3624.5469316335457;3667.743257971916;3674.210044840319;3676.8713095041544;3707.1288247261873;1223.2721530689225;1227.4169769359662;1231.944562494672;1234.9567765128177;1243.1981372015;971;996.9003099689972;997.8652881861001;1083.2417307884355;1288.2528133682629;7242.782716518513;7277.126744790659;7279.8544029120185;7287.562746235243;7289.927100728924;483.717025540063;485.83724452308167;499.29599265036126;500.1647249094022;502.32186548159694;5309.7079660618265;5353.678779273256;5358.490943360374;5369.221462887859;5373.677579345173;9087.772805679911;9160.81678366429;9369.953150234205;9384.296177786557;9390.5304734763;9200.90799092014;9259.907400925904;9272.072792720808;9273.72178834636;9287.396319239228;7040.331168538981;7105.040819489406;7192.172900116449;7216.097987751531;7268.055152830204;6654.50091243149;6660.63366514827;6685;6690.498212633975;6694.364035416627;7997.200279971957;8147.511149330822;8210;8294.751157465285;8325.542095184823;8299;8521.360897932804;8649.264812490757;8652.913470865211;8670.046294907681;6720.764773232913;6795.150606174228;6825.044493770975;6825.419839313714;6870.484713646597;7507.436942229246;7582;7592.696292148252;7593.734219302298;7598.582077985764;6903.378695917391;6909.93090069113;6917.93082069193;7012.964935175495;7039.908814133817;6028.4272994065495;6236.438720515175;6711.765088221889;6776.6950487227205;6998.790036298919;6905.75829845953;6948.51360404787;6954.47841411886;6954.9652251740445;6958.304169583002;6168.722407491584;6168.907466388097;6193.256809182927;6195.287541932736;6198.597091189058;6278.4349408551625;6292.8426789328805;6300.401461861115;6303;6311.084892690443 07:17:45 INFO - 2015-11-13 07:17:45,813 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.8219068558864;301.874721990374;310.0574254267028;318.48564568222315;320.693737480706;5848.093545500449;5972.641641501507;6002.789902353418;6052.546059045567;6054.394560543943;5885.440883116108;5955.196048533447;5961.701914904259;5971.671558064305;5988.520918326523;4325.113351762881;4401.955980440202;4512.187806194884;4514.706544074641;4520.073384956093;4413.0732546165345;4467.128909862578;4496.572825581565;4521.638268938477;4522.050369422425;4420.756858372788;4442.933355999663;4452.955470445303;4454.866354009385;4458.086092351076;4253.65970722343;4329.393884856123;4358.782060896942;4430.5126436092005;4467.463904331468;3860.7876566788814;3881.941770873439;3883.669888059518;3889.630485103911;3891.8519036884186;5580.218769372291;5583.944160558423;5604.215409842625;5609.102543593006;5629.099344104923;5210.322658054467;5237.816676416345;5238.371395432534;5238.397584277819;5242.1088414969545;6143.232095988002;6231.813045608639;6269.279032911228;6274.717637706314;6284.151639528651;4306.418633484471;4307.5261721210645;4308.353746937984;4308.504521979981;4312.654987600984;6448.258450278231;6519.641419721914;6526.445252153525;6530.804075877683;6531.706073226716;4269.188854117708;4374.606285434326;4375.190589740908;4378.43080399546;4378.474583050054;4422.800973956179;4428.180786554433;4428.269335559597;4428.512863585003;4432.734035957853;5166.5866730661455;5173.741312934339;5177.637565370388;5180.611454140954;5184.455632158644;6332.1135041094285;6349.841253968688;6353.809385718436;6355.205599300088;6357.078223657636;1560.66445714172;1585.5005673212902;1610.5168449465114;1611.548766345425;1614.8062232532172;1045.5974449836715;1046.5865982936698;1049.6273822792798;1051.8106740786732;1056.841473778924;6107.0228763397645;6151.538634602333;6157.4458298753325;6165.599236049642;6170.043643235305;6478;6481.740730370827;6483.384078512534;6490.740370385226;6501.837454063686;6148.262208535004;6152.538559608047;6155.507559395238;6161.4146656067605;6162.198914141222;3423.246885685145;3437.020449171974;3448.77582957107;3506.579210494706;3515.7538972272205;6829.760958366433;6832.487563432763;6873.690683919136;6892.620905850226;6896.069030680794;6655.367740064686;6656.73373065072;6665.566738162101;6669.7332106715185;6693.832654183684;6687.966560167168;6895.931040689529;6900.03399524067;6912.101426814482;6922.5154239202775;6528.412442880163;6555.180602424697;6558.868822623616;6566.80299591013;6567.9014814776865;6505.9265221237965;6518.641474718746;6520.217573891164;6522.543421960418;6525.738970441129;6545.476361891133;6737.090492783412;6746.797596072126;6747.730090796314;6912.135983002125;4320.93518597215;4347.108842687305;4350.73895566267;4351.804168812474;4358.520562738159;6568.244651865097;6571.5399922005;6573.934260657332;6582.539222254396;6585.835354116185;6270.059491076193;6382.808515744535;6387.105805187371;6393.648349340645;6399.136116624196;6377.713002914973;6379.3301703320485;6383.202099737533;6384.106225128578;6390.584612000205;6276.6547839869245;6276.811695649138;6278.497720182283;6282.403171698681;6289.088082228142;6300.401461861115;6381.617102973836;6396.296407395276;6421.325760795236;6436.871262574628;6236.095766113979;6236.656983865931;6241.126242325987;6244.968775156095;6249.406306400884 07:17:45 INFO - 2015-11-13 07:17:45,814 DEBUG : BROWSER_OUTPUT: |5;yui.html;855.9186877246659;857.6226460357439;860.9268212201963;871.2028493928055;881.6649673124211;13710.314484275783;14523.346449409775;14534.709305813878;14545.127292362466;14562.271886405664;13304.201747895133;13380.732385352287;13400.932995335033;13413.530526431578;13415.19508829471;673.4578664175336;682.8327059870338;823.9835203295945;830.8629076202419;838.7274135905825;813.2883726739103;823.8269963307713;830.7923019245188;831.8336332733447;832.5004997001811;875.52284005217;880.8370451466499;881.6958149438434;882.2192359761593;884.2174675412242;712.6757325416922;722.3715367630169;848.9278411335044;863.6718047142109;872.3413822563987;645.6900687669897;646.1438593863103;648.3030741952373;648.3095503288982;648.9188851393576;13407.262600556965;13469.932650336783;13498.932505337509;13520.391582378717;13546.322683865767;12116.697082572919;12579.874201258053;12608.180468269533;12622.873771262262;12863.035272354611;10482.47587620616;10489.63286284984;10602.204834637432;10626.946865265701;10668.733281667943;3465.6707612776745;3548.272604116176;3580.910477238064;3666.5050218220467;3690.944635830465;46387.30419043717;46577;46646.53353466456;46702.29946550805;46748.76625616884;10094.949525252327;10133.847992280122;10207.285490015627;10364.809104586591;10425.791484170275;18574.164162612717;18575;18587.628247435245;18596.25614975413;18630.347937822113;7618.504797188165;7645.541267523967;7781.844363112706;7853.764387068397;8059.838803223903;4158.958410415918;4442.600165985077;4449.17690227309;4452.354408610733;4469.776511174428;3097.4424603571574;3122.1101985934356;3125.8593363298705;3138.1840721412595;3138.76459265556;469.7017393954863;491.4152158930861;495.5960891873112;521.9921701174485;541.4964083402394;602.7498588085983;639.338284875152;651.2445563146726;651.2673242602073;680.2211467869361;8396.748097557083;8417.242448179572;8422.905022347179;8733.126687331343;8758.737237882873;576.9134629805479;639.1339734659563;640.6476437959197;641.4227195523972;660.7753363856312;3852.8266228019806;4024.557298697141;4051.2100140472326;4105.158442519277;4211.157768446323;59116.704416478504;59950.90417314577;60241;60348.69825650844;60552.69723651442;51085.23372149421;51992.740036299576;51994.74002630038;53578.46421535813;55737.72131139319;48076;48205.75897120562;48413;48751.756241218565;48876.266855997186;8382.49705017701;8575.3997220194;8575.528345941033;8896.5996530155;9102.226310763659;35434.29131417409;36349.0912727184;36847;37054.44418333781;37389.81305093457;44856.32715509335;45115.54884451113;46061;46315.305270421646;46323.768381157875;7568.621568921421;7733.4973226740085;7740.729074482366;7744.1094274159195;7997.7600671979935;11934.641960741192;12067.336296503776;12199.756004879675;12226.633201003984;12275.877241227474;10686.412247326472;10698.144148467949;10819.350838949687;10882.673519794418;11218.270812397168;10796.784064318826;11146.609868654557;11187.32876027441;11555.2489088209;11671.183017188716;7104.467164962752;10030.766177054618;10218.335808172445;10487.318324308895;10607.681769546925;9343.81312373735;9542.284328675238;9751.171150452008;9974.501274936369;10258.538365773707;8717.694880679146;9200.35597508168;9395.765105872135;9433.151016408556;9439.952800235955 07:17:45 INFO - 2015-11-13 07:17:45,814 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:17:45 INFO - 2015-11-13 07:17:45,814 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:17:45 INFO - 2015-11-13 07:17:45,814 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,823 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: __startTimestamp1447427865805__endTimestamp 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:17:45 INFO - 2015-11-13 07:17:45,815 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,816 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5584.27 Median:5795.07 stddev:634.73 (11.0%) stddev-sans-first:609.08 07:17:45 INFO - 2015-11-13 07:17:45,817 DEBUG : BROWSER_OUTPUT: Values: 3224.3 3239.6 3295.4 3295.8 3324.5 5264.8 5407.9 5423.7 5439.8 5475.0 5518.2 5527.1 5564.5 5573.2 5631.6 5047.5 5094.0 5144.4 5223.7 5278.0 4960.5 5178.5 5187.4 5229.1 5270.3 4935.8 5011.2 5018.1 5018.6 5097.8 5081.9 5085.1 5114.3 5119.3 5162.7 4958.8 5059.0 5078.1 5097.6 5155.8 5382.1 5413.7 5515.5 5534.4 5568.8 6048.9 6057.1 6059.1 6066.8 6072.3 5843.3 6006.6 6008.8 6015.5 6016.9 5555.2 5621.6 5629.9 5631.3 5677.7 6166.4 6195.3 6224.9 6225.3 6230.1 5808.9 5875.6 5919.6 6011.8 6038.2 6050.5 6120.0 6157.7 6166.4 6168.9 6104.2 6125.0 6130.2 6130.5 6136.6 5836.9 5908.9 5957.9 6021.2 6091.4 4620.2 4629.1 4648.0 4649.4 4677.2 4120.6 4130.6 4151.5 4155.9 4186.8 5634.3 5705.3 5753.2 5783.7 5804.4 6020.7 6030.5 6038.0 6041.6 6041.9 5614.6 5670.9 5696.5 5701.6 5702.4 5146.2 5216.5 5221.6 5252.8 5262.9 6274.0 6311.0 6316.8 6317.8 6317.9 5829.8 5966.5 6055.7 6063.0 6066.9 6058.2 6145.4 6150.8 6157.9 6161.0 5972.1 5989.9 5995.8 5998.6 6000.7 5803.3 5886.4 5941.2 6088.6 6108.8 5732.3 5772.7 5792.2 5797.8 5810.1 5828.8 5870.2 5876.0 5876.3 5884.4 5681.9 5733.5 5786.1 5796.7 5808.6 5912.2 5928.2 5964.6 5968.3 5980.9 5790.7 5794.4 5795.1 5795.2 5798.9 07:17:45 INFO - 2015-11-13 07:17:45,817 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,817 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47978.33 Median:179849.75 stddev:81172.33 (45.1%) stddev-sans-first:81321.91 07:17:45 INFO - 2015-11-13 07:17:45,818 DEBUG : BROWSER_OUTPUT: Values: 543.6 580.9 585.7 596.2 599.5 30272.7 40403.8 40908.6 40934.2 40968.6 42902.4 43739.8 43793.3 44006.3 44043.0 7715.0 7881.6 8809.5 8986.0 8989.4 10586.9 10793.9 10870.1 10888.5 10893.6 10466.2 10507.1 10555.7 10558.8 10566.8 7704.2 7865.9 10434.4 10601.6 10801.8 10190.0 10220.8 10287.1 10313.0 10325.9 34313.0 40789.2 40952.6 41038.0 41118.6 2799.8 2879.8 3484.6 3707.9 3975.4 30815.5 30828.8 31022.4 31610.5 31970.5 3458.0 3517.7 3537.5 3579.3 3652.9 268855.0 269914.0 270216.0 270330.0 270888.6 61179.4 61694.7 61740.7 61764.0 62033.9 64337.0 64823.4 64990.7 65044.7 65243.7 13267.1 13537.0 13561.0 13563.7 13575.9 11727.1 11785.8 11794.8 11797.0 11814.1 19707.1 20547.9 20582.6 20584.4 20612.2 7412.1 7533.2 7565.6 7615.6 7630.8 866.8 884.3 951.3 957.7 1059.7 25798.8 25913.5 26030.2 27725.6 28296.6 1012.3 1023.9 1126.7 1152.9 1156.3 14252.6 14541.6 14544.4 14833.3 14851.1 320779.0 324657.0 325125.0 325540.0 326481.0 53061.2 53353.7 53354.7 53404.7 53489.7 1307.2 1309.0 1313.8 1324.3 1345.4 26751.6 27439.0 27902.6 27941.3 27954.3 46610.5 47090.8 47163.5 47188.3 47199.8 293528.0 298389.0 301793.0 372552.0 379852.0 29784.9 29856.3 29960.9 29965.4 30019.5 43932.3 45048.8 45113.0 45610.0 46263.0 37553.2 37793.2 38566.4 39191.4 39266.2 35467.0 36408.3 36751.0 37328.4 38072.4 33821.2 34560.3 34655.3 34712.8 34814.5 32266.4 33218.5 33591.8 34033.5 34150.7 22000.6 22159.0 22209.3 22357.0 22400.6 07:17:45 INFO - 2015-11-13 07:17:45,819 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,819 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27380.83 Median:25361.20 stddev:90781.67 (358.0%) stddev-sans-first:91013.66 07:17:45 INFO - 2015-11-13 07:17:45,820 DEBUG : BROWSER_OUTPUT: Values: 355.5 355.8 356.3 357.5 358.4 13950.7 14220.1 16825.7 17074.8 17640.4 14123.6 14758.7 14911.5 14995.5 15131.6 5208.2 5420.0 5426.5 5427.5 5434.8 3964.7 4091.0 5346.7 5394.2 5829.8 6007.5 6026.5 6035.0 6045.3 6055.3 5803.4 5941.3 5953.6 5959.8 5964.8 5182.2 5195.9 5200.5 5201.6 5214.3 12644.9 12957.5 13133.0 13192.6 13305.2 2008.9 2023.8 2028.4 2042.6 2127.2 9492.2 9503.8 9528.2 9570.6 9682.3 1613.3 1627.3 1673.2 1675.7 1696.3 58722.0 60151.0 60723.4 60944.4 61784.7 6926.0 6930.3 6937.5 6994.8 7002.1 8357.3 8361.5 8365.3 8391.0 8400.2 5321.4 5324.3 5330.9 5418.9 5429.7 5356.9 5359.7 5407.7 5439.2 5464.7 3206.1 3218.9 3222.8 3238.0 3251.2 1057.7 1083.6 1134.1 1142.3 1175.9 388.2 398.3 430.5 474.4 516.0 8956.8 9767.0 9993.9 10173.9 10655.6 435.2 436.7 438.6 453.8 457.1 5523.9 5695.5 5720.8 5725.2 5745.8 547657.0 549112.0 554557.0 555343.0 563280.0 69911.7 75000.2 76484.0 77001.0 77385.6 500.0 513.6 514.6 515.3 518.7 10493.8 10777.3 10790.1 10976.9 11045.9 36485.0 36572.5 36608.1 36763.0 36858.6 48640.0 48885.8 48896.0 50108.5 50208.7 6498.8 6611.2 6615.0 6615.3 6617.2 9452.4 11786.6 11860.1 12142.9 12224.7 8767.0 9157.2 10580.8 10725.6 10977.1 10498.2 10701.0 10786.8 10838.4 11029.5 10724.8 10735.2 10928.5 10958.3 10968.9 6646.7 6699.6 6715.4 6716.5 6775.2 10311.0 10314.7 10489.6 10573.3 10865.9 07:17:45 INFO - 2015-11-13 07:17:45,821 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,821 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5352.14 Median:6285.64 stddev:2812.34 (44.7%) stddev-sans-first:2805.85 07:17:45 INFO - 2015-11-13 07:17:45,821 DEBUG : BROWSER_OUTPUT: Values: 1568.4 1710.1 1740.7 1774.9 1779.3 6703.5 7377.9 7687.2 7717.2 7734.5 7567.6 7664.5 7668.7 7680.4 7682.8 2000.8 2038.9 2208.6 2293.3 2314.9 2286.0 2287.4 2287.7 2297.9 2298.5 2245.0 2307.8 2311.9 2313.0 2313.0 2011.3 2054.3 2248.9 2313.7 2315.9 2266.8 2284.8 2313.2 2314.5 2316.8 7688.5 7742.5 7768.9 7776.7 7781.0 4544.9 4613.8 4621.5 4642.5 4649.7 2927.5 2939.5 2941.8 2963.3 3097.0 932.6 941.7 968.9 996.0 1003.6 10700.1 10703.3 10707.7 10710.3 10758.7 4161.1 4293.7 4307.0 4319.1 4338.5 9054.9 9059.0 9061.0 9065.9 9088.9 4510.4 4542.7 4555.6 4558.1 4558.7 4147.9 4149.8 4157.4 4157.5 4169.6 3624.5 3667.7 3674.2 3676.9 3707.1 1223.3 1227.4 1231.9 1235.0 1243.2 971.0 996.9 997.9 1083.2 1288.3 7242.8 7277.1 7279.9 7287.6 7289.9 483.7 485.8 499.3 500.2 502.3 5309.7 5353.7 5358.5 5369.2 5373.7 9087.8 9160.8 9370.0 9384.3 9390.5 9200.9 9259.9 9272.1 9273.7 9287.4 7040.3 7105.0 7192.2 7216.1 7268.1 6654.5 6660.6 6685.0 6690.5 6694.4 7997.2 8147.5 8210.0 8294.8 8325.5 8299.0 8521.4 8649.3 8652.9 8670.0 6720.8 6795.2 6825.0 6825.4 6870.5 7507.4 7582.0 7592.7 7593.7 7598.6 6903.4 6909.9 6917.9 7013.0 7039.9 6028.4 6236.4 6711.8 6776.7 6998.8 6905.8 6948.5 6954.5 6955.0 6958.3 6168.7 6168.9 6193.3 6195.3 6198.6 6278.4 6292.8 6300.4 6303.0 6311.1 07:17:45 INFO - 2015-11-13 07:17:45,821 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,821 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5271.78 Median:6125.13 stddev:1627.27 (26.6%) stddev-sans-first:1588.42 07:17:45 INFO - 2015-11-13 07:17:45,822 DEBUG : BROWSER_OUTPUT: Values: 296.8 301.9 310.1 318.5 320.7 5848.1 5972.6 6002.8 6052.5 6054.4 5885.4 5955.2 5961.7 5971.7 5988.5 4325.1 4402.0 4512.2 4514.7 4520.1 4413.1 4467.1 4496.6 4521.6 4522.1 4420.8 4442.9 4453.0 4454.9 4458.1 4253.7 4329.4 4358.8 4430.5 4467.5 3860.8 3881.9 3883.7 3889.6 3891.9 5580.2 5583.9 5604.2 5609.1 5629.1 5210.3 5237.8 5238.4 5238.4 5242.1 6143.2 6231.8 6269.3 6274.7 6284.2 4306.4 4307.5 4308.4 4308.5 4312.7 6448.3 6519.6 6526.4 6530.8 6531.7 4269.2 4374.6 4375.2 4378.4 4378.5 4422.8 4428.2 4428.3 4428.5 4432.7 5166.6 5173.7 5177.6 5180.6 5184.5 6332.1 6349.8 6353.8 6355.2 6357.1 1560.7 1585.5 1610.5 1611.5 1614.8 1045.6 1046.6 1049.6 1051.8 1056.8 6107.0 6151.5 6157.4 6165.6 6170.0 6478.0 6481.7 6483.4 6490.7 6501.8 6148.3 6152.5 6155.5 6161.4 6162.2 3423.2 3437.0 3448.8 3506.6 3515.8 6829.8 6832.5 6873.7 6892.6 6896.1 6655.4 6656.7 6665.6 6669.7 6693.8 6688.0 6895.9 6900.0 6912.1 6922.5 6528.4 6555.2 6558.9 6566.8 6567.9 6505.9 6518.6 6520.2 6522.5 6525.7 6545.5 6737.1 6746.8 6747.7 6912.1 4320.9 4347.1 4350.7 4351.8 4358.5 6568.2 6571.5 6573.9 6582.5 6585.8 6270.1 6382.8 6387.1 6393.6 6399.1 6377.7 6379.3 6383.2 6384.1 6390.6 6276.7 6276.8 6278.5 6282.4 6289.1 6300.4 6381.6 6396.3 6421.3 6436.9 6236.1 6236.7 6241.1 6245.0 6249.4 07:17:45 INFO - 2015-11-13 07:17:45,822 DEBUG : BROWSER_OUTPUT: 07:17:45 INFO - 2015-11-13 07:17:45,822 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13918.66 Median:24272.85 stddev:16439.34 (67.7%) stddev-sans-first:16456.19 07:17:45 INFO - 2015-11-13 07:17:45,822 DEBUG : BROWSER_OUTPUT: Values: 855.9 857.6 860.9 871.2 881.7 13710.3 14523.3 14534.7 14545.1 14562.3 13304.2 13380.7 13400.9 13413.5 13415.2 673.5 682.8 824.0 830.9 838.7 813.3 823.8 830.8 831.8 832.5 875.5 880.8 881.7 882.2 884.2 712.7 722.4 848.9 863.7 872.3 645.7 646.1 648.3 648.3 648.9 13407.3 13469.9 13498.9 13520.4 13546.3 12116.7 12579.9 12608.2 12622.9 12863.0 10482.5 10489.6 10602.2 10626.9 10668.7 3465.7 3548.3 3580.9 3666.5 3690.9 46387.3 46577.0 46646.5 46702.3 46748.8 10094.9 10133.8 10207.3 10364.8 10425.8 18574.2 18575.0 18587.6 18596.3 18630.3 7618.5 7645.5 7781.8 7853.8 8059.8 4159.0 4442.6 4449.2 4452.4 4469.8 3097.4 3122.1 3125.9 3138.2 3138.8 469.7 491.4 495.6 522.0 541.5 602.7 639.3 651.2 651.3 680.2 8396.7 8417.2 8422.9 8733.1 8758.7 576.9 639.1 640.6 641.4 660.8 3852.8 4024.6 4051.2 4105.2 4211.2 59116.7 59950.9 60241.0 60348.7 60552.7 51085.2 51992.7 51994.7 53578.5 55737.7 48076.0 48205.8 48413.0 48751.8 48876.3 8382.5 8575.4 8575.5 8896.6 9102.2 35434.3 36349.1 36847.0 37054.4 37389.8 44856.3 45115.5 46061.0 46315.3 46323.8 7568.6 7733.5 7740.7 7744.1 7997.8 11934.6 12067.3 12199.8 12226.6 12275.9 10686.4 10698.1 10819.4 10882.7 11218.3 10796.8 11146.6 11187.3 11555.2 11671.2 7104.5 10030.8 10218.3 10487.3 10607.7 9343.8 9542.3 9751.2 9974.5 10258.5 8717.7 9200.4 9395.8 9433.2 9440.0 07:17:45 INFO - 2015-11-13 07:17:45,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:17:45 INFO - 2015-11-13 07:17:45,823 DEBUG : BROWSER_OUTPUT: 07:17:53 INFO - 2015-11-13 07:17:53,819 INFO : Browser shutdown timed out after 5 seconds, terminating process. 07:17:53 INFO - 2015-11-13 07:17:53,820 DEBUG : Terminating psutil.Process(pid=27263, name='firefox') 07:17:53 INFO - 2015-11-13 07:17:53,993 INFO : Browser exited with error code: None 07:17:54 INFO - 2015-11-13 07:17:54,014 INFO : Completed test dromaeo_css (00:18:40) 07:17:54 INFO - 2015-11-13 07:17:54,014 INFO : Starting test kraken 07:17:54 INFO - 2015-11-13 07:17:54,014 DEBUG : operating with platform_type : linux_ 07:17:54 INFO - 2015-11-13 07:17:54,014 INFO : Initialising browser for kraken test... 07:17:54 INFO - 2015-11-13 07:17:54,020 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpycmUPF/profile http://localhost:50239/getInfo.html 07:17:58 INFO - 2015-11-13 07:17:58,059 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:17:58 INFO - 2015-11-13 07:17:58,059 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:17:58 INFO - 2015-11-13 07:17:58,059 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:17:58 INFO - 2015-11-13 07:17:58,059 DEBUG : BROWSER_OUTPUT: __metrics 07:17:58 INFO - 2015-11-13 07:17:58,237 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:59 INFO - 2015-11-13 07:17:59,390 INFO : Browser initialized. 07:17:59 INFO - 2015-11-13 07:17:59,390 INFO : Running cycle 1/1 for kraken test... 07:17:59 INFO - 2015-11-13 07:17:59,390 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpycmUPF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:18:11 INFO - 2015-11-13 07:18:11,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 141213696 07:18:11 INFO - 2015-11-13 07:18:11,152 DEBUG : BROWSER_OUTPUT: 07:18:13 INFO - 2015-11-13 07:18:13,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:14 INFO - 2015-11-13 07:18:14,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 178225152 07:18:14 INFO - 2015-11-13 07:18:14,199 DEBUG : BROWSER_OUTPUT: 07:18:16 INFO - 2015-11-13 07:18:16,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-dft) 07:18:17 INFO - 2015-11-13 07:18:17,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 167120896 07:18:17 INFO - 2015-11-13 07:18:17,472 DEBUG : BROWSER_OUTPUT: 07:18:20 INFO - 2015-11-13 07:18:20,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-fft) 07:18:20 INFO - 2015-11-13 07:18:20,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 150892544 07:18:20 INFO - 2015-11-13 07:18:20,944 DEBUG : BROWSER_OUTPUT: 07:18:22 INFO - 2015-11-13 07:18:22,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50239/tests/kraken/driver.html?testName=audio-oscillator) 07:18:23 INFO - 2015-11-13 07:18:23,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 153477120 07:18:23 INFO - 2015-11-13 07:18:23,475 DEBUG : BROWSER_OUTPUT: 07:18:25 INFO - 2015-11-13 07:18:25,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:26 INFO - 2015-11-13 07:18:26,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 154791936 07:18:26 INFO - 2015-11-13 07:18:26,183 DEBUG : BROWSER_OUTPUT: 07:18:29 INFO - 2015-11-13 07:18:29,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:29 INFO - 2015-11-13 07:18:29,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 154087424 07:18:29 INFO - 2015-11-13 07:18:29,667 DEBUG : BROWSER_OUTPUT: 07:18:33 INFO - 2015-11-13 07:18:33,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50239/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:33 INFO - 2015-11-13 07:18:33,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 154824704 07:18:33 INFO - 2015-11-13 07:18:33,617 DEBUG : BROWSER_OUTPUT: 07:18:36 INFO - 2015-11-13 07:18:36,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50239/tests/kraken/driver.html?testName=json-parse-financial) 07:18:36 INFO - 2015-11-13 07:18:36,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 157069312 07:18:36 INFO - 2015-11-13 07:18:36,940 DEBUG : BROWSER_OUTPUT: 07:18:38 INFO - 2015-11-13 07:18:38,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:39 INFO - 2015-11-13 07:18:39,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 164610048 07:18:39 INFO - 2015-11-13 07:18:39,030 DEBUG : BROWSER_OUTPUT: 07:18:40 INFO - 2015-11-13 07:18:40,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:41 INFO - 2015-11-13 07:18:41,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 162213888 07:18:41 INFO - 2015-11-13 07:18:41,415 DEBUG : BROWSER_OUTPUT: 07:18:43 INFO - 2015-11-13 07:18:43,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:44 INFO - 2015-11-13 07:18:44,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 175370240 07:18:44 INFO - 2015-11-13 07:18:44,020 DEBUG : BROWSER_OUTPUT: 07:18:46 INFO - 2015-11-13 07:18:46,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:47 INFO - 2015-11-13 07:18:47,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 180838400 07:18:47 INFO - 2015-11-13 07:18:47,024 DEBUG : BROWSER_OUTPUT: 07:18:49 INFO - 2015-11-13 07:18:49,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:50 INFO - 2015-11-13 07:18:50,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 179056640 07:18:50 INFO - 2015-11-13 07:18:50,152 DEBUG : BROWSER_OUTPUT: 07:18:51 INFO - 2015-11-13 07:18:51,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50239/tests/kraken/driver.html?testName=ai-astar) 07:18:52 INFO - 2015-11-13 07:18:52,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 237248512 07:18:52 INFO - 2015-11-13 07:18:52,067 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,071 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:18:52 INFO - 2015-11-13 07:18:52,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:18:52 INFO - 2015-11-13 07:18:52,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:18:52 INFO - 2015-11-13 07:18:52,071 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:18:52 INFO - 2015-11-13 07:18:52,071 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;113;112;113;100;112;102;110 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;128;162;181;133;149;157;129;178;128 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;161;170;161;164;163;162 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;74;93;70;71;72;106;93;73 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;135;90;90;91;137;90;91;131 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;110;110;109;109 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;145;146;145;146;147;146;146 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;96;95;95;96 07:18:52 INFO - 2015-11-13 07:18:52,072 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;59;59;58;58;59;60;66;57;58 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;68;68;68;68;67;67;73 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;85;85;84;85;85;93;86 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;127;130;118;120;117;123;124;124;114 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;154;155;150;151;143;150;149;150;140 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;68;66;69;65;73;68;65;67 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,917 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: __startTimestamp1447427932069__endTimestamp 07:18:52 INFO - 2015-11-13 07:18:52,073 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,076 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.50 stddev:4.64 (4.2%) stddev-sans-first:4.92 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 113.0 112.0 113.0 100.0 112.0 102.0 110.0 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.50 Median:158.50 stddev:20.37 (12.9%) stddev-sans-first:21.31 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: Values: 160.0 128.0 162.0 181.0 133.0 149.0 157.0 129.0 178.0 128.0 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.80 (1.7%) stddev-sans-first:2.91 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 161.0 170.0 161.0 164.0 163.0 162.0 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.50 Median:72.50 stddev:12.85 (17.7%) stddev-sans-first:13.26 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 74.0 93.0 70.0 71.0 72.0 106.0 93.0 73.0 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,077 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.60 Median:90.00 stddev:21.26 (23.6%) stddev-sans-first:21.97 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 135.0 90.0 90.0 91.0 137.0 90.0 91.0 131.0 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 145.0 146.0 145.0 146.0 147.0 146.0 146.0 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.80 Median:59.00 stddev:2.90 (4.9%) stddev-sans-first:2.65 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 64.0 59.0 59.0 58.0 58.0 59.0 60.0 66.0 57.0 58.0 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.90 07:18:52 INFO - 2015-11-13 07:18:52,078 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 73.0 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.72 (3.2%) stddev-sans-first:2.71 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 93.0 86.0 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.50 stddev:5.40 (4.4%) stddev-sans-first:5.09 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: Values: 114.0 127.0 130.0 118.0 120.0 117.0 123.0 124.0 124.0 114.0 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:150.00 stddev:5.37 (3.6%) stddev-sans-first:4.81 07:18:52 INFO - 2015-11-13 07:18:52,079 DEBUG : BROWSER_OUTPUT: Values: 140.0 154.0 155.0 150.0 151.0 143.0 150.0 149.0 150.0 140.0 07:18:52 INFO - 2015-11-13 07:18:52,080 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,080 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:2.41 (3.6%) stddev-sans-first:2.51 07:18:52 INFO - 2015-11-13 07:18:52,080 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 68.0 66.0 69.0 65.0 73.0 68.0 65.0 67.0 07:18:52 INFO - 2015-11-13 07:18:52,080 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:18:52 INFO - 2015-11-13 07:18:52,080 DEBUG : BROWSER_OUTPUT: 07:18:52 INFO - 2015-11-13 07:18:52,961 INFO : Browser exited with error code: 0 07:18:53 INFO - 2015-11-13 07:18:53,015 INFO : Completed test kraken (00:00:59) 07:18:53 INFO - 2015-11-13 07:18:53,015 INFO : Starting test v8_7 07:18:53 INFO - 2015-11-13 07:18:53,015 DEBUG : operating with platform_type : linux_ 07:18:53 INFO - 2015-11-13 07:18:53,015 INFO : Initialising browser for v8_7 test... 07:18:53 INFO - 2015-11-13 07:18:53,021 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbVRhnC/profile http://localhost:50239/getInfo.html 07:18:56 INFO - 2015-11-13 07:18:56,922 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:18:56 INFO - 2015-11-13 07:18:56,922 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:18:56 INFO - 2015-11-13 07:18:56,922 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:18:56 INFO - 2015-11-13 07:18:56,922 DEBUG : BROWSER_OUTPUT: __metrics 07:18:57 INFO - 2015-11-13 07:18:57,104 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:58 INFO - 2015-11-13 07:18:58,240 INFO : Browser initialized. 07:18:58 INFO - 2015-11-13 07:18:58,241 INFO : Running cycle 1/1 for v8_7 test... 07:18:58 INFO - 2015-11-13 07:18:58,241 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbVRhnC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:19:09 INFO - 2015-11-13 07:19:09,974 DEBUG : BROWSER_OUTPUT: RSS: Main: 141221888 07:19:09 INFO - 2015-11-13 07:19:09,974 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50239/tests/v8_7/run.html (next: http://localhost:50239/tests/v8_7/run.html) 07:19:31 INFO - 2015-11-13 07:19:31,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 497127424 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: |0;Richards;170.41581458759373 07:19:31 INFO - 2015-11-13 07:19:31,652 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.06171162429652 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.2253280091272 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1098.901098901099 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |6;Boyer;11697.67441860465 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |7;RegExp;26128.20512820513 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |8;Splay;561.2073784237004 07:19:31 INFO - 2015-11-13 07:19:31,653 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: __startTimestamp1447427971645__endTimestamp 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,654 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.42 Median:170.42 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: Values: 170.4 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.06 Median:194.06 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: Values: 194.1 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.23 Median:285.23 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: Values: 285.2 07:19:31 INFO - 2015-11-13 07:19:31,655 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: Values: 5065.7 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: Values: 1098.9 07:19:31 INFO - 2015-11-13 07:19:31,656 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: Values: 792.4 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11697.67 Median:11697.67 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: Values: 11697.7 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,657 DEBUG : BROWSER_OUTPUT: Values: 26128.2 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:561.21 Median:561.21 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: Values: 561.2 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: Values: 4822.1 07:19:31 INFO - 2015-11-13 07:19:31,658 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:19:31 INFO - 2015-11-13 07:19:31,659 DEBUG : BROWSER_OUTPUT: 07:19:32 INFO - 2015-11-13 07:19:32,509 INFO : Browser exited with error code: 0 07:19:32 INFO - 2015-11-13 07:19:32,526 INFO : Completed test v8_7 (00:00:39) 07:19:32 INFO - 2015-11-13 07:19:32,640 INFO : Completed test suite (00:20:19) 07:19:32 INFO - 2015-11-13 07:19:32,641 DEBUG : Working with test: dromaeo_css 07:19:32 INFO - 2015-11-13 07:19:32,641 DEBUG : Generating results file: dromaeo_css 07:19:32 INFO - 2015-11-13 07:19:32,642 DEBUG : Working with test: kraken 07:19:32 INFO - 2015-11-13 07:19:32,642 DEBUG : Generating results file: kraken 07:19:32 INFO - 2015-11-13 07:19:32,642 INFO : javascript benchmark 07:19:32 INFO - 2015-11-13 07:19:32,642 DEBUG : Working with test: v8_7 07:19:32 INFO - 2015-11-13 07:19:32,642 DEBUG : Generating results file: v8_7 07:19:32 INFO - 2015-11-13 07:19:32,643 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:32 INFO - 2015-11-13 07:19:32,701 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:19:32 INFO - 2015-11-13 07:19:32,701 DEBUG : process_Request line: dromaeo_css 6724.86 graph.html#tests=[[72,1,35]] 07:19:32 INFO - 2015-11-13 07:19:32,701 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:32 INFO - 2015-11-13 07:19:32,737 DEBUG : process_Request line: kraken 1505.70 graph.html#tests=[[232,1,35]] 07:19:32 INFO - 2015-11-13 07:19:32,737 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:19:32 INFO - 2015-11-13 07:19:32,779 DEBUG : process_Request line: v8_7 21171.43 graph.html#tests=[[230,1,35]] 07:19:32 INFO - 2015-11-13 07:19:32,780 INFO : javascript benchmark 07:19:32 INFO - 2015-11-13 07:19:32,784 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [355.507621943608, 355.84342889128766, 356.2732026665602, 357.46380429355963, 358.39968053510364, 13950.651233719162, 14220.146791192536, 16825.663486730275, 17074.82925170748, 17640.382586609456, 14123.576292711236, 14758.704825903476, 14911.478098266563, 14995.47515836946, 15131.621709457242, 5208.166693329077, 5419.972900135494, 5426.484483974016, 5427.511523962842, 5434.809781657643, 3964.742291751041, 4091.0386059276047, 5346.6524675896135, 5394.244805727201, 5829.766809327622, 6007.4893634041155, 6026.4576188143055, 6035.034394496882, 6045.3375321786425, 6055.333913269536, 5803.390643982384, 5941.257342832146, 5953.58324917256, 5959.821205363846, 5964.821055368346, 5182.196759502283, 5195.870103247411, 5200.5059519345605, 5201.635885488017, 5214.322138122057, 12644.873551264462, 12957.481700732054, 13133.0, 13192.604221873358, 13305.201687898758, 2008.8593798434115, 2023.7976202379791, 2028.4016215216548, 2042.5914817036653, 2127.2448280860226, 9492.193163581103, 9503.762405939839, 9528.190103841182, 9570.617175312978, 9682.273829462749, 1613.3304678558384, 1627.3002608878178, 1673.2219517924223, 1675.6983742926268, 1696.346906441029, 58722.0, 60151.0, 60723.39276607222, 60944.39055609432, 61784.69107654433, 6926.0, 6930.341617546325, 6937.549059311129, 6994.790156295319, 7002.124734408199, 8357.331413486907, 8361.498310101291, 8365.28895043928, 8391.0, 8400.201980811813, 5321.36143662763, 5324.281222035053, 5330.880515091797, 5418.8916221675345, 5429.67421954684, 5356.892862142735, 5359.678419294854, 5407.70257635826, 5439.211314359396, 5464.672119672832, 3206.0862654143457, 3218.871245150168, 3222.774405791572, 3237.967620323767, 3251.2359595495514, 1057.7144171073767, 1083.631565267797, 1134.1493879590307, 1142.3089031136044, 1175.9294442333487, 388.18093822035485, 398.2890540385456, 430.4597729849019, 474.4117294554727, 515.9767810448463, 8956.820863582692, 9767.0, 9993.900060999442, 10173.880873103953, 10655.62705305326, 435.19271750902254, 436.6921320469125, 438.56801050964776, 453.75270477589794, 457.1451385908373, 5523.944760552424, 5695.45893140151, 5720.77116915327, 5725.227094342294, 5745.770169193269, 547657.0, 549112.0, 554557.0, 555343.0, 563280.0, 69911.65044174746, 75000.24999749933, 76484.0, 77001.0, 77385.61307193428, 500.0324372339462, 513.6430181024152, 514.5703337713052, 515.2966201135498, 518.7198912587161, 10493.790124197321, 10777.299475534066, 10790.136789057013, 10976.890231097586, 11045.889541104487, 36485.0, 36572.451413229355, 36608.0847978792, 36763.0, 36858.63141368552, 48640.0, 48885.75557122192, 48896.0, 50108.49891501039, 50208.74895625498, 6498.772542960974, 6611.239707433707, 6615.0, 6615.272320044887, 6617.205935287604, 9452.385594936308, 11786.646400607995, 11860.05119590448, 12142.878571214174, 12224.71640477737, 8766.956165219388, 9157.221636161, 10580.82575227444, 10725.570977161138, 10977.121830253402, 10498.21263405263, 10701.0, 10786.838197426889, 10838.403887785931, 11029.503672334604, 10724.839127412939, 10735.194860385658, 10928.453577320943, 10958.342499450058, 10968.945155274172, 6646.734130634721, 6699.598024118569, 6715.429188518835, 6716.462682985251, 6775.186977562724, 10311.0, 10314.742131446774, 10489.632862849763, 10573.312734672221, 10865.891341086488], "dojo.html": [3224.290656055667, 3239.6436391996886, 3295.4233009223394, 3295.835208239589, 3324.4680851063817, 5264.8157314494, 5407.945920540794, 5423.701696406701, 5439.809606663767, 5475.0, 5518.19986102015, 5527.060399732045, 5564.4991950724425, 5573.164025396192, 5631.57763167762, 5047.545720885119, 5094.006668699596, 5144.356955380577, 5223.660462069954, 5278.049951008817, 4960.528749768784, 5178.482151784829, 5187.429382767911, 5229.137192363255, 5270.288511050997, 4935.802567897298, 5011.223260394645, 5018.121828680003, 5018.623603229772, 5097.847064588068, 5081.923771143399, 5085.059264036166, 5114.2584325273, 5119.334486516766, 5162.716050617215, 4958.776855041532, 5058.974705126488, 5078.13671675816, 5097.643164978453, 5155.84532464023, 5382.138857782775, 5413.675179489243, 5515.503604675599, 5534.391216966131, 5568.832935011957, 6048.939510604881, 6057.091436284549, 6059.0608455689435, 6066.787662431793, 6072.2713274406915, 5843.2695913010875, 6006.579539432241, 6008.8497787555225, 6015.488683461911, 6016.939830601682, 5555.222268882319, 5621.634593751393, 5629.887402251973, 5631.267935168484, 5677.744501497401, 6166.445019948226, 6195.31851496335, 6224.906626400608, 6225.346338634468, 6230.096635987757, 5808.912866307009, 5875.559333050039, 5919.6152250103605, 6011.7595296187665, 6038.184845045863, 6050.485708714808, 6119.996026621653, 6157.7229024694, 6166.445019948226, 6168.938310616926, 6104.204497834925, 6124.969375153185, 6130.176452100485, 6130.4671236227205, 6136.557908891407, 5836.941630583639, 5908.911366329508, 5957.940420595739, 6021.187139736167, 6091.405931131979, 4620.168369693421, 4629.0973260214605, 4647.9767601161775, 4649.395578574764, 4677.204875171229, 4120.608542188487, 4130.6282434581035, 4151.501819781645, 4155.916881662411, 4186.790660466964, 5634.267545219095, 5705.286839145107, 5753.165790960287, 5783.652980821164, 5804.4195580442465, 6020.698965051817, 6030.547708921848, 6038.033914573647, 6041.577089603686, 6041.909371359433, 5614.606977511617, 5670.886582268414, 5696.544276457874, 5701.572382071361, 5702.401247868997, 5146.2280657900865, 5216.452272511332, 5221.608379371486, 5252.763625636855, 5262.947370526323, 6274.027525733519, 6311.0, 6316.842078948063, 6317.842053948596, 6317.936820631735, 5829.7959571416495, 5966.463018328198, 6055.697215139314, 6062.969685151546, 6066.908996364969, 6058.151858739692, 6145.4161854623735, 6150.7539698411565, 6157.9384206157365, 6161.045038019114, 5972.104184372379, 5989.910151347646, 5995.760169593167, 5998.610090344114, 6000.69996500182, 5803.303603567599, 5886.352501224947, 5941.22764040672, 6088.634681919099, 6108.786192483241, 5732.283464566929, 5772.682502462405, 5792.189093526994, 5797.768089276382, 5810.07038873795, 5828.7959921404245, 5870.236869206976, 5875.970620147043, 5876.294844618502, 5884.411558844081, 5681.8863622726485, 5733.5126514245085, 5786.103154011135, 5796.739146738491, 5808.593398462067, 5912.172295878667, 5928.170056192223, 5964.642121472725, 5968.253968253968, 5980.8803823924145, 5790.710464476843, 5794.3626201117, 5795.072788353843, 5795.246617939641, 5798.884022319446], "mootools.html": [1568.4118455579157, 1710.0936503653065, 1740.7214845624703, 1774.8935063896163, 1779.3060706324536, 6703.463722902168, 7377.926220737791, 7687.192844751305, 7717.228277172294, 7734.535927844333, 7567.583782891938, 7664.4634875558595, 7668.731594394198, 7680.423968202379, 7682.807929801757, 2000.829929455998, 2038.8674736142177, 2208.5693289808414, 2293.266154830455, 2314.9421264468356, 2286.0284379138884, 2287.359539328982, 2287.714035745532, 2297.8965946532444, 2298.4598619324447, 2244.9663255051187, 2307.8038366738847, 2311.872846993415, 2312.9768702313013, 2313.0169677886915, 2011.3161525081468, 2054.3220737156703, 2248.9212877549207, 2313.7223533175957, 2315.8842057897205, 2266.784655457729, 2284.7829456201634, 2313.1903833658253, 2314.479242170515, 2316.7683231676865, 7688.461807673465, 7742.496737712031, 7768.922310776877, 7776.65005074773, 7781.0, 4544.931826022612, 4613.83851565197, 4621.537846215385, 4642.512536183686, 4649.744264065475, 2927.473054850126, 2939.456200602874, 2941.8381988990595, 2963.3184367595572, 3097.0399176255432, 932.6409332407072, 941.7410212191634, 968.9273304502191, 996.0288718499478, 1003.5684655598089, 10700.143988480902, 10703.304285221435, 10707.732306692316, 10710.303830251009, 10758.731031724114, 4161.10536234711, 4293.742375457483, 4306.956930430718, 4319.071399649028, 4338.544452832471, 9054.909450905538, 9058.954705226432, 9061.0, 9065.909340906639, 9088.909110908939, 4510.413646226035, 4542.704724192983, 4555.589996900295, 4558.088382323548, 4558.703684260512, 4147.854825081168, 4149.771762553089, 4157.417961485395, 4157.521884983265, 4169.583041695867, 3624.5469316335457, 3667.743257971916, 3674.210044840319, 3676.8713095041544, 3707.1288247261873, 1223.2721530689225, 1227.4169769359662, 1231.944562494672, 1234.9567765128177, 1243.1981372015, 971.0, 996.9003099689972, 997.8652881861001, 1083.2417307884355, 1288.2528133682629, 7242.782716518513, 7277.126744790659, 7279.8544029120185, 7287.562746235243, 7289.927100728924, 483.717025540063, 485.83724452308167, 499.29599265036126, 500.1647249094022, 502.32186548159694, 5309.7079660618265, 5353.678779273256, 5358.490943360374, 5369.221462887859, 5373.677579345173, 9087.772805679911, 9160.81678366429, 9369.953150234205, 9384.296177786557, 9390.5304734763, 9200.90799092014, 9259.907400925904, 9272.072792720808, 9273.72178834636, 9287.396319239228, 7040.331168538981, 7105.040819489406, 7192.172900116449, 7216.097987751531, 7268.055152830204, 6654.50091243149, 6660.63366514827, 6685.0, 6690.498212633975, 6694.364035416627, 7997.200279971957, 8147.511149330822, 8210.0, 8294.751157465285, 8325.542095184823, 8299.0, 8521.360897932804, 8649.264812490757, 8652.913470865211, 8670.046294907681, 6720.764773232913, 6795.150606174228, 6825.044493770975, 6825.419839313714, 6870.484713646597, 7507.436942229246, 7582.0, 7592.696292148252, 7593.734219302298, 7598.582077985764, 6903.378695917391, 6909.93090069113, 6917.93082069193, 7012.964935175495, 7039.908814133817, 6028.4272994065495, 6236.438720515175, 6711.765088221889, 6776.6950487227205, 6998.790036298919, 6905.75829845953, 6948.51360404787, 6954.47841411886, 6954.9652251740445, 6958.304169583002, 6168.722407491584, 6168.907466388097, 6193.256809182927, 6195.287541932736, 6198.597091189058, 6278.4349408551625, 6292.8426789328805, 6300.401461861115, 6303.0, 6311.084892690443], "ext.html": [543.625730994152, 580.8634970781867, 585.6866576381635, 596.1832289763023, 599.4634801852345, 30272.697273027265, 40403.79798101009, 40908.59091409085, 40934.18131637365, 40968.59031409685, 42902.35646465298, 43739.78130109353, 43793.343099853446, 44006.339904901455, 44043.0, 7714.961425192866, 7881.645325960317, 8809.515476648781, 8986.0, 8989.37074404792, 10586.947065264701, 10793.946030269837, 10870.076043536308, 10888.510017049211, 10893.618723344685, 10466.162706983461, 10507.054365107138, 10555.73610659732, 10558.841617375745, 10566.788664226711, 7704.229577042307, 7865.882011769828, 10434.37393756377, 10601.575936962512, 10801.783964320748, 10190.0, 10220.846687299696, 10287.074163325336, 10313.0, 10325.89674103257, 34313.0, 40789.18421631551, 40952.590474095174, 41038.0, 41118.588814111776, 2799.8320100794017, 2879.827210367385, 3484.6341134181052, 3707.888763337104, 3975.363941769303, 30815.53776693329, 30828.845855770578, 31022.379552408824, 31610.525842112387, 31970.520442193385, 3457.9827100864586, 3517.683408493248, 3537.504420635294, 3579.3020361029608, 3652.945205821915, 268855.0, 269914.0, 270216.0, 270330.0, 270888.64555677294, 61179.38820611737, 61694.69152654298, 61740.69129654323, 61764.0, 62033.93558837322, 64337.0, 64823.35176648267, 64990.67504662446, 65044.67477662676, 65243.67378163174, 13267.07130500875, 13537.0, 13561.0, 13563.728725425437, 13575.864241357658, 11727.061835053175, 11785.764284714258, 11794.823077653842, 11797.0, 11814.113941454425, 19707.113179906937, 20547.8972605136, 20582.588348232952, 20584.382468525968, 20612.175512979313, 7412.147603025721, 7533.20901305366, 7565.6217189140325, 7615.629186746328, 7630.847383052308, 866.8093019535818, 884.2969838978028, 951.3198063384713, 957.7031120352713, 1059.6662051453768, 25798.8388638517, 25913.481730365664, 26030.219093427226, 27725.58411623827, 28296.575551366746, 1012.3318609717551, 1023.9078482936571, 1126.7014241226082, 1152.9365884876413, 1156.300039407975, 14252.643683907985, 14541.636459088395, 14544.41822327095, 14833.332500037524, 14851.108933464027, 320779.0, 324657.0, 325125.0, 325540.0, 326481.0, 53061.2040819388, 53353.73323133437, 53354.7332263344, 53404.73297633487, 53489.73255133777, 1307.1764788183384, 1308.967275818112, 1313.7832257677567, 1324.251797734277, 1345.4281930179634, 26751.598726019514, 27439.0, 27902.581461277692, 27941.301467463476, 27954.301142470787, 46610.53389466062, 47090.76454617705, 47163.528364715916, 47188.29217561808, 47199.764001181145, 293528.0, 298389.0, 301793.0, 372552.0, 379852.0, 29784.851075744482, 29856.25359366033, 29960.85019574888, 29965.400691986473, 30019.54970675398, 43932.341014884165, 45048.77475612601, 45113.0, 45610.0, 46263.0, 37553.24893502169, 37793.2441351177, 38566.42150367803, 39191.41212881752, 39266.214675705756, 35467.0, 36408.27183456263, 36751.0, 37328.44007339838, 38072.42891356687, 33821.15447113842, 34560.30879382348, 34655.306893861474, 34712.82643586766, 34814.47778283378, 32266.35467290688, 33218.50172247466, 33591.83204083964, 34033.48949765805, 34150.65849341475, 22000.559988800454, 22159.0, 22209.333719988426, 22357.0, 22400.551988960455], "prototype.html": [296.8219068558864, 301.874721990374, 310.0574254267028, 318.48564568222315, 320.693737480706, 5848.093545500449, 5972.641641501507, 6002.789902353418, 6052.546059045567, 6054.394560543943, 5885.440883116108, 5955.196048533447, 5961.701914904259, 5971.671558064305, 5988.520918326523, 4325.113351762881, 4401.955980440202, 4512.187806194884, 4514.706544074641, 4520.073384956093, 4413.0732546165345, 4467.128909862578, 4496.572825581565, 4521.638268938477, 4522.050369422425, 4420.756858372788, 4442.933355999663, 4452.955470445303, 4454.866354009385, 4458.086092351076, 4253.65970722343, 4329.393884856123, 4358.782060896942, 4430.5126436092005, 4467.463904331468, 3860.7876566788814, 3881.941770873439, 3883.669888059518, 3889.630485103911, 3891.8519036884186, 5580.218769372291, 5583.944160558423, 5604.215409842625, 5609.102543593006, 5629.099344104923, 5210.322658054467, 5237.816676416345, 5238.371395432534, 5238.397584277819, 5242.1088414969545, 6143.232095988002, 6231.813045608639, 6269.279032911228, 6274.717637706314, 6284.151639528651, 4306.418633484471, 4307.5261721210645, 4308.353746937984, 4308.504521979981, 4312.654987600984, 6448.258450278231, 6519.641419721914, 6526.445252153525, 6530.804075877683, 6531.706073226716, 4269.188854117708, 4374.606285434326, 4375.190589740908, 4378.43080399546, 4378.474583050054, 4422.800973956179, 4428.180786554433, 4428.269335559597, 4428.512863585003, 4432.734035957853, 5166.5866730661455, 5173.741312934339, 5177.637565370388, 5180.611454140954, 5184.455632158644, 6332.1135041094285, 6349.841253968688, 6353.809385718436, 6355.205599300088, 6357.078223657636, 1560.66445714172, 1585.5005673212902, 1610.5168449465114, 1611.548766345425, 1614.8062232532172, 1045.5974449836715, 1046.5865982936698, 1049.6273822792798, 1051.8106740786732, 1056.841473778924, 6107.0228763397645, 6151.538634602333, 6157.4458298753325, 6165.599236049642, 6170.043643235305, 6478.0, 6481.740730370827, 6483.384078512534, 6490.740370385226, 6501.837454063686, 6148.262208535004, 6152.538559608047, 6155.507559395238, 6161.4146656067605, 6162.198914141222, 3423.246885685145, 3437.020449171974, 3448.77582957107, 3506.579210494706, 3515.7538972272205, 6829.760958366433, 6832.487563432763, 6873.690683919136, 6892.620905850226, 6896.069030680794, 6655.367740064686, 6656.73373065072, 6665.566738162101, 6669.7332106715185, 6693.832654183684, 6687.966560167168, 6895.931040689529, 6900.03399524067, 6912.101426814482, 6922.5154239202775, 6528.412442880163, 6555.180602424697, 6558.868822623616, 6566.80299591013, 6567.9014814776865, 6505.9265221237965, 6518.641474718746, 6520.217573891164, 6522.543421960418, 6525.738970441129, 6545.476361891133, 6737.090492783412, 6746.797596072126, 6747.730090796314, 6912.135983002125, 4320.93518597215, 4347.108842687305, 4350.73895566267, 4351.804168812474, 4358.520562738159, 6568.244651865097, 6571.5399922005, 6573.934260657332, 6582.539222254396, 6585.835354116185, 6270.059491076193, 6382.808515744535, 6387.105805187371, 6393.648349340645, 6399.136116624196, 6377.713002914973, 6379.3301703320485, 6383.202099737533, 6384.106225128578, 6390.584612000205, 6276.6547839869245, 6276.811695649138, 6278.497720182283, 6282.403171698681, 6289.088082228142, 6300.401461861115, 6381.617102973836, 6396.296407395276, 6421.325760795236, 6436.871262574628, 6236.095766113979, 6236.656983865931, 6241.126242325987, 6244.968775156095, 6249.406306400884], "yui.html": [855.9186877246659, 857.6226460357439, 860.9268212201963, 871.2028493928055, 881.6649673124211, 13710.314484275783, 14523.346449409775, 14534.709305813878, 14545.127292362466, 14562.271886405664, 13304.201747895133, 13380.732385352287, 13400.932995335033, 13413.530526431578, 13415.19508829471, 673.4578664175336, 682.8327059870338, 823.9835203295945, 830.8629076202419, 838.7274135905825, 813.2883726739103, 823.8269963307713, 830.7923019245188, 831.8336332733447, 832.5004997001811, 875.52284005217, 880.8370451466499, 881.6958149438434, 882.2192359761593, 884.2174675412242, 712.6757325416922, 722.3715367630169, 848.9278411335044, 863.6718047142109, 872.3413822563987, 645.6900687669897, 646.1438593863103, 648.3030741952373, 648.3095503288982, 648.9188851393576, 13407.262600556965, 13469.932650336783, 13498.932505337509, 13520.391582378717, 13546.322683865767, 12116.697082572919, 12579.874201258053, 12608.180468269533, 12622.873771262262, 12863.035272354611, 10482.47587620616, 10489.63286284984, 10602.204834637432, 10626.946865265701, 10668.733281667943, 3465.6707612776745, 3548.272604116176, 3580.910477238064, 3666.5050218220467, 3690.944635830465, 46387.30419043717, 46577.0, 46646.53353466456, 46702.29946550805, 46748.76625616884, 10094.949525252327, 10133.847992280122, 10207.285490015627, 10364.809104586591, 10425.791484170275, 18574.164162612717, 18575.0, 18587.628247435245, 18596.25614975413, 18630.347937822113, 7618.504797188165, 7645.541267523967, 7781.844363112706, 7853.764387068397, 8059.838803223903, 4158.958410415918, 4442.600165985077, 4449.17690227309, 4452.354408610733, 4469.776511174428, 3097.4424603571574, 3122.1101985934356, 3125.8593363298705, 3138.1840721412595, 3138.76459265556, 469.7017393954863, 491.4152158930861, 495.5960891873112, 521.9921701174485, 541.4964083402394, 602.7498588085983, 639.338284875152, 651.2445563146726, 651.2673242602073, 680.2211467869361, 8396.748097557083, 8417.242448179572, 8422.905022347179, 8733.126687331343, 8758.737237882873, 576.9134629805479, 639.1339734659563, 640.6476437959197, 641.4227195523972, 660.7753363856312, 3852.8266228019806, 4024.557298697141, 4051.2100140472326, 4105.158442519277, 4211.157768446323, 59116.704416478504, 59950.90417314577, 60241.0, 60348.69825650844, 60552.69723651442, 51085.23372149421, 51992.740036299576, 51994.74002630038, 53578.46421535813, 55737.72131139319, 48076.0, 48205.75897120562, 48413.0, 48751.756241218565, 48876.266855997186, 8382.49705017701, 8575.3997220194, 8575.528345941033, 8896.5996530155, 9102.226310763659, 35434.29131417409, 36349.0912727184, 36847.0, 37054.44418333781, 37389.81305093457, 44856.32715509335, 45115.54884451113, 46061.0, 46315.305270421646, 46323.768381157875, 7568.621568921421, 7733.4973226740085, 7740.729074482366, 7744.1094274159195, 7997.7600671979935, 11934.641960741192, 12067.336296503776, 12199.756004879675, 12226.633201003984, 12275.877241227474, 10686.412247326472, 10698.144148467949, 10819.350838949687, 10882.673519794418, 11218.270812397168, 10796.784064318826, 11146.609868654557, 11187.32876027441, 11555.2489088209, 11671.183017188716, 7104.467164962752, 10030.766177054618, 10218.335808172445, 10487.318324308895, 10607.681769546925, 9343.81312373735, 9542.284328675238, 9751.171150452008, 9974.501274936369, 10258.538365773707, 8717.694880679146, 9200.35597508168, 9395.765105872135, 9433.151016408556, 9439.952800235955]}, "summary": {"lowerIsBetter": false, "suite": 6724.86013321985, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6934.283579198329, "unit": "ms", "value": 6934.283579198329}, "dojo.html": {"lowerIsBetter": false, "filtered": 5541.821589268364, "unit": "ms", "value": 5541.821589268364}, "mootools.html": {"lowerIsBetter": false, "filtered": 4323.715781764166, "unit": "ms", "value": 4323.715781764166}, "ext.html": {"lowerIsBetter": false, "filtered": 18773.982506740565, "unit": "ms", "value": 18773.982506740565}, "prototype.html": {"lowerIsBetter": false, "filtered": 4734.164970885808, "unit": "ms", "value": 4734.164970885808}, "yui.html": {"lowerIsBetter": false, "filtered": 6262.536903101158, "unit": "ms", "value": 6262.536903101158}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-023"}, "testrun": {"date": 1447426753, "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": "20151113043003", "branch": "Firefox", "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 161.0, 161.0, 161.0, 170.0, 161.0, 164.0, 163.0, 162.0], "ai-astar": [109.0, 111.0, 106.0, 113.0, 112.0, 113.0, 100.0, 112.0, 102.0, 110.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "audio-beat-detection": [160.0, 128.0, 162.0, 181.0, 133.0, 149.0, 157.0, 129.0, 178.0, 128.0], "json-stringify-tinderbox": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 73.0], "stanford-crypto-pbkdf2": [140.0, 154.0, 155.0, 150.0, 151.0, 143.0, 150.0, 149.0, 150.0, 140.0], "json-parse-financial": [64.0, 59.0, 59.0, 58.0, 58.0, 59.0, 60.0, 66.0, 57.0, 58.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 68.0, 66.0, 69.0, 65.0, 73.0, 68.0, 65.0, 67.0], "audio-fft": [71.0, 72.0, 74.0, 93.0, 70.0, 71.0, 72.0, 106.0, 93.0, 73.0], "imaging-darkroom": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "stanford-crypto-ccm": [114.0, 127.0, 130.0, 118.0, 120.0, 117.0, 123.0, 124.0, 124.0, 114.0], "audio-oscillator": [90.0, 91.0, 135.0, 90.0, 90.0, 91.0, 137.0, 90.0, 91.0, 131.0], "stanford-crypto-aes": [83.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 93.0, 86.0], "imaging-desaturate": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1505.6999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.5, "unit": "ms", "value": 79.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.2, "unit": "ms", "value": 148.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 150.5, "unit": "ms", "value": 150.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.1, "unit": "ms", "value": 121.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.7, "unit": "ms", "value": 145.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.8, "unit": "ms", "value": 59.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.6, "unit": "ms", "value": 103.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.8, "unit": "ms", "value": 108.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 162.6, "unit": "ms", "value": 162.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.0, "unit": "ms", "value": 68.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.6, "unit": "ms", "value": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-023"}, "testrun": {"date": 1447426753, "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": "20151113043003", "branch": "Firefox", "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.06171162429652], "Encrypt": [285.2253280091272], "NavierStokes": [4822.115384615385], "Decrypt": [5065.656565656565], "Splay": [561.2073784237004], "Richards": [170.41581458759373], "RegExp": [26128.20512820513], "Earley": [792.3930269413629], "Boyer": [11697.67441860465], "RayTrace": [1098.901098901099]}, "summary": {"lowerIsBetter": false, "suite": 21171.42821162053, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.70605400000017, "unit": "score", "value": 340.70605400000017}, "Encrypt": {"lowerIsBetter": false, "filtered": 933.2305859999998, "unit": "score", "value": 933.2305859999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 145.20657270916334, "unit": "score", "value": 145.20657270916334}, "RegExp": {"lowerIsBetter": false, "filtered": 34.86596172718352, "unit": "score", "value": 34.86596172718352}, "Richards": {"lowerIsBetter": false, "filtered": 207.15213600000004, "unit": "score", "value": 207.15213600000004}, "Earley": {"lowerIsBetter": false, "filtered": 841.0763060000003, "unit": "score", "value": 841.0763060000003}, "Boyer": {"lowerIsBetter": false, "filtered": 56.97397415506962, "unit": "score", "value": 56.97397415506962}, "RayTrace": {"lowerIsBetter": false, "filtered": 673.3899900000001, "unit": "score", "value": 673.3899900000001}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-023"}, "testrun": {"date": 1447426753, "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": "20151113043003", "branch": "Firefox", "revision": "faf815a0fa9b052a38bce00c0c2aa1e2c9610936"}}] 07:19:32 INFO - RETURN: dromaeo_css: 6724.86 07:19:32 INFO - RETURN: kraken: 1505.70 07:19:32 INFO - RETURN: v8_7: 21171.43 07:19:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21171.43"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1505.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6724.86"}}} 07:19:32 INFO - Return code: 0 07:19:32 INFO - # TBPL SUCCESS # 07:19:32 INFO - Running post-action listener: _resource_record_post_action 07:19:32 INFO - Running post-run listener: _resource_record_post_run 07:19:33 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505335808; Read time: 8; Write time: 418116 07:19:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 163708928; Read time: 0; Write time: 182076 07:19:33 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336891904; Read time: 8; Write time: 235680 07:19:33 INFO - Running post-run listener: _upload_blobber_files 07:19:33 INFO - Blob upload gear active. 07:19:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:19:33 INFO - Copying logs to upload dir... 07:19:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.168217 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-13 07:19:33.022659) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 07:19:33.026318) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009936 build_url: 'https://queue.taskcluster.net/v1/task/0AqZTKR4ScekU4sv7816rQ/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-13 07:19:33.078242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:19:33.078610) ========= 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=e10134013339c31d8d0c4708000001d6-1447426705.503939-2033653932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 07:19:33.129043) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 07:19:33.129386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 07:19:33.129703) ========= ========= Total master_lag: 0.22 =========