builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1448539105.39 results: success (0) buildid: 20151126023013 builduid: 44c9c8f8885d42ec8a682f64ea17d6ec revision: 201e1c425b3affae859d9df7db17afd3ebce415f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.391359) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.391849) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.392133) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006485 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.412614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.412931) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.422374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.422801) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.473520) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.473933) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.474417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.474794) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 03:58:25-- 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% 43.0M=0s 2015-11-26 03:58:25 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172747 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.661425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.661829) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014750 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.713574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:25.713921) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 201e1c425b3affae859d9df7db17afd3ebce415f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 201e1c425b3affae859d9df7db17afd3ebce415f --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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 03:58:26,111 truncating revision to first 12 chars 2015-11-26 03:58:26,111 Setting DEBUG logging. 2015-11-26 03:58:26,111 attempt 1/10 2015-11-26 03:58:26,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/201e1c425b3a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 03:58:26,375 unpacking tar archive at: b2g-inbound-201e1c425b3a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532533 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:26.260135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:26.260499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:26.272045) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:26.272633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 03:58:26.273354) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-26 03:58:26.273784) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:58:26 INFO - MultiFileLogger online at 20151126 03:58:26 in /builds/slave/test-pgo 03:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 03:58:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:58:26 INFO - {'append_to_log': False, 03:58:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:58:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 03:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:58:26 INFO - 'branch': 'B2G-Inbound', 03:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:26 INFO - 'config_files': ('talos/linux_config.py',), 03:58:26 INFO - 'default_actions': ('clobber', 03:58:26 INFO - 'read-buildbot-config', 03:58:26 INFO - 'download-and-extract', 03:58:26 INFO - 'populate-webroot', 03:58:26 INFO - 'create-virtualenv', 03:58:26 INFO - 'install', 03:58:26 INFO - 'run-tests'), 03:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:26 INFO - 'download_minidump_stackwalk': True, 03:58:26 INFO - 'download_symbols': 'ondemand', 03:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:26 INFO - 'installer_path': 'installer.exe', 03:58:26 INFO - 'log_level': 'info', 03:58:26 INFO - 'log_name': 'talos', 03:58:26 INFO - 'log_to_console': True, 03:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:58:26 INFO - 'opt_config_files': (), 03:58:26 INFO - 'pip_index': False, 03:58:26 INFO - 'sps_profile': False, 03:58:26 INFO - 'sps_profile_interval': 0, 03:58:26 INFO - 'suite': 'dromaeojs', 03:58:26 INFO - 'system_bits': '64', 03:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:26 INFO - 'title': 'talos-linux64-ix-037', 03:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:26 INFO - 'use_talos_json': True, 03:58:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:26 INFO - 'work_dir': 'build'} 03:58:26 INFO - ##### 03:58:26 INFO - ##### Running clobber step. 03:58:26 INFO - ##### 03:58:26 INFO - Running pre-action listener: _resource_record_pre_action 03:58:26 INFO - Running main action method: clobber 03:58:26 INFO - rmtree: /builds/slave/test-pgo/build 03:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:58:27 INFO - Running post-action listener: _resource_record_post_action 03:58:27 INFO - ##### 03:58:27 INFO - ##### Running read-buildbot-config step. 03:58:27 INFO - ##### 03:58:27 INFO - Running pre-action listener: _resource_record_pre_action 03:58:27 INFO - Running main action method: read_buildbot_config 03:58:27 INFO - Using buildbot properties: 03:58:27 INFO - { 03:58:27 INFO - "properties": { 03:58:27 INFO - "buildnumber": 116, 03:58:27 INFO - "product": "firefox", 03:58:27 INFO - "script_repo_revision": "production", 03:58:27 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 03:58:27 INFO - "repository": "", 03:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 03:58:27 INFO - "buildid": "20151126023013", 03:58:27 INFO - "slavename": "talos-linux64-ix-037", 03:58:27 INFO - "pgo_build": "True", 03:58:27 INFO - "basedir": "/builds/slave/test-pgo", 03:58:27 INFO - "project": "", 03:58:27 INFO - "platform": "ubuntu64_hw", 03:58:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:58:27 INFO - "slavebuilddir": "test", 03:58:27 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 03:58:27 INFO - "branch": "b2g-inbound", 03:58:27 INFO - "repo_path": "integration/b2g-inbound", 03:58:27 INFO - "stage_platform": "linux64-pgo", 03:58:27 INFO - "builduid": "44c9c8f8885d42ec8a682f64ea17d6ec", 03:58:27 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 03:58:27 INFO - }, 03:58:27 INFO - "sourcestamp": { 03:58:27 INFO - "repository": "", 03:58:27 INFO - "hasPatch": false, 03:58:27 INFO - "project": "", 03:58:27 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:58:27 INFO - "changes": [ 03:58:27 INFO - { 03:58:27 INFO - "category": null, 03:58:27 INFO - "files": [ 03:58:27 INFO - { 03:58:27 INFO - "url": null, 03:58:27 INFO - "name": "https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:58:27 INFO - } 03:58:27 INFO - ], 03:58:27 INFO - "repository": "", 03:58:27 INFO - "rev": "201e1c425b3affae859d9df7db17afd3ebce415f", 03:58:27 INFO - "who": "sendchange", 03:58:27 INFO - "when": 1448538681, 03:58:27 INFO - "number": 6710245, 03:58:27 INFO - "comments": "", 03:58:27 INFO - "project": "", 03:58:27 INFO - "at": "Thu 26 Nov 2015 03:51:21", 03:58:27 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 03:58:27 INFO - "revlink": "", 03:58:27 INFO - "properties": [ 03:58:27 INFO - [ 03:58:27 INFO - "buildid", 03:58:27 INFO - "20151126023013", 03:58:27 INFO - "Change" 03:58:27 INFO - ], 03:58:27 INFO - [ 03:58:27 INFO - "builduid", 03:58:27 INFO - "44c9c8f8885d42ec8a682f64ea17d6ec", 03:58:27 INFO - "Change" 03:58:27 INFO - ], 03:58:27 INFO - [ 03:58:27 INFO - "pgo_build", 03:58:27 INFO - "True", 03:58:27 INFO - "Change" 03:58:27 INFO - ] 03:58:27 INFO - ], 03:58:27 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 03:58:27 INFO - } 03:58:27 INFO - ], 03:58:27 INFO - "revision": "201e1c425b3affae859d9df7db17afd3ebce415f" 03:58:27 INFO - } 03:58:27 INFO - } 03:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:58:27 INFO - Running post-action listener: _resource_record_post_action 03:58:27 INFO - ##### 03:58:27 INFO - ##### Running download-and-extract step. 03:58:27 INFO - ##### 03:58:27 INFO - Running pre-action listener: _resource_record_pre_action 03:58:27 INFO - Running main action method: download_and_extract 03:58:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:58:27 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')]} 03:58:27 INFO - https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/test_packages.json 03:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/test_packages.json 03:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:58:28 INFO - Downloaded 1302 bytes. 03:58:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:58:28 INFO - Using the following test package requirements: 03:58:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:58:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'jsshell-linux-x86_64.zip'], 03:58:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:58:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:58:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:58:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:58:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:58:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:58:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:58:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:28 INFO - https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:29 INFO - Downloaded 22755377 bytes. 03:58:29 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 03:58:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:29 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 03:58:30 INFO - Return code: 0 03:58:30 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 03:58:30 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')]} 03:58:30 INFO - https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:31 INFO - Downloaded 22755377 bytes. 03:58:31 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 03:58:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:58:31 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 03:58:33 INFO - Return code: 0 03: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')]} 03:58:33 INFO - https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:34 INFO - Downloaded 11131717 bytes. 03:58:34 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 03:58:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:58:34 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 03:58:34 INFO - Return code: 0 03:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:34 INFO - https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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 03:58:35 INFO - Downloaded 58394586 bytes. 03:58:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:35 INFO - mkdir: /builds/slave/test-pgo/properties 03:58:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:58:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:58:35 INFO - Contents: 03:58:35 INFO - build_url:https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:58:35 INFO - Running post-action listener: _resource_record_post_action 03:58:35 INFO - Running post-action listener: set_extra_try_arguments 03:58:35 INFO - ##### 03:58:35 INFO - ##### Running populate-webroot step. 03:58:35 INFO - ##### 03:58:35 INFO - Running pre-action listener: _resource_record_pre_action 03:58:35 INFO - Running main action method: populate_webroot 03:58:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:58:35 INFO - '../fennec_ids.txt'], 03:58:35 INFO - 'tests': ['tcheck2']}, 03:58:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:35 INFO - '--tppagecycles', 03:58:35 INFO - '7'], 03:58:35 INFO - 'tests': ['tsvgm']}}, 03:58:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:58:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:58:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'tests': ['damp', 'tps']}, 03:58:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['damp', 'tps']}, 03:58:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:58:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:35 INFO - 'other': {'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'other_l64': {'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'other_nol64': {'tests': ['a11yr', 03:58:35 INFO - 'ts_paint', 03:58:35 INFO - 'tpaint', 03:58:35 INFO - 'sessionrestore', 03:58:35 INFO - 'sessionrestore_no_auto_restore']}, 03:58:35 INFO - 'svgr': {'tests': ['tsvgx', 03:58:35 INFO - 'tsvgr_opacity', 03:58:35 INFO - 'tart', 03:58:35 INFO - 'tscrollx', 03:58:35 INFO - 'cart']}, 03:58:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['tsvgx', 03:58:35 INFO - 'tsvgr_opacity', 03:58:35 INFO - 'tart', 03:58:35 INFO - 'tscrollx', 03:58:35 INFO - 'cart']}, 03:58:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'tests': ['tp5o']}, 03:58:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'talos_options': ['--e10s'], 03:58:35 INFO - 'tests': ['tp5o']}, 03:58:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'talos_options': ['--xperf_path', 03:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:35 INFO - 'tests': ['tp5n']}, 03:58:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:58:35 INFO - 'talos_options': ['--e10s', 03:58:35 INFO - '--xperf_path', 03:58:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:35 INFO - 'tests': ['tp5n']}}, 03:58:35 INFO - 'talos.zip': {'path': '', 03:58:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:35 INFO - Running post-action listener: _resource_record_post_action 03:58:35 INFO - ##### 03:58:35 INFO - ##### Running create-virtualenv step. 03:58:35 INFO - ##### 03:58:35 INFO - Running pre-action listener: _resource_record_pre_action 03:58:35 INFO - Running main action method: create_virtualenv 03:58:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:58:35 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 03:58:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:58:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:35 INFO - Using real prefix '/usr' 03:58:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:58:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:38 INFO - Installing pip.................done. 03:58:38 INFO - Return code: 0 03:58:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:38 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:38 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 03:58:38 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 03:58:38 INFO - Using env: {'DISPLAY': ':0', 03:58:38 INFO - 'HOME': '/home/cltbld', 03:58:38 INFO - 'LANG': 'en_US.UTF-8', 03:58:38 INFO - 'LANGUAGE': 'en_US:en', 03:58:38 INFO - 'LOGNAME': 'cltbld', 03:58:38 INFO - 'MAIL': '/var/mail/cltbld', 03:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:38 INFO - 'MOZ_NO_REMOTE': '1', 03:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:38 INFO - 'NO_EM_RESTART': '1', 03:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:38 INFO - 'SHELL': '/bin/bash', 03:58:38 INFO - 'SHLVL': '1', 03:58:38 INFO - 'TERM': 'linux', 03:58:38 INFO - 'TMOUT': '86400', 03:58:38 INFO - 'USER': 'cltbld', 03:58:38 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:38 INFO - '_': '/tools/buildbot/bin/python'} 03:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:38 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 03:58:38 INFO - Cleaning up... 03:58:38 INFO - Return code: 0 03:58:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:38 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:38 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 03:58:38 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 03:58:38 INFO - Using env: {'DISPLAY': ':0', 03:58:38 INFO - 'HOME': '/home/cltbld', 03:58:38 INFO - 'LANG': 'en_US.UTF-8', 03:58:38 INFO - 'LANGUAGE': 'en_US:en', 03:58:38 INFO - 'LOGNAME': 'cltbld', 03:58:38 INFO - 'MAIL': '/var/mail/cltbld', 03:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:38 INFO - 'MOZ_NO_REMOTE': '1', 03:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:38 INFO - 'NO_EM_RESTART': '1', 03:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:38 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:38 INFO - 'SHELL': '/bin/bash', 03:58:38 INFO - 'SHLVL': '1', 03:58:38 INFO - 'TERM': 'linux', 03:58:38 INFO - 'TMOUT': '86400', 03:58:38 INFO - 'USER': 'cltbld', 03:58:38 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:38 INFO - '_': '/tools/buildbot/bin/python'} 03:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:38 INFO - Downloading/unpacking psutil>=0.7.1 03:58:38 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 03:58:38 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 03:58:38 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 03:58:38 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 03:58:38 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 03:58:38 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 03:58:40 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:58:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:58:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:40 INFO - Installing collected packages: psutil 03:58:40 INFO - Running setup.py install for psutil 03:58:40 INFO - building 'psutil._psutil_linux' extension 03:58:40 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 03:58:40 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 03:58:40 INFO - building 'psutil._psutil_posix' extension 03:58:40 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 03:58:41 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 03:58:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:41 INFO - Successfully installed psutil 03:58:41 INFO - Cleaning up... 03:58:41 INFO - Return code: 0 03:58:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:41 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 03:58:41 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 03:58:41 INFO - Using env: {'DISPLAY': ':0', 03:58:41 INFO - 'HOME': '/home/cltbld', 03:58:41 INFO - 'LANG': 'en_US.UTF-8', 03:58:41 INFO - 'LANGUAGE': 'en_US:en', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MAIL': '/var/mail/cltbld', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SHLVL': '1', 03:58:41 INFO - 'TERM': 'linux', 03:58:41 INFO - 'TMOUT': '86400', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - '_': '/tools/buildbot/bin/python'} 03:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:58:41 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 03:58:41 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 03:58:41 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 03:58:41 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 03:58:41 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 03:58:41 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 03:58:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:58:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:58:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:58:43 INFO - Installing collected packages: mozsystemmonitor 03:58:43 INFO - Running setup.py install for mozsystemmonitor 03:58:43 INFO - Successfully installed mozsystemmonitor 03:58:43 INFO - Cleaning up... 03:58:43 INFO - Return code: 0 03:58:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03: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')]} 03:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', '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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03: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 blobuploader==1.2.4 03:58:43 INFO - Using env: {'DISPLAY': ':0', 03:58:43 INFO - 'HOME': '/home/cltbld', 03:58:43 INFO - 'LANG': 'en_US.UTF-8', 03:58:43 INFO - 'LANGUAGE': 'en_US:en', 03:58:43 INFO - 'LOGNAME': 'cltbld', 03:58:43 INFO - 'MAIL': '/var/mail/cltbld', 03:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:43 INFO - 'MOZ_NO_REMOTE': '1', 03:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:43 INFO - 'NO_EM_RESTART': '1', 03:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:43 INFO - 'SHELL': '/bin/bash', 03:58:43 INFO - 'SHLVL': '1', 03:58:43 INFO - 'TERM': 'linux', 03:58:43 INFO - 'TMOUT': '86400', 03:58:43 INFO - 'USER': 'cltbld', 03:58:43 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:43 INFO - '_': '/tools/buildbot/bin/python'} 03:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:43 INFO - Downloading/unpacking blobuploader==1.2.4 03: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 03: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 03: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 03: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 03: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 03: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 03:58:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 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 03:58:45 INFO - Downloading docopt-0.6.1.tar.gz 03:58:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:58:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:45 INFO - Running setup.py install for blobuploader 03:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:58:45 INFO - Running setup.py install for requests 03:58:46 INFO - Running setup.py install for docopt 03:58:46 INFO - Successfully installed blobuploader requests docopt 03:58:46 INFO - Cleaning up... 03:58:46 INFO - Return code: 0 03:58:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03: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')]} 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:46 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 03:58:46 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 03:58:46 INFO - Using env: {'DISPLAY': ':0', 03:58:46 INFO - 'HOME': '/home/cltbld', 03:58:46 INFO - 'LANG': 'en_US.UTF-8', 03:58:46 INFO - 'LANGUAGE': 'en_US:en', 03:58:46 INFO - 'LOGNAME': 'cltbld', 03:58:46 INFO - 'MAIL': '/var/mail/cltbld', 03:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:46 INFO - 'MOZ_NO_REMOTE': '1', 03:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:46 INFO - 'NO_EM_RESTART': '1', 03:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:46 INFO - 'SHELL': '/bin/bash', 03:58:46 INFO - 'SHLVL': '1', 03:58:46 INFO - 'TERM': 'linux', 03:58:46 INFO - 'TMOUT': '86400', 03:58:46 INFO - 'USER': 'cltbld', 03:58:46 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:46 INFO - '_': '/tools/buildbot/bin/python'} 03:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:46 INFO - Running setup.py (path:/tmp/pip-UY_9VY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:46 INFO - Running setup.py (path:/tmp/pip-0pjj1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:46 INFO - Running setup.py (path:/tmp/pip-6qW6Ef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:46 INFO - Running setup.py (path:/tmp/pip-vDuwHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:46 INFO - Running setup.py (path:/tmp/pip-uFAU0G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:47 INFO - Running setup.py (path:/tmp/pip-L48NvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:47 INFO - Running setup.py (path:/tmp/pip-VEkOTu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:47 INFO - Running setup.py (path:/tmp/pip-Ubr52h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:47 INFO - Running setup.py (path:/tmp/pip-AZ6f4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:47 INFO - Running setup.py (path:/tmp/pip-PX0Sz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:47 INFO - Running setup.py (path:/tmp/pip-HKtCNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:47 INFO - Running setup.py (path:/tmp/pip-PfvNVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:47 INFO - Running setup.py (path:/tmp/pip-i4CdDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:47 INFO - Running setup.py (path:/tmp/pip-KmWtxM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:47 INFO - Running setup.py (path:/tmp/pip-wOnap8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:47 INFO - Running setup.py (path:/tmp/pip-Kx6qO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:47 INFO - Running setup.py (path:/tmp/pip-iL_Ed2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:47 INFO - Running setup.py install for manifestparser 03:58:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:58:47 INFO - Running setup.py install for mozcrash 03:58:48 INFO - Running setup.py install for mozdebug 03:58:48 INFO - Running setup.py install for mozdevice 03:58:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Running setup.py install for mozfile 03:58:48 INFO - Running setup.py install for mozhttpd 03:58:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Running setup.py install for mozinfo 03:58:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Running setup.py install for mozInstall 03:58:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Running setup.py install for mozleak 03:58:48 INFO - Running setup.py install for mozlog 03:58:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:58:48 INFO - Running setup.py install for moznetwork 03:58:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Running setup.py install for mozprocess 03:58:49 INFO - Running setup.py install for mozprofile 03:58:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Running setup.py install for mozrunner 03:58:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Running setup.py install for mozscreenshot 03:58:49 INFO - Running setup.py install for moztest 03:58:49 INFO - Running setup.py install for mozversion 03:58:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:58:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:49 INFO - Cleaning up... 03:58:49 INFO - Return code: 0 03:58:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:49 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:49 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 03:58:49 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 03:58:49 INFO - Using env: {'DISPLAY': ':0', 03:58:49 INFO - 'HOME': '/home/cltbld', 03:58:49 INFO - 'LANG': 'en_US.UTF-8', 03:58:49 INFO - 'LANGUAGE': 'en_US:en', 03:58:49 INFO - 'LOGNAME': 'cltbld', 03:58:49 INFO - 'MAIL': '/var/mail/cltbld', 03:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:49 INFO - 'MOZ_NO_REMOTE': '1', 03:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:49 INFO - 'NO_EM_RESTART': '1', 03:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:49 INFO - 'SHELL': '/bin/bash', 03:58:49 INFO - 'SHLVL': '1', 03:58:49 INFO - 'TERM': 'linux', 03:58:49 INFO - 'TMOUT': '86400', 03:58:49 INFO - 'USER': 'cltbld', 03:58:49 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:49 INFO - '_': '/tools/buildbot/bin/python'} 03:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:49 INFO - Running setup.py (path:/tmp/pip-ldk8Ra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:58:49 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)) 03:58:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:49 INFO - Running setup.py (path:/tmp/pip-Bb5pyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:50 INFO - Running setup.py (path:/tmp/pip-FcRoL0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:50 INFO - Running setup.py (path:/tmp/pip-oML6PQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:50 INFO - Running setup.py (path:/tmp/pip-FgISqs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:50 INFO - Running setup.py (path:/tmp/pip-qTwhzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:50 INFO - Running setup.py (path:/tmp/pip-q1FLVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:50 INFO - Running setup.py (path:/tmp/pip-6l2xsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:50 INFO - Running setup.py (path:/tmp/pip-r9aQFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:50 INFO - Running setup.py (path:/tmp/pip-N9ObHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:50 INFO - Running setup.py (path:/tmp/pip-GkKycM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:50 INFO - Running setup.py (path:/tmp/pip-Dfo04r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:50 INFO - Running setup.py (path:/tmp/pip-JPIQtC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:50 INFO - Running setup.py (path:/tmp/pip-hytD_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:50 INFO - Running setup.py (path:/tmp/pip-7EPMJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:58:50 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)) 03:58:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:50 INFO - Running setup.py (path:/tmp/pip-M37cIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:58:51 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)) 03:58:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:51 INFO - Running setup.py (path:/tmp/pip-ncZITe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:58:51 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)) 03:58:51 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)) 03:58:51 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)) 03:58:51 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)) 03:58:51 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)) 03:58:51 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)) 03:58:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:51 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 03:58:51 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 03:58:51 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 03:58:51 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 03:58:51 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 03:58:51 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 03:58:52 INFO - Downloading blessings-1.5.1.tar.gz 03:58:52 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 03:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:52 INFO - Installing collected packages: blessings 03:58:52 INFO - Running setup.py install for blessings 03:58:52 INFO - Successfully installed blessings 03:58:52 INFO - Cleaning up... 03:58:53 INFO - Return code: 0 03:58:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:58:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:58:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:58:53 INFO - Reading from file tmpfile_stdout 03:58:53 INFO - Current package versions: 03:58:53 INFO - argparse == 1.2.1 03:58:53 INFO - blessings == 1.5.1 03:58:53 INFO - blobuploader == 1.2.4 03:58:53 INFO - docopt == 0.6.1 03:58:53 INFO - manifestparser == 1.1 03:58:53 INFO - mozInstall == 1.12 03:58:53 INFO - mozcrash == 0.16 03:58:53 INFO - mozdebug == 0.1 03:58:53 INFO - mozdevice == 0.47 03:58:53 INFO - mozfile == 1.2 03:58:53 INFO - mozhttpd == 0.7 03:58:53 INFO - mozinfo == 0.9 03:58:53 INFO - mozleak == 0.1 03:58:53 INFO - mozlog == 3.1 03:58:53 INFO - moznetwork == 0.27 03:58:53 INFO - mozprocess == 0.22 03:58:53 INFO - mozprofile == 0.27 03:58:53 INFO - mozrunner == 6.11 03:58:53 INFO - mozscreenshot == 0.1 03:58:53 INFO - mozsystemmonitor == 0.0 03:58:53 INFO - moztest == 0.7 03:58:53 INFO - mozversion == 1.4 03:58:53 INFO - psutil == 3.1.1 03:58:53 INFO - requests == 1.2.3 03:58:53 INFO - wsgiref == 0.1.2 03:58:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:58:53 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')]} 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:53 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')]} 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:53 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 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:53 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 03:58:53 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 03:58:53 INFO - Using env: {'DISPLAY': ':0', 03:58:53 INFO - 'HOME': '/home/cltbld', 03:58:53 INFO - 'LANG': 'en_US.UTF-8', 03:58:53 INFO - 'LANGUAGE': 'en_US:en', 03:58:53 INFO - 'LOGNAME': 'cltbld', 03:58:53 INFO - 'MAIL': '/var/mail/cltbld', 03:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:53 INFO - 'MOZ_NO_REMOTE': '1', 03:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:53 INFO - 'NO_EM_RESTART': '1', 03:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:53 INFO - 'SHELL': '/bin/bash', 03:58:53 INFO - 'SHLVL': '1', 03:58:53 INFO - 'TERM': 'linux', 03:58:53 INFO - 'TMOUT': '86400', 03:58:53 INFO - 'USER': 'cltbld', 03:58:53 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:53 INFO - '_': '/tools/buildbot/bin/python'} 03:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 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)) 03:58:53 INFO - Cleaning up... 03:58:53 INFO - Return code: 0 03:58:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:58:53 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')]} 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:53 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')]} 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:53 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x132e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x148e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', '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 03:58:53 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', 'jsonschema'] in /builds/slave/test-pgo/build 03:58:53 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 jsonschema 03:58:53 INFO - Using env: {'DISPLAY': ':0', 03:58:53 INFO - 'HOME': '/home/cltbld', 03:58:53 INFO - 'LANG': 'en_US.UTF-8', 03:58:53 INFO - 'LANGUAGE': 'en_US:en', 03:58:53 INFO - 'LOGNAME': 'cltbld', 03:58:53 INFO - 'MAIL': '/var/mail/cltbld', 03:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:53 INFO - 'MOZ_NO_REMOTE': '1', 03:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:58:53 INFO - 'NO_EM_RESTART': '1', 03:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:58:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:58:53 INFO - 'SHELL': '/bin/bash', 03:58:53 INFO - 'SHLVL': '1', 03:58:53 INFO - 'TERM': 'linux', 03:58:53 INFO - 'TMOUT': '86400', 03:58:53 INFO - 'USER': 'cltbld', 03:58:53 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:53 INFO - '_': '/tools/buildbot/bin/python'} 03:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:53 INFO - Downloading/unpacking jsonschema 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:53 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 03:58:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:58:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:58:55 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 03:58:55 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 03:58:55 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 03:58:55 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 03:58:55 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 03:58:55 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 03:58:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:58:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:55 INFO - warning: no files found matching '*.txt' 03:58:55 INFO - no previously-included directories found matching 'build' 03:58:55 INFO - no previously-included directories found matching 'dist' 03:58:55 INFO - no previously-included directories found matching '.git*' 03:58:55 INFO - Installing collected packages: jsonschema, functools32 03:58:55 INFO - Running setup.py install for functools32 03:58:55 INFO - warning: no files found matching '*.txt' 03:58:55 INFO - no previously-included directories found matching 'build' 03:58:55 INFO - no previously-included directories found matching 'dist' 03:58:55 INFO - no previously-included directories found matching '.git*' 03:58:55 INFO - Successfully installed jsonschema functools32 03:58:55 INFO - Cleaning up... 03:58:55 INFO - Return code: 0 03:58:55 INFO - Running post-action listener: _resource_record_post_action 03:58:55 INFO - Running post-action listener: _start_resource_monitoring 03:58:55 INFO - Starting resource monitoring. 03:58:55 INFO - ##### 03:58:55 INFO - ##### Running install step. 03:58:55 INFO - ##### 03:58:55 INFO - Running pre-action listener: _resource_record_pre_action 03:58:55 INFO - Running main action method: install 03:58:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:58:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:58:56 INFO - Reading from file tmpfile_stdout 03:58:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:58:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:58:56 INFO - Reading from file tmpfile_stdout 03:58:56 INFO - Output received: 03:58:56 INFO - Usage: mozinstall [options] installer 03:58:56 INFO - Options: 03:58:56 INFO - -h, --help show this help message and exit 03:58:56 INFO - -d DEST, --destination=DEST 03:58:56 INFO - Directory to install application into. [default: 03:58:56 INFO - "/builds/slave/test-pgo"] 03:58:56 INFO - --app=APP Application being installed. [default: firefox] 03:58:56 INFO - mkdir: /builds/slave/test-pgo/build/application 03:58:56 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'] 03:58:56 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 03:59:10 INFO - Reading from file tmpfile_stdout 03:59:10 INFO - Output received: 03:59:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:59:10 INFO - Running post-action listener: _resource_record_post_action 03:59:10 INFO - ##### 03:59:10 INFO - ##### Running run-tests step. 03:59:10 INFO - ##### 03:59:10 INFO - Running pre-action listener: _resource_record_pre_action 03:59:10 INFO - Running main action method: run_tests 03:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:59:10 INFO - Python 2.7.3 03:59:10 INFO - Return code: 0 03:59:10 INFO - grabbing minidump binary from tooltool 03:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:10 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 0x15ea640>, '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 0x15eb540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15eb9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:59:10 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 03:59:10 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 03:59:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:10 INFO - Return code: 0 03:59:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:59:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:59:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:59:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:59:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:59:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:59:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 03:59:10 INFO - Using env: {'DISPLAY': ':0', 03:59:10 INFO - 'HOME': '/home/cltbld', 03:59:10 INFO - 'LANG': 'en_US.UTF-8', 03:59:10 INFO - 'LANGUAGE': 'en_US:en', 03:59:10 INFO - 'LOGNAME': 'cltbld', 03:59:10 INFO - 'MAIL': '/var/mail/cltbld', 03:59:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:59:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:10 INFO - 'MOZ_NO_REMOTE': '1', 03:59:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:10 INFO - 'NO_EM_RESTART': '1', 03:59:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:59:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:59:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:59:10 INFO - 'SHELL': '/bin/bash', 03:59:10 INFO - 'SHLVL': '1', 03:59:10 INFO - 'TERM': 'linux', 03:59:10 INFO - 'TMOUT': '86400', 03:59:10 INFO - 'USER': 'cltbld', 03:59:10 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971', 03:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:10 INFO - '_': '/tools/buildbot/bin/python'} 03:59:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 03:59:11 INFO - mozversion INFO | application_buildid: 20151126023013 03:59:11 INFO - mozversion INFO | application_changeset: 201e1c425b3affae859d9df7db17afd3ebce415f 03:59:11 INFO - mozversion INFO | application_display_name: Nightly 03:59:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:11 INFO - mozversion INFO | application_name: Firefox 03:59:11 INFO - mozversion INFO | application_remotingname: firefox 03:59:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 03:59:11 INFO - mozversion INFO | application_vendor: Mozilla 03:59:11 INFO - mozversion INFO | application_version: 45.0a1 03:59:11 INFO - mozversion INFO | platform_buildid: 20151126023013 03:59:11 INFO - mozversion INFO | platform_changeset: 201e1c425b3affae859d9df7db17afd3ebce415f 03:59:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 03:59:11 INFO - mozversion INFO | platform_version: 45.0a1 03:59:11 INFO - 2015-11-26 03:59:11,135 DEBUG : using testdate: 1448539151 03:59:11 INFO - 2015-11-26 03:59:11,135 DEBUG : actual date: 1448539151 03:59:11 INFO - 2015-11-26 03:59:11,147 INFO : starting webserver on 'localhost:51010' 03:59:11 INFO - 2015-11-26 03:59:11,148 INFO : Starting test suite talos-linux64-ix-037 03:59:11 INFO - 2015-11-26 03:59:11,148 INFO : Starting test dromaeo_css 03:59:11 INFO - 2015-11-26 03:59:11,148 DEBUG : operating with platform_type : linux_ 03:59:11 INFO - 2015-11-26 03:59:11,149 INFO : Initialising browser for dromaeo_css test... 03:59:11 INFO - 2015-11-26 03:59:11,165 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYmuomS/profile http://localhost:51010/getInfo.html 03:59:15 INFO - 2015-11-26 03:59:15,259 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:59:15 INFO - 2015-11-26 03:59:15,259 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:59:15 INFO - 2015-11-26 03:59:15,259 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:59:15 INFO - 2015-11-26 03:59:15,259 DEBUG : BROWSER_OUTPUT: __metrics 03:59:15 INFO - 2015-11-26 03:59:15,421 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:16 INFO - 2015-11-26 03:59:16,685 INFO : Browser initialized. 03:59:16 INFO - 2015-11-26 03:59:16,685 INFO : Running cycle 1/1 for dromaeo_css test... 03:59:16 INFO - 2015-11-26 03:59:16,685 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYmuomS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:59:28 INFO - 2015-11-26 03:59:28,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 138604544 03:59:28 INFO - 2015-11-26 03:59:28,369 DEBUG : BROWSER_OUTPUT: 04:00:19 INFO - 2015-11-26 04:00:19,036 DEBUG : BROWSER_OUTPUT: 1448539219034 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] 04:02:28 INFO - 2015-11-26 04:02:28,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51010/tests/dromaeo/cssquery-ext.html) 04:02:30 INFO - 2015-11-26 04:02:30,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 334413824 04:02:30 INFO - 2015-11-26 04:02:30,484 DEBUG : BROWSER_OUTPUT: 04:05:32 INFO - 2015-11-26 04:05:32,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-ext.html (next: http://localhost:51010/tests/dromaeo/cssquery-jquery.html) 04:05:33 INFO - 2015-11-26 04:05:33,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 225902592 04:05:33 INFO - 2015-11-26 04:05:33,554 DEBUG : BROWSER_OUTPUT: 04:08:35 INFO - 2015-11-26 04:08:35,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51010/tests/dromaeo/cssquery-mootools.html) 04:08:36 INFO - 2015-11-26 04:08:36,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 219942912 04:08:36 INFO - 2015-11-26 04:08:36,081 DEBUG : BROWSER_OUTPUT: 04:11:38 INFO - 2015-11-26 04:11:38,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51010/tests/dromaeo/cssquery-prototype.html) 04:11:38 INFO - 2015-11-26 04:11:38,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 200982528 04:11:38 INFO - 2015-11-26 04:11:38,603 DEBUG : BROWSER_OUTPUT: 04:14:41 INFO - 2015-11-26 04:14:41,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51010/tests/dromaeo/cssquery-yui.html) 04:14:41 INFO - 2015-11-26 04:14:41,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 204787712 04:14:41 INFO - 2015-11-26 04:14:41,734 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/dromaeo/cssquery-yui.html (next: http://localhost:51010/tests/dromaeo/cssquery-dojo.html) 04:17:44 INFO - 2015-11-26 04:17:44,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 271319040 04:17:44 INFO - 2015-11-26 04:17:44,494 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,496 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:17:44 INFO - 2015-11-26 04:17:44,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:17:44 INFO - 2015-11-26 04:17:44,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:17:44 INFO - 2015-11-26 04:17:44,496 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:17:44 INFO - 2015-11-26 04:17:44,497 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3193.409219294431;3253.333066721322;3281.1305004173896;3286.819224942627;3312.5196846457266;5322.148456247001;5450.890982180354;5480.26016487774;5526.778928842847;5550.916736248954;5430.8913821723645;5490.286262785842;5537.667739935607;5539.169124631308;5588.161775733642;5023.146065168921;5040.521150490697;5051.469595692454;5066.518680725325;5102.413222479407;4933.038057578774;5096.108181068316;5099.872503187431;5143.408508021569;5176.301199338079;4874.634402419815;4974.054929563371;4980.7011579305;4997.100521906055;5018.372703412074;5021.246812978046;5056.595472362203;5058.4435712071645;5068.18908974566;5119.283300337956;4889.951100489021;5015.5736762375245;5024.246363045536;5029.5221953914315;5051.772670229849;5248.0553500369915;5262.684238945637;5318.920216196721;5343.706096164709;5368.597355198337;5967.7911273105665;5970.925233457976;5972.940270597282;5977.820665380045;5978.790742323998;5810.970945145289;5943.702814859283;5999.340072592011;6000.099985002241;6011.038233882601;5472.616916815825;5531.695756733378;5535.916961245584;5542.39033706292;5585.441455854382;6030.155778191057;6044.093385992136;6046.2139921809885;6049.727762250709;6095.451409373178;5773.220615216892;5794.652320860761;5858.2677165354335;5861.267341582302;5925.170476133345;5824.708764561755;5839;5914.260717410324;5914.290285165807;5936.5250779937505;5899.7050147492455;5955;5956.55325850563;5959.821205363846;5966.76132954677;5766.654000759968;5939.881202375928;5942.019566771434;5947.37552556984;5952.166696662471;4509.864704058883;4545.204589196877;4568.17772800899;4577.5193604671695;4596.839110631178;4043.4137050128156;4060.6548443382644;4075.694322925792;4114.321137012359;4120.91758164841;5361.383440904268;5622.775088996476;5628.465295796893;5635.492805647429;5635.6618602883955;5812.738426770806;5839.357670656224;5873.148393482921;5917;5948.762049517971;5625.296837895263;5625.54995600351;5627.971860140673;5641.097424412074;5666;5011.6241281904;5159.535641792257;5161.27742116104;5163.948360516422;5214.895702085937;6103.816885493442;6120.877582448326;6138.9386106140155;6139.140520327158;6158.0147176451555;6000.279966403885;6001.819945401645;6003.969980150071;6010.278766548042;6014.789482368096;5933.169356290209;6169.105479705508;6171.290301615192;6171.444569988723;6180.47465965398;5784.94215057844;5865.472107510344;5869.4717475427415;5870.765169393177;5874.148248503858;5918.940810592011;5960.433758792908;5962.940370596412;5963.552733544915;5969.3732158122775;5801.622894511843;5809.564282678732;5811.622244554091;5916.290045194604;5936.1095835625;5819.738111784895;5864.853378665397;5867.882642347044;5887.352391236875;5913.970430147821;5727.083666613322;5738.598298119258;5739.2252045973255;5740.856478588069;5740.942590574208;5677.5457963362005;5808.448197421239;5866.442687944638;5880.294364676266;5880.8235752927485;5673.659580425187;5721.599488035798;5728.713564321684;5732.828015159552;5770.451807078321 04:17:44 INFO - 2015-11-26 04:17:44,499 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.2635803703362;590.9409059094091;597.6085663890152;599.8230521996013;607.3198018219595;30701.692983070163;31197.220069498275;31407;39407;39768.60231397685;42013.57986420135;42163;42255.78872105635;42269.36595951063;42532.36201456981;8745.518996455177;8919.018907920123;8921.10788921106;8923.643054277822;8924.643014279454;7768.7669369918995;7956.124826269135;10572.524236409341;10861.67414977552;10885.129189664847;10555.472226388689;10658.626948056819;10660.520276587573;10664.093552048085;10670.30643008202;7771.145174030852;7954.085280192794;10363.430011349374;10456.843147352796;10478.79042419155;10576.418296993663;10892.346459212473;10909.563617455293;10911.672649820519;10918.07196388308;38995.805020975;39298;39397.212055758726;39420;39461;3261.266215101607;3265.4938484534937;3272.787268827519;3275.197576593726;3292.3250733599552;30010;30262.96853211066;30513.847430762704;30788.538171927437;31233.219169520715;3765.9435108473394;3783.2244389900006;3809.771413715186;3876.5154355705536;3903.7860764963125;271489;271854;271960;272617;273626;57530.137047944314;57562.7121864388;57934;58210.417895821345;58250.70874645685;54304.72847635736;54861;61399;61629.691851540454;68208.6589567059;15719.292631831595;15765.605859853595;15789;15834.28745706446;15839.128847913475;12097.818532722016;12119.272843629411;12142.635720928387;12166.45250963691;12176.512939482498;19379.80620193808;19425;19480.220791168478;19497.927613981366;19515.902420487808;7490.625468726542;7703.768886933401;7781.338586220121;7813.570253636105;7881.369490440751;957.5738796235747;975.4586204656483;990.6384169777979;1031.3708637730979;1111.8443417921496;28206.85896570504;28263;28419.289517762223;28583.428331433253;28783.71216287852;1040.78143589847;1057.962971296001;1085.8099832529276;1141.4578075414113;1157.65270418874;14529.927350363392;14617.415303387957;14736.705265894836;14977.251137443302;15003;314101;315178;317829;318490;318519;50851.491485084676;51218.23172652413;51252.48747512477;51295.48704512982;51366;1364.36557000995;1365.9453621855014;1367.1660287224984;1371.2184055088703;1372.1424109931293;27214.72785272122;28025.159245222676;28313.867445301956;28334.85832570824;29093;43065.56934430741;43891.56108438875;47885;48304.7584762074;48467.5153248463;212711;213292;214191;214564;214751;28550.42899142047;28868.566971495864;28894.42211155723;28921.85539072291;28929.56605650875;33180.50229246612;34321.828390858886;38875;42388;42670.35994460148;32866.83566582152;33095;33133.17167070843;33193.502097468074;33928;33237.66762332442;33482.49776253407;35259.294814103065;35571.288574228885;36150.63849361473;35466.64533354736;35691.28617427689;35964.28071438609;36012.27975440424;36258.00580968072;30975.845120775153;31800.5229921556;32299.677003229666;32343;32364.83817580897;23371.41571460659;23408.88295558511;23653.52692946166;23734.52530949406;24798.752012480367 04:17:44 INFO - 2015-11-26 04:17:44,500 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.64308227149434;357.1802712774183;357.9212573233888;359.7284050541841;360.9927801443971;13574.321283935813;13952.162870227794;16340.509784706463;16581.917090414547;17220.22508987097;15671.373145074213;15682.215889205523;16148.465895739915;16159.91920040401;16160.191990400492;4921.778519966601;4978.228374601942;4987.251912213161;4987.800487980477;4990.226514890198;3911.5697273300057;4027.174429242013;5371.086915224421;5775.884482310351;5911.261092363455;5933.080372542263;5963.045912653976;5966.8806623867495;5997.6701281429505;6012.639241645494;5821.330546987108;5967.671778052206;5969.731362088716;5974.193483879664;5974.731137098841;5178.870528236825;5240.397354304266;5263.815766448194;5268.9736551317;5277.3139491866195;19921.701174482394;19928.90035549813;20030.799692003184;20268.29060982873;20431.4892127698;2312.410335364488;2347.190219374313;2415.541047201044;2425.2360506440414;2437.768412000857;8984.685536006209;9396.67111651089;13085.934570327088;13125.540606078837;13593.32033398336;1827.1047186878466;1842.456475339778;1855.7216417537343;1875.7936626971023;1878.2956391353243;57388.42611573872;59919.70040149815;60073;61440;62907;10114.949425252827;10125.949370253102;10145.28982971185;10181.898181018243;10231.641892533875;13377.130486518345;13407.061505694508;13420.328983550784;13442.193468391928;13447.125936814076;7367.5211111277595;7435.293647103516;7470.738524151629;7487.887681684779;7573.886391704129;7167.820804479826;7170.318819712119;7219.422446204291;7223.530470519399;7251.637418129178;4296.5273819879785;4337.587929146726;4365.80353884076;4368.497622773421;4417.668674849399;1714.1943286655253;1735.4273089880562;1764.3207365164503;1775.0769599808027;1795.1024487756122;955.9617615295449;994.0953732103895;996.3772642098688;1001.0040010189907;1030.9639162629271;13660.726785464236;15052.849471505146;15234.390624375123;15644.217789110498;15996.440124595583;949.9335046546676;954.627695198873;955.4840386191379;1000.1548691355792;1027.3271007490107;8970.686025989058;9256.814863702688;9292.256619470427;9308;9407.400741873898;515242;518778;524447;531632;531994;68803.31196687969;70354;71650.28349716436;74255;76887.231127688;1136.1138312116561;1150.9251898626562;1156.9652910412701;1182.5920057580122;1185.359905650956;14498.855011450172;14816.555503334917;14889.798693280996;14957.850421495647;15138;35391.469127962584;35413.64586354104;35465.645343547265;35520.11199720028;35581.64418355887;45663.54336456593;48725.75637121792;48747.5125248743;48929.2660610084;51045;9452.621895124117;9541.236701063759;9663.565139568876;9730.854037189307;9767.609295628095;17054.403095891583;17122.14389280506;17649.470515884543;17654.911725441805;17854.464366069038;14479.420823166955;14598.854011459749;14801.259937003322;14803.851961480248;14936.402543898123;13372.732545348845;13902.652433689238;14197;14370.137791732112;14554.854451455774;11612.245204061708;11828.17202795796;13956.79064814049;13961.511347102803;14170.14979101216;9311.813763724824;9426.293028022788;9468.857967130361;9585.712428627152;9589.760255993657;10275;13482.32588370558;13866.514671986431;14137.43450261978;14159.292035398395 04:17:44 INFO - 2015-11-26 04:17:44,500 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1558.0418042903618;1674.7069262878995;1728.03230191093;1749.0380290840035;1779.8220177982196;6926.930730692691;7651.234876512346;7812.687492500308;7896.565688887109;7898.842023159534;7621.314081732643;7890.092639346477;7897.763067107981;7901.446898717078;7904.723334683287;1933.4876257791627;1978.5647157625299;2166.729158855143;2223.6219842626792;2270.648049552322;2229.375774783055;2235.21767381416;2237.7762223777654;2241.047554789216;2242.0471299697647;2183.6178668732987;2251.9437014074615;2255.9887200563976;2256.187772401934;2256.26671331817;1927.2194761121698;1973.1614064022804;2101.8949052547387;2150.161437039556;2152.6770984352315;2195.067096483988;2241.6301310283784;2259.6158653029024;2269.273832373641;2271.7501074881748;7585.886211706828;7745;7753.8449231015065;7755.689772409097;7767.300942915164;4674.789634466457;4746.050789842046;4749.905001899942;4775.928361074587;4791.904161916777;2898.594196812427;2971.4205729882683;3004.6094007778847;3032.2116249774995;3048.9542656860167;964.1274646444979;973.7662960889406;973.8295798235351;981.5288661442477;1019.1490105761698;10884.564617415293;10925.945370273097;10970.725731856688;11003.724906877313;11017.614383496619;4166.416701661769;4217.34631132175;4257.169851878916;4308.310670292738;4313.503947046067;9205.355625106313;9231.307651926132;9231.35380523357;9241.953790231006;9247.537623118817;4759.595434388047;4760.64295177863;4760.690555113906;4762.095201911626;4764.737939413296;4281.529031806499;4313.0726893718;4316.978415107905;4330.978345108254;4331.242032644274;3608.1160115771804;3641.4901913732097;3660.6888414484533;3666.9816650916573;3700.7409481336585;1145.5360578965533;1149.0864762513822;1156.70504021474;1157.062779148892;1157.5080590749067;957.7749228931195;1254.3602762591145;1261.9305938173488;1278;1290.541857640543;6784.59292442455;7280.162781280114;7523.3229009389415;7532.736354227576;7549.433792465587;573.180352096506;581.3575998521573;581.979630712923;605.7758629307184;611.1779656362186;5733.168690539848;5775.191473193672;5826.096954971986;5836;5846.093855452412;8919.331050171264;8936.41913275635;9053.68312109073;9070.27437804974;9072.364934454657;8916.598753056129;8995.640174393082;8997.505137217517;9012.774680632905;9024.142706442877;6918.688659010357;7087.468439866928;7165.534240274365;7177;7219.783406497709;6905.792826215222;6959.26927672587;6994.965025174842;6996.265392133956;7006.054182685476;7902.644381002754;7905.920940790518;7907.5255484668805;8079.394045446733;8097.433179677366;8367.456115352483;8387.748367548984;8403.327733781161;8407.831843363221;8409.117042710672;6722.19333679942;6923.653817309215;6925.445964322943;6926.965365173343;6930.341617546325;7637.541747495168;7652.311291983749;7668.57822819728;7671.616419178907;7672.309492145734;7024.754133605299;7031.613261270474;7179.353858152791;7247.275272472711;7309.634518274172;6896.0359012715035;6973.302669732986;6992.26581208986;7016.859662806817;7048.647567621701;6271.811845644638;6603.735850565923;7076.752313668997;7151.42788576923;7170.96414517924;6454.354564543508;6532.902006469812;6602.40578347951;6602.900956485752;6607.405333520006;6632.701528431328;6682.3317668232785;6726.764563240263;6727.529072965041;6732.730690772314 04:17:44 INFO - 2015-11-26 04:17:44,501 DEBUG : BROWSER_OUTPUT: |4;prototype.html;337.39269315232593;344.9275652113056;347.58116469654067;348.66528132992335;352.4695333523049;5826.242588463494;5898.764049438023;5937.079752638342;6028.819135425939;6036.607620504664;5761.4814666679995;5869.7358618862145;5905.055191169414;5910.734016969236;5938.910916336258;4599.678022538407;4607.562281583261;4618.745968971705;4627.976860115695;4629.189891768935;4387.802548885308;4494.9775251123865;4519.9774001129945;4601.861944141681;4602.585767280944;4562.520935301795;4569.977150114245;4589.059242855206;4592.74739889306;4620.283856002325;4609.216433206363;4613.1696294666945;4615.169269531483;4615.353850460938;4618.030213655136;4073.551909289976;4076.0013796619724;4090.1819636072905;4091.079507110906;4091.284025295591;5587.630300199726;5634;5658.745356458928;5659.801906933279;5672.489475947144;5359.088954877641;5359.22291267764;5367.06076436626;5373.946260537384;5384.380796208447;5998.220231369937;6264.561480696353;6278.152449419315;6281.497480201573;6287.96856015717;4370.300751879716;4428.734275943454;4452.777361131963;4480.260756975095;4518.502964673883;6460.515461340418;6462.4183823456115;6530.020496925452;6536.3463653634735;6539.051837483586;4636.814527418933;4637.049404871993;4640.907181856344;4642.514395393442;4643.117807616542;4550.340200670884;4689.648276379286;4694.88262793426;4704.388429504211;4710.317004034464;5351.57187425005;5352.277442545206;5361.624686271924;5368.489993450616;5371.6239863209985;6346.682665866781;6360.681965901686;6375.521835862236;6382.042693595998;6384.553081284358;1649.6205872649357;1666.3334666133644;1669.741190115534;1670.8913920595367;1672.0720000399895;1114.1421105748527;1136.2103338179886;1143.5597295041302;1144.376314908377;1172.0682057764097;6086.330503644595;6106.572539922252;6124.326324104345;6126.326104128542;6137.508999280047;6511.576747511492;6520.510961677798;6534.346565343428;6540.313267106981;6542;5969.641821490724;6087.452129308295;6114.38856114385;6128.908066378919;6130.816075517741;3514.2268700885766;3521.1197200699826;3547.113221694576;3549.627289134604;3550.1479644885558;6714.899276510856;6715.7985260442265;6722.361375669304;6729.5625784323865;6732.427743641747;6652.900206496906;6654.068430419745;6657.23441804189;6658.300878407795;6660.467162626978;6697.497687673346;6837.555558888656;6862.3823855852215;6869.862602747917;6878.105846239957;6372.139761132188;6450.741970321134;6531.771388001397;6631.0716499689115;6644.966775166286;6532.183477065367;6532.5753826001155;6554.80335589933;6567.277599464151;6573.244076931214;6826.726930922906;6835.487338449736;6839.658017099225;6850.451963842781;6855.108835851307;4379.759113248802;4479.731216127043;4488.102379524043;4496.685232033857;4515.300128480091;6525.184351956005;6535.44448721864;6554.606723596599;6554.705038273384;6556.0493728410065;6372.044193371032;6381.106645069601;6382.457491113308;6384.297727249906;6387;6207.099970504161;6365.077063825626;6374;6422.710978005907;6426.646534440651;6298.685065746603;6305.1172835803945;6307.621542707452;6309.842253943688;6317.6209427434505;6448.516361272829;6451.548391612542;6455.225372955088;6467.191601049869;6471.805845824632;6141.07883817431;6290.119383286435;6291.811245662638;6297;6299.748010079546 04:17:44 INFO - 2015-11-26 04:17:44,502 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.2218725963219;731.8682637125322;735.6763024269321;850.0564373545368;868.5223127279996;12020;12282.201656892295;12358.50565977362;12360.381980900964;12370.505179792808;11173.441327933611;11284.492197851096;11285.492152853121;11289.717757056078;11291.830622540669;674.0933444517117;680.4998326230217;813.2071230550225;824.0482243009334;827.7599496146111;810.5703976892256;818.9344852411792;823.5429336718119;823.6869989404018;825.4263287015526;867.1545243387678;874.711345256064;876.6449587916871;876.8334016536837;877.4866702978765;714.6391072508402;724.8115489972593;847.5931552854603;865.6580650642961;866.2506931504266;634.0425956805258;635.9713812878432;636.1825054804553;637.4613451633362;637.4804534304527;11524.942375288154;11675.591354302644;11745.647630571097;11750.471228794724;11763.7059073523;11642.301461912313;11836.526538938431;11909.94045029778;12263.202891812003;12281.324527151093;10153.4923253837;10225.335353202017;10235.744106397326;10293.297202518585;10356.585736570603;3567.6432356764376;3571.339302229096;3602.7117830573493;3638.381475149231;3711.925761484782;46618.30072548881;47037;47222.76388618069;47302.29046564304;47418.2887256688;9741.977092405337;9790.5594248259;9839.458829764288;10017.098461138386;10350.637727679496;16089.758653620205;16139.35442582307;16144.192790360436;16228.269727862275;16228.83771162297;7430.628468576658;7445.218252083561;7565.659545320474;7692.0384951881015;7696;4357.520672725997;4401.559844015573;4423.159599676052;4458.509563947963;4659.161350956861;3006.3085490336907;3055.7402620777484;3062.0354588304613;3066.1874603229717;3068.4016616759964;539.8029719152481;546.6747285365201;554.1964151979646;558.2937583956299;559.4685049203273;513.4275283059362;591.7396345607918;601.224420497562;610.1061944251604;610.7373829253464;8060.516369017878;8287;8422.789430264293;8475.406721529556;8485.236328730443;467.8830292426893;568.3378863623832;580.0950517193107;656.1404560026381;675.5541342713785;4210.263203939298;4222.345536441856;4232.91534169321;4296.818663311479;4369.148016136823;50646.493535064175;54801.725991370586;54919.725401372736;55143.448565513834;55168.724156379765;44113.77943110264;44435.333469997975;44486.332705008805;44495.55504444914;44604.330935036;43753.124937501074;44147.558524414984;44782.32826507605;46896.29655555169;47001.5299847004;8339.583020849055;8395.412321137706;8677.132286771524;8814.33892458081;8952.820943581222;32206.35587288288;33601;34065.48901766525;35796.284074318886;35865.1033724159;41158.588414115475;41789.58210417857;43593.78203108964;45513.544864552256;45838.77080614575;8541.871871921801;9938;10020.34867733595;10171.54228059754;10886.945565272123;11670.358130302575;11815.76899283589;12007.519699211934;12009.860181036005;12268.570600029314;10189.388636681526;10310.4223944014;10386.636467723594;10603.46982650849;11069.5572177112;10393.503189153416;10605.25763196569;10736.83894741564;10917.836232456679;11203.495842686936;9817.754556136153;10018.849717254392;10117.696469105938;10397.16822654201;10421.791564168825;9215.216706580015;9259.398139120936;9264.212541934012;9440.008799075998;9847.704568862946;8460.280876125353;8768.342374321825;9211.355205135576;9282.953585232031;9305.906940930774 04:17:44 INFO - 2015-11-26 04:17:44,502 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:17:44 INFO - 2015-11-26 04:17:44,502 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1747 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1448540264494__endTimestamp 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5509.04 Median:5739.23 stddev:620.13 (10.8%) stddev-sans-first:594.83 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: Values: 3193.4 3253.3 3281.1 3286.8 3312.5 5322.1 5450.9 5480.3 5526.8 5550.9 5430.9 5490.3 5537.7 5539.2 5588.2 5023.1 5040.5 5051.5 5066.5 5102.4 4933.0 5096.1 5099.9 5143.4 5176.3 4874.6 4974.1 4980.7 4997.1 5018.4 5021.2 5056.6 5058.4 5068.2 5119.3 4890.0 5015.6 5024.2 5029.5 5051.8 5248.1 5262.7 5318.9 5343.7 5368.6 5967.8 5970.9 5972.9 5977.8 5978.8 5811.0 5943.7 5999.3 6000.1 6011.0 5472.6 5531.7 5535.9 5542.4 5585.4 6030.2 6044.1 6046.2 6049.7 6095.5 5773.2 5794.7 5858.3 5861.3 5925.2 5824.7 5839.0 5914.3 5914.3 5936.5 5899.7 5955.0 5956.6 5959.8 5966.8 5766.7 5939.9 5942.0 5947.4 5952.2 4509.9 4545.2 4568.2 4577.5 4596.8 4043.4 4060.7 4075.7 4114.3 4120.9 5361.4 5622.8 5628.5 5635.5 5635.7 5812.7 5839.4 5873.1 5917.0 5948.8 5625.3 5625.5 5628.0 5641.1 5666.0 5011.6 5159.5 5161.3 5163.9 5214.9 6103.8 6120.9 6138.9 6139.1 6158.0 6000.3 6001.8 6004.0 6010.3 6014.8 5933.2 6169.1 6171.3 6171.4 6180.5 5784.9 5865.5 5869.5 5870.8 5874.1 5918.9 5960.4 5962.9 5963.6 5969.4 5801.6 5809.6 5811.6 5916.3 5936.1 5819.7 5864.9 5867.9 5887.4 5914.0 5727.1 5738.6 5739.2 5740.9 5740.9 5677.5 5808.4 5866.4 5880.3 5880.8 5673.7 5721.6 5728.7 5732.8 5770.5 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43860.54 Median:175145.26 stddev:70700.72 (40.4%) stddev-sans-first:70824.25 04:17:44 INFO - 2015-11-26 04:17:44,503 DEBUG : BROWSER_OUTPUT: Values: 543.3 590.9 597.6 599.8 607.3 30701.7 31197.2 31407.0 39407.0 39768.6 42013.6 42163.0 42255.8 42269.4 42532.4 8745.5 8919.0 8921.1 8923.6 8924.6 7768.8 7956.1 10572.5 10861.7 10885.1 10555.5 10658.6 10660.5 10664.1 10670.3 7771.1 7954.1 10363.4 10456.8 10478.8 10576.4 10892.3 10909.6 10911.7 10918.1 38995.8 39298.0 39397.2 39420.0 39461.0 3261.3 3265.5 3272.8 3275.2 3292.3 30010.0 30263.0 30513.8 30788.5 31233.2 3765.9 3783.2 3809.8 3876.5 3903.8 271489.0 271854.0 271960.0 272617.0 273626.0 57530.1 57562.7 57934.0 58210.4 58250.7 54304.7 54861.0 61399.0 61629.7 68208.7 15719.3 15765.6 15789.0 15834.3 15839.1 12097.8 12119.3 12142.6 12166.5 12176.5 19379.8 19425.0 19480.2 19497.9 19515.9 7490.6 7703.8 7781.3 7813.6 7881.4 957.6 975.5 990.6 1031.4 1111.8 28206.9 28263.0 28419.3 28583.4 28783.7 1040.8 1058.0 1085.8 1141.5 1157.7 14529.9 14617.4 14736.7 14977.3 15003.0 314101.0 315178.0 317829.0 318490.0 318519.0 50851.5 51218.2 51252.5 51295.5 51366.0 1364.4 1365.9 1367.2 1371.2 1372.1 27214.7 28025.2 28313.9 28334.9 29093.0 43065.6 43891.6 47885.0 48304.8 48467.5 212711.0 213292.0 214191.0 214564.0 214751.0 28550.4 28868.6 28894.4 28921.9 28929.6 33180.5 34321.8 38875.0 42388.0 42670.4 32866.8 33095.0 33133.2 33193.5 33928.0 33237.7 33482.5 35259.3 35571.3 36150.6 35466.6 35691.3 35964.3 36012.3 36258.0 30975.8 31800.5 32299.7 32343.0 32364.8 23371.4 23408.9 23653.5 23734.5 24798.8 04:17:44 INFO - 2015-11-26 04:17:44,504 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,504 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28184.25 Median:35492.88 stddev:85611.04 (241.2%) stddev-sans-first:85825.69 04:17:44 INFO - 2015-11-26 04:17:44,505 DEBUG : BROWSER_OUTPUT: Values: 351.6 357.2 357.9 359.7 361.0 13574.3 13952.2 16340.5 16581.9 17220.2 15671.4 15682.2 16148.5 16159.9 16160.2 4921.8 4978.2 4987.3 4987.8 4990.2 3911.6 4027.2 5371.1 5775.9 5911.3 5933.1 5963.0 5966.9 5997.7 6012.6 5821.3 5967.7 5969.7 5974.2 5974.7 5178.9 5240.4 5263.8 5269.0 5277.3 19921.7 19928.9 20030.8 20268.3 20431.5 2312.4 2347.2 2415.5 2425.2 2437.8 8984.7 9396.7 13085.9 13125.5 13593.3 1827.1 1842.5 1855.7 1875.8 1878.3 57388.4 59919.7 60073.0 61440.0 62907.0 10114.9 10125.9 10145.3 10181.9 10231.6 13377.1 13407.1 13420.3 13442.2 13447.1 7367.5 7435.3 7470.7 7487.9 7573.9 7167.8 7170.3 7219.4 7223.5 7251.6 4296.5 4337.6 4365.8 4368.5 4417.7 1714.2 1735.4 1764.3 1775.1 1795.1 956.0 994.1 996.4 1001.0 1031.0 13660.7 15052.8 15234.4 15644.2 15996.4 949.9 954.6 955.5 1000.2 1027.3 8970.7 9256.8 9292.3 9308.0 9407.4 515242.0 518778.0 524447.0 531632.0 531994.0 68803.3 70354.0 71650.3 74255.0 76887.2 1136.1 1150.9 1157.0 1182.6 1185.4 14498.9 14816.6 14889.8 14957.9 15138.0 35391.5 35413.6 35465.6 35520.1 35581.6 45663.5 48725.8 48747.5 48929.3 51045.0 9452.6 9541.2 9663.6 9730.9 9767.6 17054.4 17122.1 17649.5 17654.9 17854.5 14479.4 14598.9 14801.3 14803.9 14936.4 13372.7 13902.7 14197.0 14370.1 14554.9 11612.2 11828.2 13956.8 13961.5 14170.1 9311.8 9426.3 9468.9 9585.7 9589.8 10275.0 13482.3 13866.5 14137.4 14159.3 04:17:44 INFO - 2015-11-26 04:17:44,505 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,505 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5418.15 Median:6605.57 stddev:2833.13 (42.9%) stddev-sans-first:2826.23 04:17:44 INFO - 2015-11-26 04:17:44,506 DEBUG : BROWSER_OUTPUT: Values: 1558.0 1674.7 1728.0 1749.0 1779.8 6926.9 7651.2 7812.7 7896.6 7898.8 7621.3 7890.1 7897.8 7901.4 7904.7 1933.5 1978.6 2166.7 2223.6 2270.6 2229.4 2235.2 2237.8 2241.0 2242.0 2183.6 2251.9 2256.0 2256.2 2256.3 1927.2 1973.2 2101.9 2150.2 2152.7 2195.1 2241.6 2259.6 2269.3 2271.8 7585.9 7745.0 7753.8 7755.7 7767.3 4674.8 4746.1 4749.9 4775.9 4791.9 2898.6 2971.4 3004.6 3032.2 3049.0 964.1 973.8 973.8 981.5 1019.1 10884.6 10925.9 10970.7 11003.7 11017.6 4166.4 4217.3 4257.2 4308.3 4313.5 9205.4 9231.3 9231.4 9242.0 9247.5 4759.6 4760.6 4760.7 4762.1 4764.7 4281.5 4313.1 4317.0 4331.0 4331.2 3608.1 3641.5 3660.7 3667.0 3700.7 1145.5 1149.1 1156.7 1157.1 1157.5 957.8 1254.4 1261.9 1278.0 1290.5 6784.6 7280.2 7523.3 7532.7 7549.4 573.2 581.4 582.0 605.8 611.2 5733.2 5775.2 5826.1 5836.0 5846.1 8919.3 8936.4 9053.7 9070.3 9072.4 8916.6 8995.6 8997.5 9012.8 9024.1 6918.7 7087.5 7165.5 7177.0 7219.8 6905.8 6959.3 6995.0 6996.3 7006.1 7902.6 7905.9 7907.5 8079.4 8097.4 8367.5 8387.7 8403.3 8407.8 8409.1 6722.2 6923.7 6925.4 6927.0 6930.3 7637.5 7652.3 7668.6 7671.6 7672.3 7024.8 7031.6 7179.4 7247.3 7309.6 6896.0 6973.3 6992.3 7016.9 7048.6 6271.8 6603.7 7076.8 7151.4 7171.0 6454.4 6532.9 6602.4 6602.9 6607.4 6632.7 6682.3 6726.8 6727.5 6732.7 04:17:44 INFO - 2015-11-26 04:17:44,506 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,506 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5328.21 Median:6032.71 stddev:1584.32 (26.3%) stddev-sans-first:1543.84 04:17:44 INFO - 2015-11-26 04:17:44,506 DEBUG : BROWSER_OUTPUT: Values: 337.4 344.9 347.6 348.7 352.5 5826.2 5898.8 5937.1 6028.8 6036.6 5761.5 5869.7 5905.1 5910.7 5938.9 4599.7 4607.6 4618.7 4628.0 4629.2 4387.8 4495.0 4520.0 4601.9 4602.6 4562.5 4570.0 4589.1 4592.7 4620.3 4609.2 4613.2 4615.2 4615.4 4618.0 4073.6 4076.0 4090.2 4091.1 4091.3 5587.6 5634.0 5658.7 5659.8 5672.5 5359.1 5359.2 5367.1 5373.9 5384.4 5998.2 6264.6 6278.2 6281.5 6288.0 4370.3 4428.7 4452.8 4480.3 4518.5 6460.5 6462.4 6530.0 6536.3 6539.1 4636.8 4637.0 4640.9 4642.5 4643.1 4550.3 4689.6 4694.9 4704.4 4710.3 5351.6 5352.3 5361.6 5368.5 5371.6 6346.7 6360.7 6375.5 6382.0 6384.6 1649.6 1666.3 1669.7 1670.9 1672.1 1114.1 1136.2 1143.6 1144.4 1172.1 6086.3 6106.6 6124.3 6126.3 6137.5 6511.6 6520.5 6534.3 6540.3 6542.0 5969.6 6087.5 6114.4 6128.9 6130.8 3514.2 3521.1 3547.1 3549.6 3550.1 6714.9 6715.8 6722.4 6729.6 6732.4 6652.9 6654.1 6657.2 6658.3 6660.5 6697.5 6837.6 6862.4 6869.9 6878.1 6372.1 6450.7 6531.8 6631.1 6645.0 6532.2 6532.6 6554.8 6567.3 6573.2 6826.7 6835.5 6839.7 6850.5 6855.1 4379.8 4479.7 4488.1 4496.7 4515.3 6525.2 6535.4 6554.6 6554.7 6556.0 6372.0 6381.1 6382.5 6384.3 6387.0 6207.1 6365.1 6374.0 6422.7 6426.6 6298.7 6305.1 6307.6 6309.8 6317.6 6448.5 6451.5 6455.2 6467.2 6471.8 6141.1 6290.1 6291.8 6297.0 6299.7 04:17:44 INFO - 2015-11-26 04:17:44,506 DEBUG : BROWSER_OUTPUT: 04:17:44 INFO - 2015-11-26 04:17:44,507 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13070.60 Median:25248.97 stddev:15084.91 (59.7%) stddev-sans-first:15098.74 04:17:44 INFO - 2015-11-26 04:17:44,507 DEBUG : BROWSER_OUTPUT: Values: 727.2 731.9 735.7 850.1 868.5 12020.0 12282.2 12358.5 12360.4 12370.5 11173.4 11284.5 11285.5 11289.7 11291.8 674.1 680.5 813.2 824.0 827.8 810.6 818.9 823.5 823.7 825.4 867.2 874.7 876.6 876.8 877.5 714.6 724.8 847.6 865.7 866.3 634.0 636.0 636.2 637.5 637.5 11524.9 11675.6 11745.6 11750.5 11763.7 11642.3 11836.5 11909.9 12263.2 12281.3 10153.5 10225.3 10235.7 10293.3 10356.6 3567.6 3571.3 3602.7 3638.4 3711.9 46618.3 47037.0 47222.8 47302.3 47418.3 9742.0 9790.6 9839.5 10017.1 10350.6 16089.8 16139.4 16144.2 16228.3 16228.8 7430.6 7445.2 7565.7 7692.0 7696.0 4357.5 4401.6 4423.2 4458.5 4659.2 3006.3 3055.7 3062.0 3066.2 3068.4 539.8 546.7 554.2 558.3 559.5 513.4 591.7 601.2 610.1 610.7 8060.5 8287.0 8422.8 8475.4 8485.2 467.9 568.3 580.1 656.1 675.6 4210.3 4222.3 4232.9 4296.8 4369.1 50646.5 54801.7 54919.7 55143.4 55168.7 44113.8 44435.3 44486.3 44495.6 44604.3 43753.1 44147.6 44782.3 46896.3 47001.5 8339.6 8395.4 8677.1 8814.3 8952.8 32206.4 33601.0 34065.5 35796.3 35865.1 41158.6 41789.6 43593.8 45513.5 45838.8 8541.9 9938.0 10020.3 10171.5 10886.9 11670.4 11815.8 12007.5 12009.9 12268.6 10189.4 10310.4 10386.6 10603.5 11069.6 10393.5 10605.3 10736.8 10917.8 11203.5 9817.8 10018.8 10117.7 10397.2 10421.8 9215.2 9259.4 9264.2 9440.0 9847.7 8460.3 8768.3 9211.4 9283.0 9305.9 04:17:44 INFO - 2015-11-26 04:17:44,507 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:17:44 INFO - 2015-11-26 04:17:44,508 DEBUG : BROWSER_OUTPUT: 04:17:45 INFO - 2015-11-26 04:17:45,177 INFO : Browser exited with error code: 0 04:17:45 INFO - 2015-11-26 04:17:45,198 INFO : Completed test dromaeo_css (00:18:34) 04:17:45 INFO - 2015-11-26 04:17:45,198 INFO : Starting test kraken 04:17:45 INFO - 2015-11-26 04:17:45,198 DEBUG : operating with platform_type : linux_ 04:17:45 INFO - 2015-11-26 04:17:45,199 INFO : Initialising browser for kraken test... 04:17:45 INFO - 2015-11-26 04:17:45,205 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uz_6T/profile http://localhost:51010/getInfo.html 04:17:49 INFO - 2015-11-26 04:17:49,018 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:17:49 INFO - 2015-11-26 04:17:49,019 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:17:49 INFO - 2015-11-26 04:17:49,019 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:17:49 INFO - 2015-11-26 04:17:49,019 DEBUG : BROWSER_OUTPUT: __metrics 04:17:49 INFO - 2015-11-26 04:17:49,096 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:17:50 INFO - 2015-11-26 04:17:50,374 INFO : Browser initialized. 04:17:50 INFO - 2015-11-26 04:17:50,374 INFO : Running cycle 1/1 for kraken test... 04:17:50 INFO - 2015-11-26 04:17:50,374 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uz_6T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:18:02 INFO - 2015-11-26 04:18:02,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 04:18:02 INFO - 2015-11-26 04:18:02,070 DEBUG : BROWSER_OUTPUT: 04:18:04 INFO - 2015-11-26 04:18:04,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51010/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:05 INFO - 2015-11-26 04:18:05,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 175693824 04:18:05 INFO - 2015-11-26 04:18:05,091 DEBUG : BROWSER_OUTPUT: 04:18:07 INFO - 2015-11-26 04:18:07,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51010/tests/kraken/driver.html?testName=audio-dft) 04:18:08 INFO - 2015-11-26 04:18:08,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 165310464 04:18:08 INFO - 2015-11-26 04:18:08,233 DEBUG : BROWSER_OUTPUT: 04:18:11 INFO - 2015-11-26 04:18:11,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51010/tests/kraken/driver.html?testName=audio-fft) 04:18:11 INFO - 2015-11-26 04:18:11,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 151351296 04:18:11 INFO - 2015-11-26 04:18:11,642 DEBUG : BROWSER_OUTPUT: 04:18:13 INFO - 2015-11-26 04:18:13,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51010/tests/kraken/driver.html?testName=audio-oscillator) 04:18:14 INFO - 2015-11-26 04:18:14,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 152993792 04:18:14 INFO - 2015-11-26 04:18:14,180 DEBUG : BROWSER_OUTPUT: 04:18:16 INFO - 2015-11-26 04:18:16,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:16 INFO - 2015-11-26 04:18:16,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 155058176 04:18:16 INFO - 2015-11-26 04:18:16,924 DEBUG : BROWSER_OUTPUT: 04:18:19 INFO - 2015-11-26 04:18:19,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51010/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:20 INFO - 2015-11-26 04:18:20,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 155734016 04:18:20 INFO - 2015-11-26 04:18:20,395 DEBUG : BROWSER_OUTPUT: 04:18:23 INFO - 2015-11-26 04:18:23,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51010/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:24 INFO - 2015-11-26 04:18:24,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 155156480 04:18:24 INFO - 2015-11-26 04:18:24,341 DEBUG : BROWSER_OUTPUT: 04:18:27 INFO - 2015-11-26 04:18:27,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51010/tests/kraken/driver.html?testName=json-parse-financial) 04:18:27 INFO - 2015-11-26 04:18:27,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 156368896 04:18:27 INFO - 2015-11-26 04:18:27,663 DEBUG : BROWSER_OUTPUT: 04:18:29 INFO - 2015-11-26 04:18:29,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:29 INFO - 2015-11-26 04:18:29,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 165584896 04:18:29 INFO - 2015-11-26 04:18:29,764 DEBUG : BROWSER_OUTPUT: 04:18:31 INFO - 2015-11-26 04:18:31,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:32 INFO - 2015-11-26 04:18:32,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 164315136 04:18:32 INFO - 2015-11-26 04:18:32,233 DEBUG : BROWSER_OUTPUT: 04:18:34 INFO - 2015-11-26 04:18:34,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:34 INFO - 2015-11-26 04:18:34,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 170242048 04:18:34 INFO - 2015-11-26 04:18:34,878 DEBUG : BROWSER_OUTPUT: 04:18:37 INFO - 2015-11-26 04:18:37,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:37 INFO - 2015-11-26 04:18:37,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 179204096 04:18:37 INFO - 2015-11-26 04:18:37,914 DEBUG : BROWSER_OUTPUT: 04:18:40 INFO - 2015-11-26 04:18:40,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:41 INFO - 2015-11-26 04:18:41,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 178966528 04:18:41 INFO - 2015-11-26 04:18:41,049 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51010/tests/kraken/driver.html?testName=ai-astar) 04:18:42 INFO - 2015-11-26 04:18:42,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 237109248 04:18:42 INFO - 2015-11-26 04:18:42,923 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,924 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;110;111;109;100;111;110;98 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;148;169;127;152;146;128;163;126 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;162;160;163;163;160;163 04:18:42 INFO - 2015-11-26 04:18:42,925 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;92;93;70;71;71;113;91;71 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;137;92;93;93;140;93;94;138 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;109;109;110;110 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;145;145;145;146;148;146;146;147;145 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;95;96;95;96 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;58;57;57;58;57;66;56;55 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;69;70;70;81;74;70;71;71;70 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;84;85;84;84;84;83;85;85;85 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;135;122;125;122;130;127;124;118;124;122 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;150;149;147;148;149;158;156;147;138 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;66;67;67;66;67;65;67;67 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:18:42 INFO - 2015-11-26 04:18:42,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 04:18:42 INFO - 2015-11-26 04:18:42,927 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:18:42 INFO - 2015-11-26 04:18:42,927 DEBUG : BROWSER_OUTPUT: __startTimestamp1448540322923__endTimestamp 04:18:42 INFO - 2015-11-26 04:18:42,927 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:110.00 stddev:4.72 (4.3%) stddev-sans-first:4.96 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 110.0 111.0 109.0 100.0 111.0 110.0 98.0 04:18:42 INFO - 2015-11-26 04:18:42,928 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.00 stddev:16.39 (10.9%) stddev-sans-first:17.03 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 148.0 169.0 127.0 152.0 146.0 128.0 163.0 126.0 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.40 (0.9%) stddev-sans-first:1.48 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 162.0 160.0 163.0 163.0 160.0 163.0 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:72.00 stddev:14.79 (20.5%) stddev-sans-first:15.27 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 92.0 93.0 70.0 71.0 71.0 113.0 91.0 71.0 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,929 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.78 (23.4%) stddev-sans-first:22.60 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 137.0 92.0 93.0 93.0 140.0 93.0 94.0 138.0 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,930 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 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:1.16 (0.8%) stddev-sans-first:1.05 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: Values: 144.0 145.0 145.0 145.0 146.0 148.0 146.0 146.0 147.0 145.0 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 04:18:42 INFO - 2015-11-26 04:18:42,930 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,931 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:3.00 (5.2%) stddev-sans-first:3.16 04:18:42 INFO - 2015-11-26 04:18:42,931 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 58.0 57.0 57.0 58.0 57.0 66.0 56.0 55.0 04:18:42 INFO - 2015-11-26 04:18:42,931 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,931 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.00 stddev:3.52 (5.0%) stddev-sans-first:3.73 04:18:42 INFO - 2015-11-26 04:18:42,931 DEBUG : BROWSER_OUTPUT: Values: 72.0 69.0 70.0 70.0 81.0 74.0 70.0 71.0 71.0 70.0 04:18:42 INFO - 2015-11-26 04:18:42,932 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,932 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.51 (3.0%) stddev-sans-first:0.71 04:18:42 INFO - 2015-11-26 04:18:42,932 DEBUG : BROWSER_OUTPUT: Values: 92.0 84.0 85.0 84.0 84.0 84.0 83.0 85.0 85.0 85.0 04:18:42 INFO - 2015-11-26 04:18:42,932 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,933 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:124.50 stddev:4.79 (3.9%) stddev-sans-first:3.42 04:18:42 INFO - 2015-11-26 04:18:42,933 DEBUG : BROWSER_OUTPUT: Values: 135.0 122.0 125.0 122.0 130.0 127.0 124.0 118.0 124.0 122.0 04:18:42 INFO - 2015-11-26 04:18:42,933 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.00 stddev:6.43 (4.3%) stddev-sans-first:5.71 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: Values: 138.0 150.0 149.0 147.0 148.0 149.0 158.0 156.0 147.0 138.0 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 67.0 66.0 67.0 65.0 67.0 67.0 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:18:42 INFO - 2015-11-26 04:18:42,934 DEBUG : BROWSER_OUTPUT: 04:18:43 INFO - 2015-11-26 04:18:43,789 INFO : Browser exited with error code: 0 04:18:43 INFO - 2015-11-26 04:18:43,840 INFO : Completed test kraken (00:00:58) 04:18:43 INFO - 2015-11-26 04:18:43,840 INFO : Starting test v8_7 04:18:43 INFO - 2015-11-26 04:18:43,840 DEBUG : operating with platform_type : linux_ 04:18:43 INFO - 2015-11-26 04:18:43,840 INFO : Initialising browser for v8_7 test... 04:18:43 INFO - 2015-11-26 04:18:43,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3xzvXA/profile http://localhost:51010/getInfo.html 04:18:47 INFO - 2015-11-26 04:18:47,601 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:18:47 INFO - 2015-11-26 04:18:47,601 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:18:47 INFO - 2015-11-26 04:18:47,601 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:18:47 INFO - 2015-11-26 04:18:47,601 DEBUG : BROWSER_OUTPUT: __metrics 04:18:47 INFO - 2015-11-26 04:18:47,766 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:48 INFO - 2015-11-26 04:18:48,965 INFO : Browser initialized. 04:18:48 INFO - 2015-11-26 04:18:48,965 INFO : Running cycle 1/1 for v8_7 test... 04:18:48 INFO - 2015-11-26 04:18:48,966 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3xzvXA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:19:00 INFO - 2015-11-26 04:19:00,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 04:19:00 INFO - 2015-11-26 04:19:00,684 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51010/tests/v8_7/run.html (next: http://localhost:51010/tests/v8_7/run.html) 04:19:22 INFO - 2015-11-26 04:19:22,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 542928896 04:19:22 INFO - 2015-11-26 04:19:22,283 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,283 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:19:22 INFO - 2015-11-26 04:19:22,283 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:19:22 INFO - 2015-11-26 04:19:22,284 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:19:22 INFO - 2015-11-26 04:19:22,284 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:19:22 INFO - 2015-11-26 04:19:22,284 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5001665001665 04:19:22 INFO - 2015-11-26 04:19:22,284 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 04:19:22 INFO - 2015-11-26 04:19:22,284 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.6569883290635 04:19:22 INFO - 2015-11-26 04:19:22,285 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 04:19:22 INFO - 2015-11-26 04:19:22,285 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1085.7763300760043 04:19:22 INFO - 2015-11-26 04:19:22,285 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 04:19:22 INFO - 2015-11-26 04:19:22,285 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 04:19:22 INFO - 2015-11-26 04:19:22,285 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 04:19:22 INFO - 2015-11-26 04:19:22,286 DEBUG : BROWSER_OUTPUT: |8;Splay;583.7711617046118 04:19:22 INFO - 2015-11-26 04:19:22,286 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:19:22 INFO - 2015-11-26 04:19:22,286 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:19:22 INFO - 2015-11-26 04:19:22,286 DEBUG : BROWSER_OUTPUT: __startTimestamp1448540362276__endTimestamp 04:19:22 INFO - 2015-11-26 04:19:22,286 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,287 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:19:22 INFO - 2015-11-26 04:19:22,287 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:19:22 INFO - 2015-11-26 04:19:22,287 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,287 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.50 Median:166.50 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,287 DEBUG : BROWSER_OUTPUT: Values: 166.5 04:19:22 INFO - 2015-11-26 04:19:22,288 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,288 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,288 DEBUG : BROWSER_OUTPUT: Values: 194.4 04:19:22 INFO - 2015-11-26 04:19:22,288 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,288 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.66 Median:284.66 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,289 DEBUG : BROWSER_OUTPUT: Values: 284.7 04:19:22 INFO - 2015-11-26 04:19:22,289 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,289 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,289 DEBUG : BROWSER_OUTPUT: Values: 5202.1 04:19:22 INFO - 2015-11-26 04:19:22,289 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,290 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,290 DEBUG : BROWSER_OUTPUT: Values: 1085.8 04:19:22 INFO - 2015-11-26 04:19:22,290 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,290 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,290 DEBUG : BROWSER_OUTPUT: Values: 789.9 04:19:22 INFO - 2015-11-26 04:19:22,291 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,291 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,291 DEBUG : BROWSER_OUTPUT: Values: 12168.7 04:19:22 INFO - 2015-11-26 04:19:22,291 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,291 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,292 DEBUG : BROWSER_OUTPUT: Values: 25846.2 04:19:22 INFO - 2015-11-26 04:19:22,292 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,292 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:583.77 Median:583.77 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,292 DEBUG : BROWSER_OUTPUT: Values: 583.8 04:19:22 INFO - 2015-11-26 04:19:22,292 DEBUG : BROWSER_OUTPUT: 04:19:22 INFO - 2015-11-26 04:19:22,293 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:19:22 INFO - 2015-11-26 04:19:22,293 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:19:22 INFO - 2015-11-26 04:19:22,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:19:22 INFO - 2015-11-26 04:19:22,293 DEBUG : BROWSER_OUTPUT: 04:19:23 INFO - 2015-11-26 04:19:23,137 INFO : Browser exited with error code: 0 04:19:23 INFO - 2015-11-26 04:19:23,152 INFO : Completed test v8_7 (00:00:39) 04:19:23 INFO - 2015-11-26 04:19:23,340 INFO : Completed test suite (00:20:12) 04:19:23 INFO - 2015-11-26 04:19:23,340 DEBUG : Working with test: dromaeo_css 04:19:23 INFO - 2015-11-26 04:19:23,340 DEBUG : Generating results file: dromaeo_css 04:19:23 INFO - 2015-11-26 04:19:23,341 DEBUG : Working with test: kraken 04:19:23 INFO - 2015-11-26 04:19:23,342 DEBUG : Generating results file: kraken 04:19:23 INFO - 2015-11-26 04:19:23,342 INFO : javascript benchmark 04:19:23 INFO - 2015-11-26 04:19:23,342 DEBUG : Working with test: v8_7 04:19:23 INFO - 2015-11-26 04:19:23,342 DEBUG : Generating results file: v8_7 04:19:23 INFO - 2015-11-26 04:19:23,342 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:23 INFO - 2015-11-26 04:19:23,409 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 04:19:23 INFO - 2015-11-26 04:19:23,409 DEBUG : process_Request line: dromaeo_css 6962.23 graph.html#tests=[[72,201,35]] 04:19:23 INFO - 2015-11-26 04:19:23,409 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:23 INFO - 2015-11-26 04:19:23,445 DEBUG : process_Request line: kraken 1505.60 graph.html#tests=[[232,201,35]] 04:19:23 INFO - 2015-11-26 04:19:23,445 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:19:23 INFO - 2015-11-26 04:19:23,486 DEBUG : process_Request line: v8_7 21052.46 graph.html#tests=[[230,201,35]] 04:19:23 INFO - 2015-11-26 04:19:23,488 INFO : javascript benchmark 04:19:23 INFO - 2015-11-26 04:19:23,491 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3193.409219294431, 3253.333066721322, 3281.1305004173896, 3286.819224942627, 3312.5196846457266, 5322.148456247001, 5450.890982180354, 5480.26016487774, 5526.778928842847, 5550.916736248954, 5430.8913821723645, 5490.286262785842, 5537.667739935607, 5539.169124631308, 5588.161775733642, 5023.146065168921, 5040.521150490697, 5051.469595692454, 5066.518680725325, 5102.413222479407, 4933.038057578774, 5096.108181068316, 5099.872503187431, 5143.408508021569, 5176.301199338079, 4874.634402419815, 4974.054929563371, 4980.7011579305, 4997.100521906055, 5018.372703412074, 5021.246812978046, 5056.595472362203, 5058.4435712071645, 5068.18908974566, 5119.283300337956, 4889.951100489021, 5015.5736762375245, 5024.246363045536, 5029.5221953914315, 5051.772670229849, 5248.0553500369915, 5262.684238945637, 5318.920216196721, 5343.706096164709, 5368.597355198337, 5967.7911273105665, 5970.925233457976, 5972.940270597282, 5977.820665380045, 5978.790742323998, 5810.970945145289, 5943.702814859283, 5999.340072592011, 6000.099985002241, 6011.038233882601, 5472.616916815825, 5531.695756733378, 5535.916961245584, 5542.39033706292, 5585.441455854382, 6030.155778191057, 6044.093385992136, 6046.2139921809885, 6049.727762250709, 6095.451409373178, 5773.220615216892, 5794.652320860761, 5858.2677165354335, 5861.267341582302, 5925.170476133345, 5824.708764561755, 5839.0, 5914.260717410324, 5914.290285165807, 5936.5250779937505, 5899.7050147492455, 5955.0, 5956.55325850563, 5959.821205363846, 5966.76132954677, 5766.654000759968, 5939.881202375928, 5942.019566771434, 5947.37552556984, 5952.166696662471, 4509.864704058883, 4545.204589196877, 4568.17772800899, 4577.5193604671695, 4596.839110631178, 4043.4137050128156, 4060.6548443382644, 4075.694322925792, 4114.321137012359, 4120.91758164841, 5361.383440904268, 5622.775088996476, 5628.465295796893, 5635.492805647429, 5635.6618602883955, 5812.738426770806, 5839.357670656224, 5873.148393482921, 5917.0, 5948.762049517971, 5625.296837895263, 5625.54995600351, 5627.971860140673, 5641.097424412074, 5666.0, 5011.6241281904, 5159.535641792257, 5161.27742116104, 5163.948360516422, 5214.895702085937, 6103.816885493442, 6120.877582448326, 6138.9386106140155, 6139.140520327158, 6158.0147176451555, 6000.279966403885, 6001.819945401645, 6003.969980150071, 6010.278766548042, 6014.789482368096, 5933.169356290209, 6169.105479705508, 6171.290301615192, 6171.444569988723, 6180.47465965398, 5784.94215057844, 5865.472107510344, 5869.4717475427415, 5870.765169393177, 5874.148248503858, 5918.940810592011, 5960.433758792908, 5962.940370596412, 5963.552733544915, 5969.3732158122775, 5801.622894511843, 5809.564282678732, 5811.622244554091, 5916.290045194604, 5936.1095835625, 5819.738111784895, 5864.853378665397, 5867.882642347044, 5887.352391236875, 5913.970430147821, 5727.083666613322, 5738.598298119258, 5739.2252045973255, 5740.856478588069, 5740.942590574208, 5677.5457963362005, 5808.448197421239, 5866.442687944638, 5880.294364676266, 5880.8235752927485, 5673.659580425187, 5721.599488035798, 5728.713564321684, 5732.828015159552, 5770.451807078321], "unit": "ms", "name": "dojo.html", "value": 5468.008594427316}, {"lowerIsBetter": false, "replicates": [543.2635803703362, 590.9409059094091, 597.6085663890152, 599.8230521996013, 607.3198018219595, 30701.692983070163, 31197.220069498275, 31407.0, 39407.0, 39768.60231397685, 42013.57986420135, 42163.0, 42255.78872105635, 42269.36595951063, 42532.36201456981, 8745.518996455177, 8919.018907920123, 8921.10788921106, 8923.643054277822, 8924.643014279454, 7768.7669369918995, 7956.124826269135, 10572.524236409341, 10861.67414977552, 10885.129189664847, 10555.472226388689, 10658.626948056819, 10660.520276587573, 10664.093552048085, 10670.30643008202, 7771.145174030852, 7954.085280192794, 10363.430011349374, 10456.843147352796, 10478.79042419155, 10576.418296993663, 10892.346459212473, 10909.563617455293, 10911.672649820519, 10918.07196388308, 38995.805020975, 39298.0, 39397.212055758726, 39420.0, 39461.0, 3261.266215101607, 3265.4938484534937, 3272.787268827519, 3275.197576593726, 3292.3250733599552, 30010.0, 30262.96853211066, 30513.847430762704, 30788.538171927437, 31233.219169520715, 3765.9435108473394, 3783.2244389900006, 3809.771413715186, 3876.5154355705536, 3903.7860764963125, 271489.0, 271854.0, 271960.0, 272617.0, 273626.0, 57530.137047944314, 57562.7121864388, 57934.0, 58210.417895821345, 58250.70874645685, 54304.72847635736, 54861.0, 61399.0, 61629.691851540454, 68208.6589567059, 15719.292631831595, 15765.605859853595, 15789.0, 15834.28745706446, 15839.128847913475, 12097.818532722016, 12119.272843629411, 12142.635720928387, 12166.45250963691, 12176.512939482498, 19379.80620193808, 19425.0, 19480.220791168478, 19497.927613981366, 19515.902420487808, 7490.625468726542, 7703.768886933401, 7781.338586220121, 7813.570253636105, 7881.369490440751, 957.5738796235747, 975.4586204656483, 990.6384169777979, 1031.3708637730979, 1111.8443417921496, 28206.85896570504, 28263.0, 28419.289517762223, 28583.428331433253, 28783.71216287852, 1040.78143589847, 1057.962971296001, 1085.8099832529276, 1141.4578075414113, 1157.65270418874, 14529.927350363392, 14617.415303387957, 14736.705265894836, 14977.251137443302, 15003.0, 314101.0, 315178.0, 317829.0, 318490.0, 318519.0, 50851.491485084676, 51218.23172652413, 51252.48747512477, 51295.48704512982, 51366.0, 1364.36557000995, 1365.9453621855014, 1367.1660287224984, 1371.2184055088703, 1372.1424109931293, 27214.72785272122, 28025.159245222676, 28313.867445301956, 28334.85832570824, 29093.0, 43065.56934430741, 43891.56108438875, 47885.0, 48304.7584762074, 48467.5153248463, 212711.0, 213292.0, 214191.0, 214564.0, 214751.0, 28550.42899142047, 28868.566971495864, 28894.42211155723, 28921.85539072291, 28929.56605650875, 33180.50229246612, 34321.828390858886, 38875.0, 42388.0, 42670.35994460148, 32866.83566582152, 33095.0, 33133.17167070843, 33193.502097468074, 33928.0, 33237.66762332442, 33482.49776253407, 35259.294814103065, 35571.288574228885, 36150.63849361473, 35466.64533354736, 35691.28617427689, 35964.28071438609, 36012.27975440424, 36258.00580968072, 30975.845120775153, 31800.5229921556, 32299.677003229666, 32343.0, 32364.83817580897, 23371.41571460659, 23408.88295558511, 23653.52692946166, 23734.52530949406, 24798.752012480367], "unit": "ms", "name": "ext.html", "value": 18383.031950693487}, {"lowerIsBetter": false, "replicates": [351.64308227149434, 357.1802712774183, 357.9212573233888, 359.7284050541841, 360.9927801443971, 13574.321283935813, 13952.162870227794, 16340.509784706463, 16581.917090414547, 17220.22508987097, 15671.373145074213, 15682.215889205523, 16148.465895739915, 16159.91920040401, 16160.191990400492, 4921.778519966601, 4978.228374601942, 4987.251912213161, 4987.800487980477, 4990.226514890198, 3911.5697273300057, 4027.174429242013, 5371.086915224421, 5775.884482310351, 5911.261092363455, 5933.080372542263, 5963.045912653976, 5966.8806623867495, 5997.6701281429505, 6012.639241645494, 5821.330546987108, 5967.671778052206, 5969.731362088716, 5974.193483879664, 5974.731137098841, 5178.870528236825, 5240.397354304266, 5263.815766448194, 5268.9736551317, 5277.3139491866195, 19921.701174482394, 19928.90035549813, 20030.799692003184, 20268.29060982873, 20431.4892127698, 2312.410335364488, 2347.190219374313, 2415.541047201044, 2425.2360506440414, 2437.768412000857, 8984.685536006209, 9396.67111651089, 13085.934570327088, 13125.540606078837, 13593.32033398336, 1827.1047186878466, 1842.456475339778, 1855.7216417537343, 1875.7936626971023, 1878.2956391353243, 57388.42611573872, 59919.70040149815, 60073.0, 61440.0, 62907.0, 10114.949425252827, 10125.949370253102, 10145.28982971185, 10181.898181018243, 10231.641892533875, 13377.130486518345, 13407.061505694508, 13420.328983550784, 13442.193468391928, 13447.125936814076, 7367.5211111277595, 7435.293647103516, 7470.738524151629, 7487.887681684779, 7573.886391704129, 7167.820804479826, 7170.318819712119, 7219.422446204291, 7223.530470519399, 7251.637418129178, 4296.5273819879785, 4337.587929146726, 4365.80353884076, 4368.497622773421, 4417.668674849399, 1714.1943286655253, 1735.4273089880562, 1764.3207365164503, 1775.0769599808027, 1795.1024487756122, 955.9617615295449, 994.0953732103895, 996.3772642098688, 1001.0040010189907, 1030.9639162629271, 13660.726785464236, 15052.849471505146, 15234.390624375123, 15644.217789110498, 15996.440124595583, 949.9335046546676, 954.627695198873, 955.4840386191379, 1000.1548691355792, 1027.3271007490107, 8970.686025989058, 9256.814863702688, 9292.256619470427, 9308.0, 9407.400741873898, 515242.0, 518778.0, 524447.0, 531632.0, 531994.0, 68803.31196687969, 70354.0, 71650.28349716436, 74255.0, 76887.231127688, 1136.1138312116561, 1150.9251898626562, 1156.9652910412701, 1182.5920057580122, 1185.359905650956, 14498.855011450172, 14816.555503334917, 14889.798693280996, 14957.850421495647, 15138.0, 35391.469127962584, 35413.64586354104, 35465.645343547265, 35520.11199720028, 35581.64418355887, 45663.54336456593, 48725.75637121792, 48747.5125248743, 48929.2660610084, 51045.0, 9452.621895124117, 9541.236701063759, 9663.565139568876, 9730.854037189307, 9767.609295628095, 17054.403095891583, 17122.14389280506, 17649.470515884543, 17654.911725441805, 17854.464366069038, 14479.420823166955, 14598.854011459749, 14801.259937003322, 14803.851961480248, 14936.402543898123, 13372.732545348845, 13902.652433689238, 14197.0, 14370.137791732112, 14554.854451455774, 11612.245204061708, 11828.17202795796, 13956.79064814049, 13961.511347102803, 14170.14979101216, 9311.813763724824, 9426.293028022788, 9468.857967130361, 9585.712428627152, 9589.760255993657, 10275.0, 13482.32588370558, 13866.514671986431, 14137.43450261978, 14159.292035398395], "unit": "ms", "name": "jquery.html", "value": 8858.908790671236}, {"lowerIsBetter": false, "replicates": [1558.0418042903618, 1674.7069262878995, 1728.03230191093, 1749.0380290840035, 1779.8220177982196, 6926.930730692691, 7651.234876512346, 7812.687492500308, 7896.565688887109, 7898.842023159534, 7621.314081732643, 7890.092639346477, 7897.763067107981, 7901.446898717078, 7904.723334683287, 1933.4876257791627, 1978.5647157625299, 2166.729158855143, 2223.6219842626792, 2270.648049552322, 2229.375774783055, 2235.21767381416, 2237.7762223777654, 2241.047554789216, 2242.0471299697647, 2183.6178668732987, 2251.9437014074615, 2255.9887200563976, 2256.187772401934, 2256.26671331817, 1927.2194761121698, 1973.1614064022804, 2101.8949052547387, 2150.161437039556, 2152.6770984352315, 2195.067096483988, 2241.6301310283784, 2259.6158653029024, 2269.273832373641, 2271.7501074881748, 7585.886211706828, 7745.0, 7753.8449231015065, 7755.689772409097, 7767.300942915164, 4674.789634466457, 4746.050789842046, 4749.905001899942, 4775.928361074587, 4791.904161916777, 2898.594196812427, 2971.4205729882683, 3004.6094007778847, 3032.2116249774995, 3048.9542656860167, 964.1274646444979, 973.7662960889406, 973.8295798235351, 981.5288661442477, 1019.1490105761698, 10884.564617415293, 10925.945370273097, 10970.725731856688, 11003.724906877313, 11017.614383496619, 4166.416701661769, 4217.34631132175, 4257.169851878916, 4308.310670292738, 4313.503947046067, 9205.355625106313, 9231.307651926132, 9231.35380523357, 9241.953790231006, 9247.537623118817, 4759.595434388047, 4760.64295177863, 4760.690555113906, 4762.095201911626, 4764.737939413296, 4281.529031806499, 4313.0726893718, 4316.978415107905, 4330.978345108254, 4331.242032644274, 3608.1160115771804, 3641.4901913732097, 3660.6888414484533, 3666.9816650916573, 3700.7409481336585, 1145.5360578965533, 1149.0864762513822, 1156.70504021474, 1157.062779148892, 1157.5080590749067, 957.7749228931195, 1254.3602762591145, 1261.9305938173488, 1278.0, 1290.541857640543, 6784.59292442455, 7280.162781280114, 7523.3229009389415, 7532.736354227576, 7549.433792465587, 573.180352096506, 581.3575998521573, 581.979630712923, 605.7758629307184, 611.1779656362186, 5733.168690539848, 5775.191473193672, 5826.096954971986, 5836.0, 5846.093855452412, 8919.331050171264, 8936.41913275635, 9053.68312109073, 9070.27437804974, 9072.364934454657, 8916.598753056129, 8995.640174393082, 8997.505137217517, 9012.774680632905, 9024.142706442877, 6918.688659010357, 7087.468439866928, 7165.534240274365, 7177.0, 7219.783406497709, 6905.792826215222, 6959.26927672587, 6994.965025174842, 6996.265392133956, 7006.054182685476, 7902.644381002754, 7905.920940790518, 7907.5255484668805, 8079.394045446733, 8097.433179677366, 8367.456115352483, 8387.748367548984, 8403.327733781161, 8407.831843363221, 8409.117042710672, 6722.19333679942, 6923.653817309215, 6925.445964322943, 6926.965365173343, 6930.341617546325, 7637.541747495168, 7652.311291983749, 7668.57822819728, 7671.616419178907, 7672.309492145734, 7024.754133605299, 7031.613261270474, 7179.353858152791, 7247.275272472711, 7309.634518274172, 6896.0359012715035, 6973.302669732986, 6992.26581208986, 7016.859662806817, 7048.647567621701, 6271.811845644638, 6603.735850565923, 7076.752313668997, 7151.42788576923, 7170.96414517924, 6454.354564543508, 6532.902006469812, 6602.40578347951, 6602.900956485752, 6607.405333520006, 6632.701528431328, 6682.3317668232785, 6726.764563240263, 6727.529072965041, 6732.730690772314], "unit": "ms", "name": "mootools.html", "value": 4386.506710619684}, {"lowerIsBetter": false, "replicates": [337.39269315232593, 344.9275652113056, 347.58116469654067, 348.66528132992335, 352.4695333523049, 5826.242588463494, 5898.764049438023, 5937.079752638342, 6028.819135425939, 6036.607620504664, 5761.4814666679995, 5869.7358618862145, 5905.055191169414, 5910.734016969236, 5938.910916336258, 4599.678022538407, 4607.562281583261, 4618.745968971705, 4627.976860115695, 4629.189891768935, 4387.802548885308, 4494.9775251123865, 4519.9774001129945, 4601.861944141681, 4602.585767280944, 4562.520935301795, 4569.977150114245, 4589.059242855206, 4592.74739889306, 4620.283856002325, 4609.216433206363, 4613.1696294666945, 4615.169269531483, 4615.353850460938, 4618.030213655136, 4073.551909289976, 4076.0013796619724, 4090.1819636072905, 4091.079507110906, 4091.284025295591, 5587.630300199726, 5634.0, 5658.745356458928, 5659.801906933279, 5672.489475947144, 5359.088954877641, 5359.22291267764, 5367.06076436626, 5373.946260537384, 5384.380796208447, 5998.220231369937, 6264.561480696353, 6278.152449419315, 6281.497480201573, 6287.96856015717, 4370.300751879716, 4428.734275943454, 4452.777361131963, 4480.260756975095, 4518.502964673883, 6460.515461340418, 6462.4183823456115, 6530.020496925452, 6536.3463653634735, 6539.051837483586, 4636.814527418933, 4637.049404871993, 4640.907181856344, 4642.514395393442, 4643.117807616542, 4550.340200670884, 4689.648276379286, 4694.88262793426, 4704.388429504211, 4710.317004034464, 5351.57187425005, 5352.277442545206, 5361.624686271924, 5368.489993450616, 5371.6239863209985, 6346.682665866781, 6360.681965901686, 6375.521835862236, 6382.042693595998, 6384.553081284358, 1649.6205872649357, 1666.3334666133644, 1669.741190115534, 1670.8913920595367, 1672.0720000399895, 1114.1421105748527, 1136.2103338179886, 1143.5597295041302, 1144.376314908377, 1172.0682057764097, 6086.330503644595, 6106.572539922252, 6124.326324104345, 6126.326104128542, 6137.508999280047, 6511.576747511492, 6520.510961677798, 6534.346565343428, 6540.313267106981, 6542.0, 5969.641821490724, 6087.452129308295, 6114.38856114385, 6128.908066378919, 6130.816075517741, 3514.2268700885766, 3521.1197200699826, 3547.113221694576, 3549.627289134604, 3550.1479644885558, 6714.899276510856, 6715.7985260442265, 6722.361375669304, 6729.5625784323865, 6732.427743641747, 6652.900206496906, 6654.068430419745, 6657.23441804189, 6658.300878407795, 6660.467162626978, 6697.497687673346, 6837.555558888656, 6862.3823855852215, 6869.862602747917, 6878.105846239957, 6372.139761132188, 6450.741970321134, 6531.771388001397, 6631.0716499689115, 6644.966775166286, 6532.183477065367, 6532.5753826001155, 6554.80335589933, 6567.277599464151, 6573.244076931214, 6826.726930922906, 6835.487338449736, 6839.658017099225, 6850.451963842781, 6855.108835851307, 4379.759113248802, 4479.731216127043, 4488.102379524043, 4496.685232033857, 4515.300128480091, 6525.184351956005, 6535.44448721864, 6554.606723596599, 6554.705038273384, 6556.0493728410065, 6372.044193371032, 6381.106645069601, 6382.457491113308, 6384.297727249906, 6387.0, 6207.099970504161, 6365.077063825626, 6374.0, 6422.710978005907, 6426.646534440651, 6298.685065746603, 6305.1172835803945, 6307.621542707452, 6309.842253943688, 6317.6209427434505, 6448.516361272829, 6451.548391612542, 6455.225372955088, 6467.191601049869, 6471.805845824632, 6141.07883817431, 6290.119383286435, 6291.811245662638, 6297.0, 6299.748010079546], "unit": "ms", "name": "prototype.html", "value": 4821.022153617706}, {"lowerIsBetter": false, "replicates": [727.2218725963219, 731.8682637125322, 735.6763024269321, 850.0564373545368, 868.5223127279996, 12020.0, 12282.201656892295, 12358.50565977362, 12360.381980900964, 12370.505179792808, 11173.441327933611, 11284.492197851096, 11285.492152853121, 11289.717757056078, 11291.830622540669, 674.0933444517117, 680.4998326230217, 813.2071230550225, 824.0482243009334, 827.7599496146111, 810.5703976892256, 818.9344852411792, 823.5429336718119, 823.6869989404018, 825.4263287015526, 867.1545243387678, 874.711345256064, 876.6449587916871, 876.8334016536837, 877.4866702978765, 714.6391072508402, 724.8115489972593, 847.5931552854603, 865.6580650642961, 866.2506931504266, 634.0425956805258, 635.9713812878432, 636.1825054804553, 637.4613451633362, 637.4804534304527, 11524.942375288154, 11675.591354302644, 11745.647630571097, 11750.471228794724, 11763.7059073523, 11642.301461912313, 11836.526538938431, 11909.94045029778, 12263.202891812003, 12281.324527151093, 10153.4923253837, 10225.335353202017, 10235.744106397326, 10293.297202518585, 10356.585736570603, 3567.6432356764376, 3571.339302229096, 3602.7117830573493, 3638.381475149231, 3711.925761484782, 46618.30072548881, 47037.0, 47222.76388618069, 47302.29046564304, 47418.2887256688, 9741.977092405337, 9790.5594248259, 9839.458829764288, 10017.098461138386, 10350.637727679496, 16089.758653620205, 16139.35442582307, 16144.192790360436, 16228.269727862275, 16228.83771162297, 7430.628468576658, 7445.218252083561, 7565.659545320474, 7692.0384951881015, 7696.0, 4357.520672725997, 4401.559844015573, 4423.159599676052, 4458.509563947963, 4659.161350956861, 3006.3085490336907, 3055.7402620777484, 3062.0354588304613, 3066.1874603229717, 3068.4016616759964, 539.8029719152481, 546.6747285365201, 554.1964151979646, 558.2937583956299, 559.4685049203273, 513.4275283059362, 591.7396345607918, 601.224420497562, 610.1061944251604, 610.7373829253464, 8060.516369017878, 8287.0, 8422.789430264293, 8475.406721529556, 8485.236328730443, 467.8830292426893, 568.3378863623832, 580.0950517193107, 656.1404560026381, 675.5541342713785, 4210.263203939298, 4222.345536441856, 4232.91534169321, 4296.818663311479, 4369.148016136823, 50646.493535064175, 54801.725991370586, 54919.725401372736, 55143.448565513834, 55168.724156379765, 44113.77943110264, 44435.333469997975, 44486.332705008805, 44495.55504444914, 44604.330935036, 43753.124937501074, 44147.558524414984, 44782.32826507605, 46896.29655555169, 47001.5299847004, 8339.583020849055, 8395.412321137706, 8677.132286771524, 8814.33892458081, 8952.820943581222, 32206.35587288288, 33601.0, 34065.48901766525, 35796.284074318886, 35865.1033724159, 41158.588414115475, 41789.58210417857, 43593.78203108964, 45513.544864552256, 45838.77080614575, 8541.871871921801, 9938.0, 10020.34867733595, 10171.54228059754, 10886.945565272123, 11670.358130302575, 11815.76899283589, 12007.519699211934, 12009.860181036005, 12268.570600029314, 10189.388636681526, 10310.4223944014, 10386.636467723594, 10603.46982650849, 11069.5572177112, 10393.503189153416, 10605.25763196569, 10736.83894741564, 10917.836232456679, 11203.495842686936, 9817.754556136153, 10018.849717254392, 10117.696469105938, 10397.16822654201, 10421.791564168825, 9215.216706580015, 9259.398139120936, 9264.212541934012, 9440.008799075998, 9847.704568862946, 8460.280876125353, 8768.342374321825, 9211.355205135576, 9282.953585232031, 9305.906940930774], "unit": "ms", "name": "yui.html", "value": 6047.382732825145}], "name": "dromaeo_css", "value": 6962.231176516464}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 111.0, 109.0, 100.0, 111.0, 110.0, 98.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 148.0, 169.0, 127.0, 152.0, 146.0, 128.0, 163.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 162.0, 160.0, 163.0, 163.0, 160.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 92.0, 93.0, 70.0, 71.0, 71.0, 113.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 92.0, 93.0, 93.0, 140.0, 93.0, 94.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 145.0, 145.0, 146.0, 148.0, 146.0, 146.0, 147.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0, 66.0, 56.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 70.0, 70.0, 81.0, 74.0, 70.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 85.0, 84.0, 84.0, 84.0, 83.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [135.0, 122.0, 125.0, 122.0, 130.0, 127.0, 124.0, 118.0, 124.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [138.0, 150.0, 149.0, 147.0, 148.0, 149.0, 158.0, 156.0, 147.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 65.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1505.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5001665001665], "unit": "score", "name": "Richards", "value": 212.02381199999994}, {"lowerIsBetter": false, "replicates": [194.43904335990666], "unit": "score", "name": "DeltaBlue", "value": 340.0448739999999}, {"lowerIsBetter": false, "replicates": [284.6569883290635], "unit": "score", "name": "Encrypt", "value": 935.093853}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [583.7711617046118], "unit": "score", "name": "Splay", "value": 139.59408299999993}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21052.457821377877}]} 04:19:23 INFO - RETURN: dromaeo_css: 6962.23 04:19:23 INFO - RETURN: kraken: 1505.60 04:19:23 INFO - RETURN: v8_7: 21052.46 04:19:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "21052.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6962.23"}}} 04:19:23 INFO - Return code: 0 04:19:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:19:23 INFO - # TBPL SUCCESS # 04:19:23 INFO - Running post-action listener: _resource_record_post_action 04:19:23 INFO - Running post-run listener: _resource_record_post_run 04:19:24 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 503726080; Read time: 0; Write time: 564996 04:19:24 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235606016; Read time: 0; Write time: 399524 04:19:24 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 263217152; Read time: 0; Write time: 165184 04:19:24 INFO - Running post-run listener: _upload_blobber_files 04:19:24 INFO - Blob upload gear active. 04:19:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:19:24 INFO - Copying logs to upload dir... 04:19:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.116271 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2015-11-26 04:19:24.411627) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 04:19:24.415027) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009954 build_url: 'https://queue.taskcluster.net/v1/task/lG7EQnYLSLajEKNDwxiVlQ/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-26 04:19:24.469466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:19:24.470005) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1448539105.12266-1848272971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 04:19:24.521339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 04:19:24.521686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 04:19:24.522009) ========= ========= Total master_lag: 0.24 =========