builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1446777456.42 results: success (0) buildid: 20151105163015 builduid: 2de19b3d13484e2d9e1a4829912831ee revision: dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.416307) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.416859) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.417169) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006704 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.437940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.438236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.451540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.451925) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.500758) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.501068) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.501461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.501753) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-05 18:37:36-- 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% 225M=0s 2015-11-05 18:37:36 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.631957) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.632286) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021964 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.688569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:36.688890) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d --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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-05 18:37:37,018 truncating revision to first 12 chars 2015-11-05 18:37:37,018 Setting DEBUG logging. 2015-11-05 18:37:37,018 attempt 1/10 2015-11-05 18:37:37,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dae6c2b8fef8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 18:37:37,278 unpacking tar archive at: mozilla-central-dae6c2b8fef8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527481 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:37.228974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:37.229289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:37.260723) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:37.261092) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 18:37:37.261559) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-05 18:37:37.261858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:37 INFO - MultiFileLogger online at 20151105 18:37:37 in /builds/slave/test-pgo 18:37:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:37:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:37:37 INFO - {'append_to_log': False, 18:37:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:37:37 INFO - 'blob_upload_branch': 'Firefox', 18:37:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:37:37 INFO - 'branch': 'Firefox', 18:37:37 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:37 INFO - 'config_files': ('talos/linux_config.py',), 18:37:37 INFO - 'default_actions': ('clobber', 18:37:37 INFO - 'read-buildbot-config', 18:37:37 INFO - 'download-and-extract', 18:37:37 INFO - 'populate-webroot', 18:37:37 INFO - 'create-virtualenv', 18:37:37 INFO - 'install', 18:37:37 INFO - 'run-tests'), 18:37:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:37 INFO - 'download_minidump_stackwalk': True, 18:37:37 INFO - 'download_symbols': 'ondemand', 18:37:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:37:37 INFO - 'tooltool.py': '/tools/tooltool.py', 18:37:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:37:37 INFO - '/tools/misc-python/virtualenv.py')}, 18:37:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:37 INFO - 'installer_path': 'installer.exe', 18:37:37 INFO - 'log_level': 'info', 18:37:37 INFO - 'log_name': 'talos', 18:37:37 INFO - 'log_to_console': True, 18:37:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:37 INFO - 'opt_config_files': (), 18:37:37 INFO - 'pip_index': False, 18:37:37 INFO - 'sps_profile': False, 18:37:37 INFO - 'sps_profile_interval': 0, 18:37:37 INFO - 'suite': 'dromaeojs', 18:37:37 INFO - 'system_bits': '64', 18:37:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:37 INFO - 'title': 'talos-linux64-ix-057', 18:37:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:37 INFO - 'use_talos_json': True, 18:37:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:37:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:37 INFO - 'work_dir': 'build'} 18:37:37 INFO - ##### 18:37:37 INFO - ##### Running clobber step. 18:37:37 INFO - ##### 18:37:37 INFO - Running pre-action listener: _resource_record_pre_action 18:37:37 INFO - Running main action method: clobber 18:37:37 INFO - rmtree: /builds/slave/test-pgo/build 18:37:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:37:38 INFO - Running post-action listener: _resource_record_post_action 18:37:38 INFO - ##### 18:37:38 INFO - ##### Running read-buildbot-config step. 18:37:38 INFO - ##### 18:37:38 INFO - Running pre-action listener: _resource_record_pre_action 18:37:38 INFO - Running main action method: read_buildbot_config 18:37:38 INFO - Using buildbot properties: 18:37:38 INFO - { 18:37:38 INFO - "properties": { 18:37:38 INFO - "buildnumber": 531, 18:37:38 INFO - "product": "firefox", 18:37:38 INFO - "script_repo_revision": "production", 18:37:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:37:38 INFO - "repository": "", 18:37:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:37:38 INFO - "buildid": "20151105163015", 18:37:38 INFO - "slavename": "talos-linux64-ix-057", 18:37:38 INFO - "pgo_build": "True", 18:37:38 INFO - "basedir": "/builds/slave/test-pgo", 18:37:38 INFO - "project": "", 18:37:38 INFO - "platform": "ubuntu64_hw", 18:37:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:37:38 INFO - "slavebuilddir": "test", 18:37:38 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:37:38 INFO - "branch": "mozilla-central", 18:37:38 INFO - "repo_path": "mozilla-central", 18:37:38 INFO - "stage_platform": "linux64-pgo", 18:37:38 INFO - "builduid": "2de19b3d13484e2d9e1a4829912831ee", 18:37:38 INFO - "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d" 18:37:38 INFO - }, 18:37:38 INFO - "sourcestamp": { 18:37:38 INFO - "repository": "", 18:37:38 INFO - "hasPatch": false, 18:37:38 INFO - "project": "", 18:37:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:37:38 INFO - "changes": [ 18:37:38 INFO - { 18:37:38 INFO - "category": null, 18:37:38 INFO - "files": [ 18:37:38 INFO - { 18:37:38 INFO - "url": null, 18:37:38 INFO - "name": "https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:37:38 INFO - } 18:37:38 INFO - ], 18:37:38 INFO - "repository": "", 18:37:38 INFO - "rev": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d", 18:37:38 INFO - "who": "sendchange", 18:37:38 INFO - "when": 1446777399, 18:37:38 INFO - "number": 6628204, 18:37:38 INFO - "comments": "", 18:37:38 INFO - "project": "", 18:37:38 INFO - "at": "Thu 05 Nov 2015 18:36:39", 18:37:38 INFO - "branch": "mozilla-central-linux64-pgo-talos", 18:37:38 INFO - "revlink": "", 18:37:38 INFO - "properties": [ 18:37:38 INFO - [ 18:37:38 INFO - "buildid", 18:37:38 INFO - "20151105163015", 18:37:38 INFO - "Change" 18:37:38 INFO - ], 18:37:38 INFO - [ 18:37:38 INFO - "builduid", 18:37:38 INFO - "2de19b3d13484e2d9e1a4829912831ee", 18:37:38 INFO - "Change" 18:37:38 INFO - ], 18:37:38 INFO - [ 18:37:38 INFO - "pgo_build", 18:37:38 INFO - "True", 18:37:38 INFO - "Change" 18:37:38 INFO - ] 18:37:38 INFO - ], 18:37:38 INFO - "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d" 18:37:38 INFO - } 18:37:38 INFO - ], 18:37:38 INFO - "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d" 18:37:38 INFO - } 18:37:38 INFO - } 18:37:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:37:38 INFO - Running post-action listener: _resource_record_post_action 18:37:38 INFO - ##### 18:37:38 INFO - ##### Running download-and-extract step. 18:37:38 INFO - ##### 18:37:38 INFO - Running pre-action listener: _resource_record_pre_action 18:37:38 INFO - Running main action method: download_and_extract 18:37:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:37: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')]} 18:37:38 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/test_packages.json 18:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/test_packages.json 18:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:37:38 INFO - Downloaded 1302 bytes. 18:37:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:37:38 INFO - Using the following test package requirements: 18:37:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:37:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'jsshell-linux-x86_64.zip'], 18:37:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:37:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:37:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:37:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:37:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:37:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:37:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:37:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:37: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')]} 18:37:38 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:37:41 INFO - Downloaded 22441031 bytes. 18:37:41 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 18:37:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:41 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 18:37:42 INFO - Return code: 0 18:37:42 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 18:37:42 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')]} 18:37:42 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:38:05 INFO - Downloaded 22441031 bytes. 18:38:05 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 18:38:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:05 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 18:38:06 INFO - Return code: 0 18:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:06 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:38:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:38:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:38:10 INFO - Downloaded 11131307 bytes. 18:38:10 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 18:38:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:10 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 18:38:11 INFO - Return code: 0 18:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:11 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:38:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/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 18:38:14 INFO - Downloaded 57113395 bytes. 18:38:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:14 INFO - mkdir: /builds/slave/test-pgo/properties 18:38:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:38:14 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:38:14 INFO - Contents: 18:38:14 INFO - build_url:https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:38:14 INFO - Running post-action listener: _resource_record_post_action 18:38:14 INFO - Running post-action listener: set_extra_try_arguments 18:38:14 INFO - ##### 18:38:14 INFO - ##### Running populate-webroot step. 18:38:14 INFO - ##### 18:38:14 INFO - Running pre-action listener: _resource_record_pre_action 18:38:14 INFO - Running main action method: populate_webroot 18:38:14 INFO - Guessing talos json url... 18:38:14 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')]} 18:38:14 INFO - https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.txt matches https://queue.taskcluster.net 18:38:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.txt 18:38:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.txt 18:38:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.txt to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.txt 18:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.txt', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.txt'}, attempt #1 18:38:14 INFO - Downloaded 99 bytes. 18:38:14 INFO - Reading from file /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.txt 18:38:14 INFO - Contents: 18:38:14 INFO - 20151105163015 18:38:14 INFO - https://hg.mozilla.org/mozilla-central/rev/dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d 18:38:14 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')]} 18:38:14 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/dae6c2b8fe/testing/talos/talos.json 18:38:14 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/dae6c2b8fe/testing/talos/talos.json to /builds/slave/test-pgo/build/talos.json 18:38:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/dae6c2b8fe/testing/talos/talos.json', 'file_name': '/builds/slave/test-pgo/build/talos.json'}, attempt #1 18:38:15 INFO - Downloaded 4264 bytes. 18:38:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:38:15 INFO - '../fennec_ids.txt'], 18:38:15 INFO - 'tests': ['tcheck2']}, 18:38:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:15 INFO - '--tppagecycles', 18:38:15 INFO - '7'], 18:38:15 INFO - 'tests': ['tsvgm']}}, 18:38:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:38:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:38:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'tests': ['damp', 'tps']}, 18:38:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['damp', 'tps']}, 18:38:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:38:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:15 INFO - 'other': {'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'other_l64': {'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'other_nol64': {'tests': ['a11yr', 18:38:15 INFO - 'ts_paint', 18:38:15 INFO - 'tpaint', 18:38:15 INFO - 'sessionrestore', 18:38:15 INFO - 'sessionrestore_no_auto_restore']}, 18:38:15 INFO - 'svgr': {'tests': ['tsvgx', 18:38:15 INFO - 'tsvgr_opacity', 18:38:15 INFO - 'tart', 18:38:15 INFO - 'tscrollx', 18:38:15 INFO - 'cart']}, 18:38:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['tsvgx', 18:38:15 INFO - 'tsvgr_opacity', 18:38:15 INFO - 'tart', 18:38:15 INFO - 'tscrollx', 18:38:15 INFO - 'cart']}, 18:38:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'tests': ['tp5o']}, 18:38:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'talos_options': ['--e10s'], 18:38:15 INFO - 'tests': ['tp5o']}, 18:38:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'talos_options': ['--xperf_path', 18:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:15 INFO - 'tests': ['tp5n']}, 18:38:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:15 INFO - 'talos_options': ['--e10s', 18:38:15 INFO - '--xperf_path', 18:38:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 18:38:15 INFO - 'C:/slave/talos-data/talos/xperf.config'], 18:38:15 INFO - 'tests': ['tp5n']}}, 18:38:15 INFO - 'talos.zip': {'path': '', 18:38:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:15 INFO - Running post-action listener: _resource_record_post_action 18:38:15 INFO - ##### 18:38:15 INFO - ##### Running create-virtualenv step. 18:38:15 INFO - ##### 18:38:15 INFO - Running pre-action listener: _resource_record_pre_action 18:38:15 INFO - Running main action method: create_virtualenv 18:38:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:38:15 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 18:38:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:38:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:15 INFO - Using real prefix '/usr' 18:38:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:38:15 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:17 INFO - Installing pip.................done. 18:38:17 INFO - Return code: 0 18:38:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:17 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:17 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 18:38:17 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 18:38:17 INFO - Using env: {'DISPLAY': ':0', 18:38:17 INFO - 'HOME': '/home/cltbld', 18:38:17 INFO - 'LANG': 'en_US.UTF-8', 18:38:17 INFO - 'LANGUAGE': 'en_US:en', 18:38:17 INFO - 'LOGNAME': 'cltbld', 18:38:17 INFO - 'MAIL': '/var/mail/cltbld', 18:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:17 INFO - 'MOZ_NO_REMOTE': '1', 18:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:17 INFO - 'NO_EM_RESTART': '1', 18:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:17 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:17 INFO - 'SHELL': '/bin/bash', 18:38:17 INFO - 'SHLVL': '1', 18:38:17 INFO - 'TERM': 'linux', 18:38:17 INFO - 'TMOUT': '86400', 18:38:17 INFO - 'USER': 'cltbld', 18:38:17 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:17 INFO - '_': '/tools/buildbot/bin/python'} 18:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:18 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 18:38:18 INFO - Cleaning up... 18:38:18 INFO - Return code: 0 18:38:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:38:18 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')]} 18:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:18 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')]} 18:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:18 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:18 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 18:38:18 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 18:38:18 INFO - Using env: {'DISPLAY': ':0', 18:38:18 INFO - 'HOME': '/home/cltbld', 18:38:18 INFO - 'LANG': 'en_US.UTF-8', 18:38:18 INFO - 'LANGUAGE': 'en_US:en', 18:38:18 INFO - 'LOGNAME': 'cltbld', 18:38:18 INFO - 'MAIL': '/var/mail/cltbld', 18:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:18 INFO - 'MOZ_NO_REMOTE': '1', 18:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:18 INFO - 'NO_EM_RESTART': '1', 18:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:18 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:18 INFO - 'SHELL': '/bin/bash', 18:38:18 INFO - 'SHLVL': '1', 18:38:18 INFO - 'TERM': 'linux', 18:38:18 INFO - 'TMOUT': '86400', 18:38:18 INFO - 'USER': 'cltbld', 18:38:18 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:18 INFO - '_': '/tools/buildbot/bin/python'} 18:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:18 INFO - Downloading/unpacking psutil>=0.7.1 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:18 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 18:38:19 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:38:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:38:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:20 INFO - Installing collected packages: psutil 18:38:20 INFO - Running setup.py install for psutil 18:38:20 INFO - building 'psutil._psutil_linux' extension 18:38:20 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 18:38:20 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 18:38:20 INFO - building 'psutil._psutil_posix' extension 18:38:20 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 18:38:20 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 18:38:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:20 INFO - Successfully installed psutil 18:38:20 INFO - Cleaning up... 18:38:20 INFO - Return code: 0 18:38:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:38:20 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')]} 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:20 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')]} 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:20 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:20 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 18:38:20 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 18:38:20 INFO - Using env: {'DISPLAY': ':0', 18:38:20 INFO - 'HOME': '/home/cltbld', 18:38:20 INFO - 'LANG': 'en_US.UTF-8', 18:38:20 INFO - 'LANGUAGE': 'en_US:en', 18:38:20 INFO - 'LOGNAME': 'cltbld', 18:38:20 INFO - 'MAIL': '/var/mail/cltbld', 18:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:20 INFO - 'MOZ_NO_REMOTE': '1', 18:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:20 INFO - 'NO_EM_RESTART': '1', 18:38:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:20 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:20 INFO - 'SHELL': '/bin/bash', 18:38:20 INFO - 'SHLVL': '1', 18:38:20 INFO - 'TERM': 'linux', 18:38:20 INFO - 'TMOUT': '86400', 18:38:20 INFO - 'USER': 'cltbld', 18:38:20 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:20 INFO - '_': '/tools/buildbot/bin/python'} 18:38:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:38:20 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 18:38:20 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 18:38:20 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 18:38:20 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 18:38:20 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 18:38:20 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 18:38:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:38:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:38:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:38:22 INFO - Installing collected packages: mozsystemmonitor 18:38:22 INFO - Running setup.py install for mozsystemmonitor 18:38:22 INFO - Successfully installed mozsystemmonitor 18:38:22 INFO - Cleaning up... 18:38:22 INFO - Return code: 0 18:38:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:38:22 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')]} 18:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:22 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')]} 18:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:22 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:22 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 18:38:22 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 18:38:22 INFO - Using env: {'DISPLAY': ':0', 18:38:22 INFO - 'HOME': '/home/cltbld', 18:38:22 INFO - 'LANG': 'en_US.UTF-8', 18:38:22 INFO - 'LANGUAGE': 'en_US:en', 18:38:22 INFO - 'LOGNAME': 'cltbld', 18:38:22 INFO - 'MAIL': '/var/mail/cltbld', 18:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:22 INFO - 'MOZ_NO_REMOTE': '1', 18:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:22 INFO - 'NO_EM_RESTART': '1', 18:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:22 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:22 INFO - 'SHELL': '/bin/bash', 18:38:22 INFO - 'SHLVL': '1', 18:38:22 INFO - 'TERM': 'linux', 18:38:22 INFO - 'TMOUT': '86400', 18:38:22 INFO - 'USER': 'cltbld', 18:38:22 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:22 INFO - '_': '/tools/buildbot/bin/python'} 18:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:22 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:22 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 18:38:22 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 18:38:22 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 18:38:22 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 18:38:22 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 18:38:22 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 18:38:24 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:38:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:38:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:38:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:25 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 18:38:25 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 18:38:25 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 18:38:25 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 18:38:25 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 18:38:25 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 18:38:25 INFO - Downloading docopt-0.6.1.tar.gz 18:38:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:38:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:25 INFO - Running setup.py install for blobuploader 18:38:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:38:25 INFO - Running setup.py install for requests 18:38:25 INFO - Running setup.py install for docopt 18:38:25 INFO - Successfully installed blobuploader requests docopt 18:38:25 INFO - Cleaning up... 18:38:25 INFO - Return code: 0 18:38:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:38:25 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')]} 18:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:25 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')]} 18:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:25 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:25 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 18:38:25 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 18:38:25 INFO - Using env: {'DISPLAY': ':0', 18:38:25 INFO - 'HOME': '/home/cltbld', 18:38:25 INFO - 'LANG': 'en_US.UTF-8', 18:38:25 INFO - 'LANGUAGE': 'en_US:en', 18:38:25 INFO - 'LOGNAME': 'cltbld', 18:38:25 INFO - 'MAIL': '/var/mail/cltbld', 18:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:25 INFO - 'MOZ_NO_REMOTE': '1', 18:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:25 INFO - 'NO_EM_RESTART': '1', 18:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:25 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:25 INFO - 'SHELL': '/bin/bash', 18:38:25 INFO - 'SHLVL': '1', 18:38:25 INFO - 'TERM': 'linux', 18:38:25 INFO - 'TMOUT': '86400', 18:38:25 INFO - 'USER': 'cltbld', 18:38:25 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:25 INFO - '_': '/tools/buildbot/bin/python'} 18:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:38:26 INFO - Running setup.py (path:/tmp/pip-j52Lnw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:38:26 INFO - Running setup.py (path:/tmp/pip-cZUyff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:38:26 INFO - Running setup.py (path:/tmp/pip-ukFkyD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:38:26 INFO - Running setup.py (path:/tmp/pip-nhivN8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:38:26 INFO - Running setup.py (path:/tmp/pip-cKYzH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:38:26 INFO - Running setup.py (path:/tmp/pip-gXVOJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:38:26 INFO - Running setup.py (path:/tmp/pip-UolnP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:38:26 INFO - Running setup.py (path:/tmp/pip-SkjZVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:38:26 INFO - Running setup.py (path:/tmp/pip-SrR1Gd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:38:26 INFO - Running setup.py (path:/tmp/pip-C8sqIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:38:26 INFO - Running setup.py (path:/tmp/pip-c9_XcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:38:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:38:26 INFO - Running setup.py (path:/tmp/pip-qFfaDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:38:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:38:27 INFO - Running setup.py (path:/tmp/pip-r5QRrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:38:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:38:27 INFO - Running setup.py (path:/tmp/pip-rRjqex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:38:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:38:27 INFO - Running setup.py (path:/tmp/pip-50RudI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:38:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:38:27 INFO - Running setup.py (path:/tmp/pip-kytpnx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:38:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:38:27 INFO - Running setup.py (path:/tmp/pip-_ZIiRw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:38:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:27 INFO - Running setup.py install for manifestparser 18:38:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:38:27 INFO - Running setup.py install for mozcrash 18:38:27 INFO - Running setup.py install for mozdebug 18:38:27 INFO - Running setup.py install for mozdevice 18:38:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:38:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:38:27 INFO - Running setup.py install for mozfile 18:38:27 INFO - Running setup.py install for mozhttpd 18:38:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:38:27 INFO - Running setup.py install for mozinfo 18:38:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for mozInstall 18:38:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for mozleak 18:38:28 INFO - Running setup.py install for mozlog 18:38:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for moznetwork 18:38:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for mozprocess 18:38:28 INFO - Running setup.py install for mozprofile 18:38:28 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for mozrunner 18:38:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:38:28 INFO - Running setup.py install for mozscreenshot 18:38:28 INFO - Running setup.py install for moztest 18:38:29 INFO - Running setup.py install for mozversion 18:38:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:38:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:29 INFO - Cleaning up... 18:38:29 INFO - Return code: 0 18:38:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:29 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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:29 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 18:38:29 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 18:38:29 INFO - Using env: {'DISPLAY': ':0', 18:38:29 INFO - 'HOME': '/home/cltbld', 18:38:29 INFO - 'LANG': 'en_US.UTF-8', 18:38:29 INFO - 'LANGUAGE': 'en_US:en', 18:38:29 INFO - 'LOGNAME': 'cltbld', 18:38:29 INFO - 'MAIL': '/var/mail/cltbld', 18:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:29 INFO - 'MOZ_NO_REMOTE': '1', 18:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:29 INFO - 'NO_EM_RESTART': '1', 18:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:29 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:29 INFO - 'SHELL': '/bin/bash', 18:38:29 INFO - 'SHLVL': '1', 18:38:29 INFO - 'TERM': 'linux', 18:38:29 INFO - 'TMOUT': '86400', 18:38:29 INFO - 'USER': 'cltbld', 18:38:29 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:29 INFO - '_': '/tools/buildbot/bin/python'} 18:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:38:29 INFO - Running setup.py (path:/tmp/pip-NNV3fx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:38:29 INFO - Running setup.py (path:/tmp/pip-8HKCXV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:38:29 INFO - Running setup.py (path:/tmp/pip-YNL2c7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:38:29 INFO - Running setup.py (path:/tmp/pip-29Hdbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:38:29 INFO - Running setup.py (path:/tmp/pip-eHXdDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:38:29 INFO - Running setup.py (path:/tmp/pip-SFbApb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:38:29 INFO - Running setup.py (path:/tmp/pip-AzUVf5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:38:29 INFO - Running setup.py (path:/tmp/pip-h00h7w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:38:29 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)) 18:38:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:38:29 INFO - Running setup.py (path:/tmp/pip-G5Y7b4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:38:30 INFO - Running setup.py (path:/tmp/pip-Hj9GQo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:38:30 INFO - Running setup.py (path:/tmp/pip-CHAdXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:38:30 INFO - Running setup.py (path:/tmp/pip-jwkr14-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:38:30 INFO - Running setup.py (path:/tmp/pip-3hBbdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:38:30 INFO - Running setup.py (path:/tmp/pip-gPwhhB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:38:30 INFO - Running setup.py (path:/tmp/pip-ONXEOW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:38:30 INFO - Running setup.py (path:/tmp/pip-48upGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:38:30 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)) 18:38:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:38:30 INFO - Running setup.py (path:/tmp/pip-j0269V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:38:30 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)) 18:38:30 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)) 18:38:30 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)) 18:38:30 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)) 18:38:30 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)) 18:38:30 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)) 18:38:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:30 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 18:38:30 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 18:38:30 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 18:38:30 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 18:38:30 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 18:38:30 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 18:38:32 INFO - Downloading blessings-1.5.1.tar.gz 18:38:32 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 18:38:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:32 INFO - Installing collected packages: blessings 18:38:32 INFO - Running setup.py install for blessings 18:38:32 INFO - Successfully installed blessings 18:38:32 INFO - Cleaning up... 18:38:32 INFO - Return code: 0 18:38:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:38:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:38:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:38:32 INFO - Reading from file tmpfile_stdout 18:38:32 INFO - Current package versions: 18:38:32 INFO - argparse == 1.2.1 18:38:32 INFO - blessings == 1.5.1 18:38:32 INFO - blobuploader == 1.2.4 18:38:32 INFO - docopt == 0.6.1 18:38:32 INFO - manifestparser == 1.1 18:38:32 INFO - mozInstall == 1.12 18:38:32 INFO - mozcrash == 0.16 18:38:32 INFO - mozdebug == 0.1 18:38:32 INFO - mozdevice == 0.47 18:38:32 INFO - mozfile == 1.2 18:38:32 INFO - mozhttpd == 0.7 18:38:32 INFO - mozinfo == 0.9 18:38:32 INFO - mozleak == 0.1 18:38:32 INFO - mozlog == 3.0 18:38:32 INFO - moznetwork == 0.27 18:38:32 INFO - mozprocess == 0.22 18:38:32 INFO - mozprofile == 0.27 18:38:32 INFO - mozrunner == 6.11 18:38:32 INFO - mozscreenshot == 0.1 18:38:32 INFO - mozsystemmonitor == 0.0 18:38:32 INFO - moztest == 0.7 18:38:32 INFO - mozversion == 1.4 18:38:32 INFO - psutil == 3.1.1 18:38:32 INFO - requests == 1.2.3 18:38:32 INFO - wsgiref == 0.1.2 18:38:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f74cd46cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11507b0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121c5d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', '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 18:38:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 18:38:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 18:38:32 INFO - Using env: {'DISPLAY': ':0', 18:38:32 INFO - 'HOME': '/home/cltbld', 18:38:32 INFO - 'LANG': 'en_US.UTF-8', 18:38:32 INFO - 'LANGUAGE': 'en_US:en', 18:38:32 INFO - 'LOGNAME': 'cltbld', 18:38:32 INFO - 'MAIL': '/var/mail/cltbld', 18:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:32 INFO - 'MOZ_NO_REMOTE': '1', 18:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:32 INFO - 'NO_EM_RESTART': '1', 18:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:32 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:32 INFO - 'SHELL': '/bin/bash', 18:38:32 INFO - 'SHLVL': '1', 18:38:32 INFO - 'TERM': 'linux', 18:38:32 INFO - 'TMOUT': '86400', 18:38:32 INFO - 'USER': 'cltbld', 18:38:32 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:32 INFO - '_': '/tools/buildbot/bin/python'} 18:38:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 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)) 18:38:32 INFO - Cleaning up... 18:38:32 INFO - Return code: 0 18:38:32 INFO - Running post-action listener: _resource_record_post_action 18:38:32 INFO - Running post-action listener: _start_resource_monitoring 18:38:32 INFO - Starting resource monitoring. 18:38:32 INFO - ##### 18:38:32 INFO - ##### Running install step. 18:38:32 INFO - ##### 18:38:32 INFO - Running pre-action listener: _resource_record_pre_action 18:38:32 INFO - Running main action method: install 18:38:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:38:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:38:33 INFO - Reading from file tmpfile_stdout 18:38:33 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:38:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:38:33 INFO - Reading from file tmpfile_stdout 18:38:33 INFO - Output received: 18:38:33 INFO - Usage: mozinstall [options] installer 18:38:33 INFO - Options: 18:38:33 INFO - -h, --help show this help message and exit 18:38:33 INFO - -d DEST, --destination=DEST 18:38:33 INFO - Directory to install application into. [default: 18:38:33 INFO - "/builds/slave/test-pgo"] 18:38:33 INFO - --app=APP Application being installed. [default: firefox] 18:38:33 INFO - mkdir: /builds/slave/test-pgo/build/application 18:38:33 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'] 18:38:33 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 18:38:47 INFO - Reading from file tmpfile_stdout 18:38:47 INFO - Output received: 18:38:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:38:47 INFO - Running post-action listener: _resource_record_post_action 18:38:47 INFO - ##### 18:38:47 INFO - ##### Running run-tests step. 18:38:47 INFO - ##### 18:38:47 INFO - Running pre-action listener: _resource_record_pre_action 18:38:47 INFO - Running main action method: run_tests 18:38:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:38:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:38:47 INFO - Python 2.7.3 18:38:47 INFO - Return code: 0 18:38:47 INFO - grabbing minidump binary from tooltool 18:38:47 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')]} 18:38:47 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 0x12b2530>, '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 0x12b3430>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b38c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:38:47 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 18:38:47 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 18:38:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:38:47 INFO - Return code: 0 18:38:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:38:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:38:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:38:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:38:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:38:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:38:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 18:38:47 INFO - Using env: {'DISPLAY': ':0', 18:38:47 INFO - 'HOME': '/home/cltbld', 18:38:47 INFO - 'LANG': 'en_US.UTF-8', 18:38:47 INFO - 'LANGUAGE': 'en_US:en', 18:38:47 INFO - 'LOGNAME': 'cltbld', 18:38:47 INFO - 'MAIL': '/var/mail/cltbld', 18:38:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:38:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:47 INFO - 'MOZ_NO_REMOTE': '1', 18:38:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:47 INFO - 'NO_EM_RESTART': '1', 18:38:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:38:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:38:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:38:47 INFO - 'SHELL': '/bin/bash', 18:38:47 INFO - 'SHLVL': '1', 18:38:47 INFO - 'TERM': 'linux', 18:38:47 INFO - 'TMOUT': '86400', 18:38:47 INFO - 'USER': 'cltbld', 18:38:47 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360', 18:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:47 INFO - '_': '/tools/buildbot/bin/python'} 18:38:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost'] with output_timeout 3600 18:38:48 INFO - mozversion INFO | application_buildid: 20151105163015 18:38:48 INFO - mozversion INFO | application_changeset: dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d 18:38:48 INFO - mozversion INFO | application_display_name: Nightly 18:38:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:38:48 INFO - mozversion INFO | application_name: Firefox 18:38:48 INFO - mozversion INFO | application_remotingname: firefox 18:38:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:38:48 INFO - mozversion INFO | application_vendor: Mozilla 18:38:48 INFO - mozversion INFO | application_version: 45.0a1 18:38:48 INFO - mozversion INFO | platform_buildid: 20151105163015 18:38:48 INFO - mozversion INFO | platform_changeset: dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d 18:38:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:38:48 INFO - mozversion INFO | platform_version: 45.0a1 18:38:48 INFO - 2015-11-05 18:38:48,014 DEBUG : using testdate: 1446777528 18:38:48 INFO - 2015-11-05 18:38:48,014 DEBUG : actual date: 1446777528 18:38:48 INFO - 2015-11-05 18:38:48,023 INFO : starting webserver on 'localhost:59070' 18:38:48 INFO - 2015-11-05 18:38:48,024 INFO : Starting test suite talos-linux64-ix-057 18:38:48 INFO - 2015-11-05 18:38:48,024 INFO : Starting test dromaeo_css 18:38:48 INFO - 2015-11-05 18:38:48,024 DEBUG : operating with platform_type : linux_ 18:38:48 INFO - 2015-11-05 18:38:48,025 INFO : Initialising browser for dromaeo_css test... 18:38:48 INFO - 2015-11-05 18:38:48,039 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPxe_Jr/profile http://localhost:59070/getInfo.html 18:38:51 INFO - 2015-11-05 18:38:51,706 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:38:51 INFO - 2015-11-05 18:38:51,706 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:38:51 INFO - 2015-11-05 18:38:51,706 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:38:51 INFO - 2015-11-05 18:38:51,706 DEBUG : BROWSER_OUTPUT: __metrics 18:38:51 INFO - 2015-11-05 18:38:51,791 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:53 INFO - 2015-11-05 18:38:53,559 INFO : Browser initialized. 18:38:53 INFO - 2015-11-05 18:38:53,559 INFO : Running cycle 1/1 for dromaeo_css test... 18:38:53 INFO - 2015-11-05 18:38:53,559 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPxe_Jr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:05 INFO - 2015-11-05 18:39:05,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 139546624 18:39:05 INFO - 2015-11-05 18:39:05,282 DEBUG : BROWSER_OUTPUT: 18:39:56 INFO - 2015-11-05 18:39:56,018 DEBUG : BROWSER_OUTPUT: 1446777596010 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] 18:42:05 INFO - 2015-11-05 18:42:05,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59070/tests/dromaeo/cssquery-ext.html) 18:42:06 INFO - 2015-11-05 18:42:06,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 234729472 18:42:06 INFO - 2015-11-05 18:42:06,565 DEBUG : BROWSER_OUTPUT: 18:45:08 INFO - 2015-11-05 18:45:08,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-ext.html (next: http://localhost:59070/tests/dromaeo/cssquery-jquery.html) 18:45:09 INFO - 2015-11-05 18:45:09,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 229462016 18:45:09 INFO - 2015-11-05 18:45:09,519 DEBUG : BROWSER_OUTPUT: 18:48:11 INFO - 2015-11-05 18:48:11,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59070/tests/dromaeo/cssquery-mootools.html) 18:48:12 INFO - 2015-11-05 18:48:12,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 212733952 18:48:12 INFO - 2015-11-05 18:48:12,037 DEBUG : BROWSER_OUTPUT: 18:51:13 INFO - 2015-11-05 18:51:13,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59070/tests/dromaeo/cssquery-prototype.html) 18:51:14 INFO - 2015-11-05 18:51:14,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 199827456 18:51:14 INFO - 2015-11-05 18:51:14,393 DEBUG : BROWSER_OUTPUT: 18:54:16 INFO - 2015-11-05 18:54:16,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59070/tests/dromaeo/cssquery-yui.html) 18:54:17 INFO - 2015-11-05 18:54:17,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 202366976 18:54:17 INFO - 2015-11-05 18:54:17,488 DEBUG : BROWSER_OUTPUT: 18:57:19 INFO - 2015-11-05 18:57:19,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/dromaeo/cssquery-yui.html (next: http://localhost:59070/tests/dromaeo/cssquery-dojo.html) 18:57:20 INFO - 2015-11-05 18:57:20,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 269193216 18:57:20 INFO - 2015-11-05 18:57:20,125 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,126 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:57:20 INFO - 2015-11-05 18:57:20,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:57:20 INFO - 2015-11-05 18:57:20,126 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:57:20 INFO - 2015-11-05 18:57:20,126 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:57:20 INFO - 2015-11-05 18:57:20,130 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3184.7770656054076;3288.408086544421;3306.735461163107;3308.2887179256454;3310.2882880180773;5284.630075894689;5370.624056316059;5531.336239651242;5534.142207957768;5542.0024395608825;5392.325959255093;5393.487618676229;5436.130219164925;5456.48163424475;5573.693446860421;4849.175640141185;4963.1810751226185;4977.676451030689;5107.642465027449;5122.206058061007;5018.447970723218;5066.949330506684;5126.948730512703;5138.820141295056;5194.58443324535;4846.951530484703;4916.827911023097;4948.925766113512;5026.321446604698;5037.017781532602;4990.5508504234795;4996.200607902754;4997.625178111656;5012.27322038306;5025.522575355372;4964.404271487445;4983.551480366785;4986.351774269358;4996.750162491897;5037.5718063964605;5176.637635365526;5182.948170518284;5267.1835865440535;5275.4460781618145;5329.147336426153;5970.313413957364;5980.162777211194;5980.491658209057;5984.910226346608;5992.580519363646;5736.483716465538;6010.609310394854;6021.307549631804;6030.09548567714;6040.335563088057;5466.644668096601;5497.340319161726;5556.499915007588;5561.777528898799;5615.691136987464;6058.363871793486;6059.818205453844;6088.992974238861;6089.5737298388685;6095.2685677718955;5648.689322087324;5778.451047150514;5901.940980590139;5931.7627294907725;5958.493528050078;5803.361630220672;5873.148393482921;5875.177475153482;5879.5002424794375;5925.585209035412;5905.763769449174;5927.229460170151;5934.258217722785;5935.643861368246;5938.910916336258;5731.77072917087;5781.335146458211;5863.853403664943;5924.851878703067;5928.733207005609;4549.567791059844;4551;4554.43069616298;4587.4036375271;4597.218472859622;4035.0921042765144;4037.8990525237105;4038.1318016626565;4063.065494936181;4079.8164082616354;5303.549198318186;5391.946080539223;5541.224228607998;5657.8019769307875;5668.688222147822;5976.641401515836;5978.4021597839865;6006.939930600725;6008.909866352008;6013.789517366871;5622.690752008679;5646.153077038395;5652.293463317085;5653.632513886584;5654.660720356792;5086.643934924594;5116.181410974226;5190.6107041972;5197.402298735694;5225.555827754683;6077.817665470043;6081.817545473643;6088.238970128734;6090.665013424305;6227.283862355887;5808.448197421239;5965.671888046026;5983.581149319506;5987.550933679904;5994.310654274815;6069.605475644069;6105.053716673922;6120.17377654011;6125.295591007091;6126.23422072241;5826.621269617462;5848.707564621667;5849.473547380756;5851.093080572518;5853;5687;5814;5902.291724993029;5916.26046744157;5918.2898052234;5775.364709881826;5850.53195744348;5859.677717725566;5865.648061116347;5904.675242861684;5766.711664416846;5785.218995435563;5786.276715410574;5786.276715410574;5790.392008839011;5524.613277070566;5629.043062679272;5664.178694089252;5700.572457065654;5702.34423041339;5790.449907258803;5803.12953057028;5831.096180092092;5833.708314584169;5858.384869588802;5671.801486948102;5686.800961966312;5709.3719690834805;5710.972025035533;5742.598018138858 18:57:20 INFO - 2015-11-05 18:57:20,130 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.3223913136611;582.205289779451;587.9500242479388;604.4227762486822;609.561115996483;39985.60014399855;40901.79549102254;40912.38631420531;40943.79528102363;40962.7951860241;43795.343069853974;44264.11471770563;44315.55684443154;44324.113517729624;44328.335074973904;7532.058492688414;7640.159582445955;8717.738467845975;8866.512341821197;8884.200421962023;10505.317154384978;10694;10747.5163617637;10783.083437907748;10797.190210734227;10437.634682786103;10550.683479495627;10556.577736890515;10557.683269501927;10561.207909406787;7769;7956.602169891482;10327.483625818717;10477.318974266724;10750.354978701303;10191.286609937308;10317.638882639072;10329.431881246528;10332.225083118721;10336.79326413475;41200;41706.37440438396;41718.58281417177;41808;41823.7908810457;3406;3629.1834337274167;3703.518542589446;3882.301185786557;4155;30037;30086.84956575225;30790.846045769627;31198.22004449884;31540.842295788374;3585.4442561403025;3633.7819730816236;3637.254362855608;3646.4165733482782;3657.817109144559;299334;299442;299562;299745.5165414263;300590;54385.72807136018;55528.44471555233;57914.4208557909;58281;58516.7074164635;61909.38090619036;62399.6880015597;62675.6866215666;62751.37248627547;62754.68622656858;15466.381344746083;15720.606984825243;15747.055176689435;15753;15763.763543546627;11976.520939162336;12099.274043557414;12116.454759535665;12158.696032599079;12160.148789584644;18659;18894.90552547256;19447.8055219446;19586.31447899317;19590.608187836162;7790.688372465152;8005.239502247277;8025.7993550160545;8057.6776928923355;8193.035919468404;985.6008316631776;999.415342024909;1030.2768123076382;1040.9687709368732;1111.3887361950895;29026;29113.85443072771;29394.853025734734;29549.409011819644;29625.703742962727;1060.6340812419703;1060.798448294837;1084.5336505302637;1118.3960661242838;1125.729824842032;14532.0554163979;14692.191929443983;15659.686806263811;16027.519174424553;16194;532440;544777;544933;545276;546076;52380.73809630927;52754;52821;52834.471655282956;52840.471595283554;1343.7917122845975;1355.8711922367556;1361.0404664711355;1362.1418506340942;1367.9452821887212;24893;27827;28031.719682803727;28885.711142888304;29361.706382935896;48844.75577622089;49087.75456122697;49148.75425622849;49213;49272.29002404902;282249;287663;287688;288207;288236;28106.71893281041;28208;31360.902368416995;32448.675513244565;32540.51189232116;38403.807980959915;38756.2248755029;39159;39172.80413597914;39541;35554.288914221055;35830.82084589561;36097.27805443929;36999.56005279384;37051.25897482089;35589.644103559665;35688.464673029404;35767.3446378415;35873.64126358703;36248.275034498634;35112.64887351196;35516.467252991744;35617.46573801343;35940;36009.0997725059;30578;31316.74733010654;33026.83486582552;33068.66931330656;33107.172320692174;24233.394165145306;24304.513909721354;24620.50758984846;24958;24989.75010249947 18:57:20 INFO - 2015-11-05 18:57:20,134 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.09160366255065;352.13902009586553;353.5245095346759;354.36037951497536;356.891148199799;17079.57301067474;17580.384686535974;18522.444326670222;18991.810081899177;19002.23991040357;15293.082415055105;15306.464273750422;15449.613759656015;17385.73921391177;17391.652166956654;4746.288056791474;4870.4885986971385;5162.793488260465;5326.946730532683;5328.946710532884;4854.101991131634;4871.293662418947;4871.5615594596475;4874.683145595525;4875.8781030474165;3479.1128262293078;3561.893143205695;4734.715917044989;4897.363342765436;4966.15575352191;4125.773082480462;4986.925196122061;5001.8499445016705;5003.849884503471;5022.598192144638;4218.430511880918;4288.9142217155795;4310.48274207094;4319.848805291831;4322.222000039991;11310.264832785842;11770.705732356673;13195.142315749446;13401.66495837602;13692.589222323346;2070.6583413736867;2100.674395468705;2125.798049185325;2186.081845624841;2239.507308392151;9882.752931176707;10014.349067310673;10067.89932100677;10081.49592520371;10223.182145428347;1657.113444307302;1660.8173100958884;1661.3935913391647;1670.7076261654283;1719.3724290633954;63261.683691581246;66611.333886661;69304.6534767328;69831.65084174597;70539;15347.462838800811;15583.922080389526;15819.999999999769;15849.762253566205;15988.162840918329;23502.882485587463;23729.406764831016;23833.40416489567;23835.880820596132;23856;8903.910960890438;8955.955220223988;9076.183143517115;9082.272657186442;9205.76985575366;7462.104547454232;7577.583232922132;7581.658825352873;7664.425168112414;7675.207441414388;8150.877736833952;8258.215469530385;8280.378971577156;8284.50292982423;8302.418830681794;3107.1610665120743;3128.765342599314;3132;3136.5138403547485;3163.6994485523837;444.9666275029321;471.4107365792759;491.268010664115;499.4580879745444;506.57194670503367;11088.889111108947;11394.658160255205;11461.885381146081;11682.357470339042;12084.697882553006;468.21340148550763;520.0223579670196;520.1365732883471;521.9712915789668;528.2736237673199;6090.573659843769;6505.243584232231;6508;6585.111010013683;6589.934100658932;557670;558067;564048;574434;575832;78335.60832195803;80573.59713201514;82362;82636;83176;569.3566270114827;578.5227187570272;580.2080160580776;582.3855832097178;582.5339728217409;11534.750474977895;11603.12976526747;11683.240589361665;11739.706507337385;11764.411779411166;36185;36984.445233320985;38588.80705596454;39834.800825995684;40045.59954400419;49753.502464976336;51268.230976534636;53375.733121334146;53431.19853202127;53619.731901340245;7024.4029257513685;7097.219305876452;7100.644967751695;7106.111736032996;7147.142342918883;12249.14256002107;12639.747205055663;12672.683182920133;12683.175593586388;12971;10834.187435942493;10842.241043126905;10983.725406864573;11021.063209627271;11043.840396758225;10728.463576820972;11017.779644407226;11056.944715276371;11088.833667494833;11161.55353785872;10973.067289280181;11240;11298;11349.262297950607;11429;6164.876702466016;6205.689715514297;6946.235914049552;6959.338862808025;7009.334113259232;10657.94671026671;10748.72039042976;10989.230753847154;10990.560377584807;11053.944730276296 18:57:20 INFO - 2015-11-05 18:57:20,135 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1322.0547308674295;1485.3464475630724;1486.6877955629318;1672.665466906619;1824.0514932235246;7026.40275576576;7417.5920324382205;7617.695292188313;7624.809379765508;7630.732924347649;7779.2998630123275;7868.606569671508;7874.606269686507;7900.604969751504;7905.762827115182;2253.8422310438277;2270.500489892221;2270.9545809083806;2274.863508189506;2274.8976296066635;2227.6658501224783;2231.3306008197555;2231.8102961248233;2236.1614394602025;2305.4812667149927;2236.854604450714;2246.3822448826622;2247.5617254635354;2249.7862703043184;2280.9393631961134;2238.9216377426874;2256.8758718270487;2267.2291420916968;2270.6594010898416;2270.852394594346;2268.8638681679154;2277.908883644652;2280.680704701343;2282.4179834142356;2282.7146606674164;6911.827204319882;7063.1524217093765;7761.18507556704;7787.922120778776;7793.688252469894;4235.195312890572;4553.521880202564;4610.631149508032;4617.30740388941;4619.9076018479445;3096.752259819209;3132.4674805283157;3132.7023932726584;3148.889788857402;3256.96743032569;971.2618410008374;997.4165113408665;1015.6242190389603;1028.280203857303;1044.4777611194402;10660.786784264348;10772.515236814284;10774.030337269605;10784;10791.028807407292;4048.1903619276263;4133.7106402551535;4195.098053918422;4209.031922657745;4216.219999300078;8769.079246679134;8790.956045219733;8791.032986371494;8792.60433280504;8794.780130496789;4676.953230467651;4677.321788340671;4681.040386720714;4700.95299047012;4709.693869898446;4345.695801293942;4354.107407981356;4354.6951713380395;4355.455568053993;4361.738295702205;3449.5170676105367;3530.805805680661;3533.4699795030438;3543.3976224041457;3562.7149828014217;1049.732318258839;1065.717584840018;1070.0583486531802;1082.355998181081;1082.9350238985687;1106.9225154239125;1109.839073334362;1151.7696460707891;1200.6698158006618;1397.4200706706806;7406.481546291816;7462.514936529217;7466.141393739789;7467.290607392289;7467.7012919483695;477.81365267545686;480.79325889866993;492.32059757534375;492.8004158315888;494.80949834313327;5630.8029218977135;5955.612885162451;6001.789937352259;6018.939810601925;6024.036154215304;8617.913820861837;9089.22741566961;9260.629574817067;9297.16325530692;9307.488088155216;9043.547822608843;9052.728418147466;9132.406393584528;9138.954305228564;9160.496172710431;7354.448416368794;7424.96287518559;7430.071241094864;7442.06974128234;7447.069116360455;7216.7113315466795;7286.96356518214;7332.853342933218;7336.926630733625;7350;8231.753047408587;8328.83342333162;8361.456505327134;8368.623411946599;8390.916090839257;8350.874736879074;8495.235428811437;8540.14598540141;8541.316694664536;8572.4427912188;7297.124345078624;7379.667914943733;7380.298871607189;7380.815479612837;7382.5570465772225;7412.481126321106;7488.101427828696;7520.548767073993;7536.8492630148185;7661.923380766121;7071.575705457689;7189.784306470814;7270.854582908418;7306.013688152244;7329.230430804902;6944;7054.118235220598;7063.39961103312;7079.716811327489;7221.097362829646;7120.1099862517185;7155.713771449084;7157.391621712213;7173.426125910019;7180.928190718235;6280.120783090462;6366.076918846834;6374.649394283359;6631.767888123893;6663.700133493908;6475.643839588868;6577.2436169841085;6627.602343859384;6658.1011563438315;6658.800235992928 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.27671845222056;331.6302322909956;334.3013102615533;336.99663003369966;345.56976564177603;5754.309482862062;5851.912221316684;5880.411958804118;5894.793682221123;5898.02682557378;5625.578081643873;5682.687452190128;5719.6854173020465;5734.655920644765;5753.108268218422;4448.04367061081;4456.974895773974;4465.30787727901;4470.26240670289;4473.261911784552;4383.802728877192;4442.267025940716;4453.755043472608;4455.398521199645;4504.279315309551;4450.465944086714;4456.17560751262;4460.107978404316;4463.977680111595;4468.664850136237;4434.512203657595;4440.933385999197;4443.688941774077;4454.2873140297725;4458.554144585548;3933.174033452978;3934.567197608261;3937.606239376068;3941.960580394188;3944.5069366329208;5448.7548060336985;5527.811520523107;5546.667199967975;5573.247611572427;5574.888502229973;5129.25625784263;5136.717480538568;5139.12634852076;5144.845654630367;5152.9484705152845;5902.970485147547;6054.364291749391;6099.176611157482;6099.9085013724825;6103.664298463583;4170.249355116078;4221.767802770846;4241.533431322583;4260.637845783112;4261.97869010653;6220.284667263278;6279.058141278799;6309.842253943642;6316.494680425555;6322.051692246107;4359.237133501624;4367.10474352757;4367.47590289161;4367.5414081520985;4369.43197384338;4364.650827933758;4418.138462999748;4419.005723712204;4421.40311058003;4460.620847227957;5097.617678674114;5119.897602047939;5123.5132662397755;5124.56441202502;5126.538611524906;6087.665178415141;6128;6133.26400831903;6143.109249158847;6143.232095988002;1577.7791109244715;1610.074207330766;1611.8629916456998;1611.927463264156;1614.6044219166379;1055.8732952045805;1062.8033813744328;1068.1027936533349;1073.5061871539178;1092.956281748737;6034.426729460694;6039.033754599243;6048.697565121726;6049.092636104531;6049.546284028627;6382.489400847921;6400.007998760199;6401.551891367652;6405;6410.583312084699;5980.73086711099;6012.759489620454;6032.306284777307;6032.698365081728;6033;3484.198634314071;3529.435290353531;3531.346700860349;3557.5375201223674;3560.430331147004;6620.602763834186;6624.470042396597;6624.56940298879;6633.635150066696;6638.900416493757;6555.475561955032;6559.409653131241;6574.638394888231;6576.276609572943;6578.605283682994;6463.15978922737;6712.12742343502;6712.295209002984;6720.193576770819;6722;6222.315545289924;6299.748010079546;6467.417932386108;6468.8706225874275;6471.935280647322;6293.96853015732;6324.905126423199;6339.366063393808;6339.524535659936;6378.9362106380195;6642.535022548375;6645.202575690754;6649.069130321662;6652.168478940132;6652.467802575879;4469.3966314548425;4515.503294637521;4574.817007319803;4575.153596584642;4579.381783459324;6344.238691357066;6344.682765861596;6346.270178929298;6350.90473642905;6353.0152826312;6151.6001459904965;6165;6165.260168779775;6179.351168127282;6181.196444462191;6109.297430795337;6162.291336496181;6170.969145154425;6172.876542469216;6175.2589689237575;6101.023836186189;6114.633122012693;6119.785807496716;6120.418560236771;6126.172966649446;6211.65835879013;6248.218972628421;6251.6874156292915;6253.624782513064;6256.468200203034;6007.279126504847;6103.267607886904;6110.511159107172;6116.052011938156;6117.510599152146 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: |5;yui.html;783.1929947737689;788.6845261895245;836.5440834745064;848.4909054567261;850.7065062553417;12964.74070518589;13192.868071319284;13206;13212.339383030834;13245.933770331136;12576.748465030694;12584;13871.653208669788;13901.096428732126;13909.513167039157;708.6421357214625;714.242902523327;853.6329378367315;868.9131086891292;870.0125357719003;860.7159637319669;863.9222469977701;868.5049521772593;873.5981448533682;874.54960695242;891.2647066170402;897.2821742605922;898.1602201941173;898.2723993565234;903.9864402033975;731.9377852882485;737.2001378504356;886.4592598514932;888.6401007591936;906.0622255965045;659.5350278054009;660.0495286787011;660.9173853268342;666.1140682891743;668.3283300283184;13087.738245235138;13129.60611181666;13147.276899770508;13171.078024538287;13205.603831885059;12801.103922725413;13075.346232688422;13389.464421423132;13429.932850335686;13455.865441345559;10443.47782610874;10462.319949203278;10479.266451348409;10594.41730704811;10615.893841061568;3603.9099022524383;3620.167361506868;3649.361361761681;3676.889693309205;3771;42432.151356972994;43456.130877382595;50173.74913125447;50280.49719502795;50465;7916.089649690244;8000.919990800134;8030.277275045274;8071.071826739882;8103.351731861437;13102.868971310356;13136.080474366703;13145.342732863319;13147.60557183286;13163.802542961863;7093.82265443368;7201;7231.204567497571;7275.818104547323;7513.962430187814;4516.796744146522;4524.5701658342405;4535.25168347219;4544.727316361029;4546.204414227563;2781.582762585628;2806.943861122807;2824.4351129774127;2829.221963959886;2830.9150725478266;460.723565860481;467.93448917151625;471.19190588140816;472.9408823897013;480.92545655423464;669.9833501161539;688.4905170174135;696.6795274173937;707.2962402409636;735.7167490516083;8355.916440835636;8442.851059194076;8545.444546104483;8704.173103555153;8748.34387420946;548.5200449606594;637.5951270942985;652.3541693723274;653.2716021635841;664.9401553860079;4208.894777630522;4642.396488456479;4646.86059418218;4655.51117132703;4680.882977925511;65270;66886;67122.66438667776;67276.6636166816;67326.66336668383;54773;54909;55339.72330138324;55393;55618;51791.741041294554;51995.48004519982;52116.47883521192;52188.73905630523;52992.47007529953;9085.863712044193;9236.21492173146;9497.952510237405;9509.476978766234;9574.138327550554;35186.824065879504;35658;36169.63830361663;39511.407328889516;40186.19627607373;50438.49561504338;50729.746351268004;50837.74581127071;50842.74578627083;51579.74210129076;8179.877301840358;8206.097329293892;8278.586070696561;8310.376721746014;8479.915200847912;12569.811452828399;12713.745725085631;12849.581272831267;12914.483420663068;13115.606531804062;11749.765004699688;11826.231294965799;11901.345426001653;11970.341631210018;11978.281303121841;12007.762352590216;12056.51773929033;12066.3363515004;12085.637430877088;12221.938890305491;10994;11139.443027848738;11211.439428028403;11303.095752339628;11305.660830175108;10379.429131397847;10559.52482138321;10602.522886470282;10888.67333979982;11057.391843448688;9895.55470003866;9931.950340248253;9944;10074.748131296483;10082.243831712798 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,764 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1446778640125__endTimestamp 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:57:20 INFO - 2015-11-05 18:57:20,139 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:57:20 INFO - 2015-11-05 18:57:20,140 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,140 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5489.69 Median:5700.57 stddev:619.20 (10.9%) stddev-sans-first:594.12 18:57:20 INFO - 2015-11-05 18:57:20,140 DEBUG : BROWSER_OUTPUT: Values: 3184.8 3288.4 3306.7 3308.3 3310.3 5284.6 5370.6 5531.3 5534.1 5542.0 5392.3 5393.5 5436.1 5456.5 5573.7 4849.2 4963.2 4977.7 5107.6 5122.2 5018.4 5066.9 5126.9 5138.8 5194.6 4847.0 4916.8 4948.9 5026.3 5037.0 4990.6 4996.2 4997.6 5012.3 5025.5 4964.4 4983.6 4986.4 4996.8 5037.6 5176.6 5182.9 5267.2 5275.4 5329.1 5970.3 5980.2 5980.5 5984.9 5992.6 5736.5 6010.6 6021.3 6030.1 6040.3 5466.6 5497.3 5556.5 5561.8 5615.7 6058.4 6059.8 6089.0 6089.6 6095.3 5648.7 5778.5 5901.9 5931.8 5958.5 5803.4 5873.1 5875.2 5879.5 5925.6 5905.8 5927.2 5934.3 5935.6 5938.9 5731.8 5781.3 5863.9 5924.9 5928.7 4549.6 4551.0 4554.4 4587.4 4597.2 4035.1 4037.9 4038.1 4063.1 4079.8 5303.5 5391.9 5541.2 5657.8 5668.7 5976.6 5978.4 6006.9 6008.9 6013.8 5622.7 5646.2 5652.3 5653.6 5654.7 5086.6 5116.2 5190.6 5197.4 5225.6 6077.8 6081.8 6088.2 6090.7 6227.3 5808.4 5965.7 5983.6 5987.6 5994.3 6069.6 6105.1 6120.2 6125.3 6126.2 5826.6 5848.7 5849.5 5851.1 5853.0 5687.0 5814.0 5902.3 5916.3 5918.3 5775.4 5850.5 5859.7 5865.6 5904.7 5766.7 5785.2 5786.3 5786.3 5790.4 5524.6 5629.0 5664.2 5700.6 5702.3 5790.4 5803.1 5831.1 5833.7 5858.4 5671.8 5686.8 5709.4 5711.0 5742.6 18:57:20 INFO - 2015-11-05 18:57:20,140 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,140 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53621.67 Median:18256.59 stddev:104772.06 (573.9%) stddev-sans-first:104990.19 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: Values: 549.3 582.2 588.0 604.4 609.6 39985.6 40901.8 40912.4 40943.8 40962.8 43795.3 44264.1 44315.6 44324.1 44328.3 7532.1 7640.2 8717.7 8866.5 8884.2 10505.3 10694.0 10747.5 10783.1 10797.2 10437.6 10550.7 10556.6 10557.7 10561.2 7769.0 7956.6 10327.5 10477.3 10750.4 10191.3 10317.6 10329.4 10332.2 10336.8 41200.0 41706.4 41718.6 41808.0 41823.8 3406.0 3629.2 3703.5 3882.3 4155.0 30037.0 30086.8 30790.8 31198.2 31540.8 3585.4 3633.8 3637.3 3646.4 3657.8 299334.0 299442.0 299562.0 299745.5 300590.0 54385.7 55528.4 57914.4 58281.0 58516.7 61909.4 62399.7 62675.7 62751.4 62754.7 15466.4 15720.6 15747.1 15753.0 15763.8 11976.5 12099.3 12116.5 12158.7 12160.1 18659.0 18894.9 19447.8 19586.3 19590.6 7790.7 8005.2 8025.8 8057.7 8193.0 985.6 999.4 1030.3 1041.0 1111.4 29026.0 29113.9 29394.9 29549.4 29625.7 1060.6 1060.8 1084.5 1118.4 1125.7 14532.1 14692.2 15659.7 16027.5 16194.0 532440.0 544777.0 544933.0 545276.0 546076.0 52380.7 52754.0 52821.0 52834.5 52840.5 1343.8 1355.9 1361.0 1362.1 1367.9 24893.0 27827.0 28031.7 28885.7 29361.7 48844.8 49087.8 49148.8 49213.0 49272.3 282249.0 287663.0 287688.0 288207.0 288236.0 28106.7 28208.0 31360.9 32448.7 32540.5 38403.8 38756.2 39159.0 39172.8 39541.0 35554.3 35830.8 36097.3 36999.6 37051.3 35589.6 35688.5 35767.3 35873.6 36248.3 35112.6 35516.5 35617.5 35940.0 36009.1 30578.0 31316.7 33026.8 33068.7 33107.2 24233.4 24304.5 24620.5 24958.0 24989.8 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29441.34 Median:22085.69 stddev:92715.17 (419.8%) stddev-sans-first:92949.53 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: Values: 352.1 352.1 353.5 354.4 356.9 17079.6 17580.4 18522.4 18991.8 19002.2 15293.1 15306.5 15449.6 17385.7 17391.7 4746.3 4870.5 5162.8 5326.9 5328.9 4854.1 4871.3 4871.6 4874.7 4875.9 3479.1 3561.9 4734.7 4897.4 4966.2 4125.8 4986.9 5001.8 5003.8 5022.6 4218.4 4288.9 4310.5 4319.8 4322.2 11310.3 11770.7 13195.1 13401.7 13692.6 2070.7 2100.7 2125.8 2186.1 2239.5 9882.8 10014.3 10067.9 10081.5 10223.2 1657.1 1660.8 1661.4 1670.7 1719.4 63261.7 66611.3 69304.7 69831.7 70539.0 15347.5 15583.9 15820.0 15849.8 15988.2 23502.9 23729.4 23833.4 23835.9 23856.0 8903.9 8956.0 9076.2 9082.3 9205.8 7462.1 7577.6 7581.7 7664.4 7675.2 8150.9 8258.2 8280.4 8284.5 8302.4 3107.2 3128.8 3132.0 3136.5 3163.7 445.0 471.4 491.3 499.5 506.6 11088.9 11394.7 11461.9 11682.4 12084.7 468.2 520.0 520.1 522.0 528.3 6090.6 6505.2 6508.0 6585.1 6589.9 557670.0 558067.0 564048.0 574434.0 575832.0 78335.6 80573.6 82362.0 82636.0 83176.0 569.4 578.5 580.2 582.4 582.5 11534.8 11603.1 11683.2 11739.7 11764.4 36185.0 36984.4 38588.8 39834.8 40045.6 49753.5 51268.2 53375.7 53431.2 53619.7 7024.4 7097.2 7100.6 7106.1 7147.1 12249.1 12639.7 12672.7 12683.2 12971.0 10834.2 10842.2 10983.7 11021.1 11043.8 10728.5 11017.8 11056.9 11088.8 11161.6 10973.1 11240.0 11298.0 11349.3 11429.0 6164.9 6205.7 6946.2 6959.3 7009.3 10657.9 10748.7 10989.2 10990.6 11053.9 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,141 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5443.03 Median:6425.15 stddev:2844.20 (44.3%) stddev-sans-first:2835.31 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: Values: 1322.1 1485.3 1486.7 1672.7 1824.1 7026.4 7417.6 7617.7 7624.8 7630.7 7779.3 7868.6 7874.6 7900.6 7905.8 2253.8 2270.5 2271.0 2274.9 2274.9 2227.7 2231.3 2231.8 2236.2 2305.5 2236.9 2246.4 2247.6 2249.8 2280.9 2238.9 2256.9 2267.2 2270.7 2270.9 2268.9 2277.9 2280.7 2282.4 2282.7 6911.8 7063.2 7761.2 7787.9 7793.7 4235.2 4553.5 4610.6 4617.3 4619.9 3096.8 3132.5 3132.7 3148.9 3257.0 971.3 997.4 1015.6 1028.3 1044.5 10660.8 10772.5 10774.0 10784.0 10791.0 4048.2 4133.7 4195.1 4209.0 4216.2 8769.1 8791.0 8791.0 8792.6 8794.8 4677.0 4677.3 4681.0 4701.0 4709.7 4345.7 4354.1 4354.7 4355.5 4361.7 3449.5 3530.8 3533.5 3543.4 3562.7 1049.7 1065.7 1070.1 1082.4 1082.9 1106.9 1109.8 1151.8 1200.7 1397.4 7406.5 7462.5 7466.1 7467.3 7467.7 477.8 480.8 492.3 492.8 494.8 5630.8 5955.6 6001.8 6018.9 6024.0 8617.9 9089.2 9260.6 9297.2 9307.5 9043.5 9052.7 9132.4 9139.0 9160.5 7354.4 7425.0 7430.1 7442.1 7447.1 7216.7 7287.0 7332.9 7336.9 7350.0 8231.8 8328.8 8361.5 8368.6 8390.9 8350.9 8495.2 8540.1 8541.3 8572.4 7297.1 7379.7 7380.3 7380.8 7382.6 7412.5 7488.1 7520.5 7536.8 7661.9 7071.6 7189.8 7270.9 7306.0 7329.2 6944.0 7054.1 7063.4 7079.7 7221.1 7120.1 7155.7 7157.4 7173.4 7180.9 6280.1 6366.1 6374.6 6631.8 6663.7 6475.6 6577.2 6627.6 6658.1 6658.8 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5180.51 Median:5941.85 stddev:1550.85 (26.1%) stddev-sans-first:1511.82 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: Values: 327.3 331.6 334.3 337.0 345.6 5754.3 5851.9 5880.4 5894.8 5898.0 5625.6 5682.7 5719.7 5734.7 5753.1 4448.0 4457.0 4465.3 4470.3 4473.3 4383.8 4442.3 4453.8 4455.4 4504.3 4450.5 4456.2 4460.1 4464.0 4468.7 4434.5 4440.9 4443.7 4454.3 4458.6 3933.2 3934.6 3937.6 3942.0 3944.5 5448.8 5527.8 5546.7 5573.2 5574.9 5129.3 5136.7 5139.1 5144.8 5152.9 5903.0 6054.4 6099.2 6099.9 6103.7 4170.2 4221.8 4241.5 4260.6 4262.0 6220.3 6279.1 6309.8 6316.5 6322.1 4359.2 4367.1 4367.5 4367.5 4369.4 4364.7 4418.1 4419.0 4421.4 4460.6 5097.6 5119.9 5123.5 5124.6 5126.5 6087.7 6128.0 6133.3 6143.1 6143.2 1577.8 1610.1 1611.9 1611.9 1614.6 1055.9 1062.8 1068.1 1073.5 1093.0 6034.4 6039.0 6048.7 6049.1 6049.5 6382.5 6400.0 6401.6 6405.0 6410.6 5980.7 6012.8 6032.3 6032.7 6033.0 3484.2 3529.4 3531.3 3557.5 3560.4 6620.6 6624.5 6624.6 6633.6 6638.9 6555.5 6559.4 6574.6 6576.3 6578.6 6463.2 6712.1 6712.3 6720.2 6722.0 6222.3 6299.7 6467.4 6468.9 6471.9 6294.0 6324.9 6339.4 6339.5 6378.9 6642.5 6645.2 6649.1 6652.2 6652.5 4469.4 4515.5 4574.8 4575.2 4579.4 6344.2 6344.7 6346.3 6350.9 6353.0 6151.6 6165.0 6165.3 6179.4 6181.2 6109.3 6162.3 6171.0 6172.9 6175.3 6101.0 6114.6 6119.8 6120.4 6126.2 6211.7 6248.2 6251.7 6253.6 6256.5 6007.3 6103.3 6110.5 6116.1 6117.5 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14411.72 Median:50359.50 stddev:17681.35 (35.1%) stddev-sans-first:17701.33 18:57:20 INFO - 2015-11-05 18:57:20,143 DEBUG : BROWSER_OUTPUT: Values: 783.2 788.7 836.5 848.5 850.7 12964.7 13192.9 13206.0 13212.3 13245.9 12576.7 12584.0 13871.7 13901.1 13909.5 708.6 714.2 853.6 868.9 870.0 860.7 863.9 868.5 873.6 874.5 891.3 897.3 898.2 898.3 904.0 731.9 737.2 886.5 888.6 906.1 659.5 660.0 660.9 666.1 668.3 13087.7 13129.6 13147.3 13171.1 13205.6 12801.1 13075.3 13389.5 13429.9 13455.9 10443.5 10462.3 10479.3 10594.4 10615.9 3603.9 3620.2 3649.4 3676.9 3771.0 42432.2 43456.1 50173.7 50280.5 50465.0 7916.1 8000.9 8030.3 8071.1 8103.4 13102.9 13136.1 13145.3 13147.6 13163.8 7093.8 7201.0 7231.2 7275.8 7514.0 4516.8 4524.6 4535.3 4544.7 4546.2 2781.6 2806.9 2824.4 2829.2 2830.9 460.7 467.9 471.2 472.9 480.9 670.0 688.5 696.7 707.3 735.7 8355.9 8442.9 8545.4 8704.2 8748.3 548.5 637.6 652.4 653.3 664.9 4208.9 4642.4 4646.9 4655.5 4680.9 65270.0 66886.0 67122.7 67276.7 67326.7 54773.0 54909.0 55339.7 55393.0 55618.0 51791.7 51995.5 52116.5 52188.7 52992.5 9085.9 9236.2 9498.0 9509.5 9574.1 35186.8 35658.0 36169.6 39511.4 40186.2 50438.5 50729.7 50837.7 50842.7 51579.7 8179.9 8206.1 8278.6 8310.4 8479.9 12569.8 12713.7 12849.6 12914.5 13115.6 11749.8 11826.2 11901.3 11970.3 11978.3 12007.8 12056.5 12066.3 12085.6 12221.9 10994.0 11139.4 11211.4 11303.1 11305.7 10379.4 10559.5 10602.5 10888.7 11057.4 9895.6 9932.0 9944.0 10074.7 10082.2 18:57:20 INFO - 2015-11-05 18:57:20,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:57:20 INFO - 2015-11-05 18:57:20,145 DEBUG : BROWSER_OUTPUT: 18:57:20 INFO - 2015-11-05 18:57:20,838 INFO : Browser exited with error code: 0 18:57:20 INFO - 2015-11-05 18:57:20,854 INFO : Completed test dromaeo_css (00:18:32) 18:57:20 INFO - 2015-11-05 18:57:20,854 INFO : Starting test kraken 18:57:20 INFO - 2015-11-05 18:57:20,854 DEBUG : operating with platform_type : linux_ 18:57:20 INFO - 2015-11-05 18:57:20,854 INFO : Initialising browser for kraken test... 18:57:20 INFO - 2015-11-05 18:57:20,860 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc2AmVP/profile http://localhost:59070/getInfo.html 18:57:24 INFO - 2015-11-05 18:57:24,595 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:57:24 INFO - 2015-11-05 18:57:24,595 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:57:24 INFO - 2015-11-05 18:57:24,595 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:57:24 INFO - 2015-11-05 18:57:24,595 DEBUG : BROWSER_OUTPUT: __metrics 18:57:24 INFO - 2015-11-05 18:57:24,672 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:57:25 INFO - 2015-11-05 18:57:25,237 DEBUG : BROWSER_OUTPUT: console.error: 18:57:25 INFO - 2015-11-05 18:57:25,237 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:57:25 INFO - 2015-11-05 18:57:25,237 DEBUG : BROWSER_OUTPUT: Stack: 18:57:25 INFO - 2015-11-05 18:57:25,237 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:57:25 INFO - 2015-11-05 18:57:25,239 DEBUG : BROWSER_OUTPUT: 18:57:25 INFO - 2015-11-05 18:57:25,781 INFO : Browser initialized. 18:57:25 INFO - 2015-11-05 18:57:25,782 INFO : Running cycle 1/1 for kraken test... 18:57:25 INFO - 2015-11-05 18:57:25,782 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc2AmVP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:57:37 INFO - 2015-11-05 18:57:37,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 139866112 18:57:37 INFO - 2015-11-05 18:57:37,534 DEBUG : BROWSER_OUTPUT: 18:57:39 INFO - 2015-11-05 18:57:39,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59070/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:40 INFO - 2015-11-05 18:57:40,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 179990528 18:57:40 INFO - 2015-11-05 18:57:40,570 DEBUG : BROWSER_OUTPUT: 18:57:43 INFO - 2015-11-05 18:57:43,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59070/tests/kraken/driver.html?testName=audio-dft) 18:57:43 INFO - 2015-11-05 18:57:43,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 169852928 18:57:43 INFO - 2015-11-05 18:57:43,681 DEBUG : BROWSER_OUTPUT: 18:57:46 INFO - 2015-11-05 18:57:46,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59070/tests/kraken/driver.html?testName=audio-fft) 18:57:47 INFO - 2015-11-05 18:57:47,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 150499328 18:57:47 INFO - 2015-11-05 18:57:47,089 DEBUG : BROWSER_OUTPUT: 18:57:49 INFO - 2015-11-05 18:57:49,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59070/tests/kraken/driver.html?testName=audio-oscillator) 18:57:49 INFO - 2015-11-05 18:57:49,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 154677248 18:57:49 INFO - 2015-11-05 18:57:49,647 DEBUG : BROWSER_OUTPUT: 18:57:51 INFO - 2015-11-05 18:57:51,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:52 INFO - 2015-11-05 18:57:52,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 156127232 18:57:52 INFO - 2015-11-05 18:57:52,359 DEBUG : BROWSER_OUTPUT: 18:57:55 INFO - 2015-11-05 18:57:55,277 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59070/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:55 INFO - 2015-11-05 18:57:55,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 156483584 18:57:55 INFO - 2015-11-05 18:57:55,859 DEBUG : BROWSER_OUTPUT: 18:57:59 INFO - 2015-11-05 18:57:59,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59070/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:59 INFO - 2015-11-05 18:57:59,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 157061120 18:57:59 INFO - 2015-11-05 18:57:59,783 DEBUG : BROWSER_OUTPUT: 18:58:02 INFO - 2015-11-05 18:58:02,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59070/tests/kraken/driver.html?testName=json-parse-financial) 18:58:03 INFO - 2015-11-05 18:58:03,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 156282880 18:58:03 INFO - 2015-11-05 18:58:03,084 DEBUG : BROWSER_OUTPUT: 18:58:04 INFO - 2015-11-05 18:58:04,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:05 INFO - 2015-11-05 18:58:05,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 167362560 18:58:05 INFO - 2015-11-05 18:58:05,196 DEBUG : BROWSER_OUTPUT: 18:58:07 INFO - 2015-11-05 18:58:07,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:07 INFO - 2015-11-05 18:58:07,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 166506496 18:58:07 INFO - 2015-11-05 18:58:07,593 DEBUG : BROWSER_OUTPUT: 18:58:09 INFO - 2015-11-05 18:58:09,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:10 INFO - 2015-11-05 18:58:10,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 179712000 18:58:10 INFO - 2015-11-05 18:58:10,230 DEBUG : BROWSER_OUTPUT: 18:58:12 INFO - 2015-11-05 18:58:12,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:13 INFO - 2015-11-05 18:58:13,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 185692160 18:58:13 INFO - 2015-11-05 18:58:13,194 DEBUG : BROWSER_OUTPUT: 18:58:15 INFO - 2015-11-05 18:58:15,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:16 INFO - 2015-11-05 18:58:16,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 184332288 18:58:16 INFO - 2015-11-05 18:58:16,267 DEBUG : BROWSER_OUTPUT: 18:58:17 INFO - 2015-11-05 18:58:17,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59070/tests/kraken/driver.html?testName=ai-astar) 18:58:18 INFO - 2015-11-05 18:58:18,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 243064832 18:58:18 INFO - 2015-11-05 18:58:18,167 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;107;111;112;111;100;109;112;109 18:58:18 INFO - 2015-11-05 18:58:18,169 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;146;166;123;147;143;123;165;124 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;161;160;162;162;160;161 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;80;96;71;71;71;100;104;72 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;90;91;90;143;90;91;133 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;110;109 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;144;145;144;145;145;145 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;95;96;95;96;97;96 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;57;57;57;57;58;67;56;56 18:58:18 INFO - 2015-11-05 18:58:18,170 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;70;67;68;68;77;68;69 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;85;92;91;83;86;86;85 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;113;120;119;114;117;120;110;114;129 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;146;147;136;145;145;138;142;144;144 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;67;64;65;66;65;63;63;67;64 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:58:18 INFO - 2015-11-05 18:58:18,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,935 18:58:18 INFO - 2015-11-05 18:58:18,172 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:58:18 INFO - 2015-11-05 18:58:18,172 DEBUG : BROWSER_OUTPUT: __startTimestamp1446778698167__endTimestamp 18:58:18 INFO - 2015-11-05 18:58:18,172 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,175 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:58:18 INFO - 2015-11-05 18:58:18,175 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:58:18 INFO - 2015-11-05 18:58:18,176 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,176 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.54 (3.2%) stddev-sans-first:3.74 18:58:18 INFO - 2015-11-05 18:58:18,176 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 107.0 111.0 112.0 111.0 100.0 109.0 112.0 109.0 18:58:18 INFO - 2015-11-05 18:58:18,176 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,177 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:146.50 stddev:17.08 (11.7%) stddev-sans-first:17.74 18:58:18 INFO - 2015-11-05 18:58:18,177 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 146.0 166.0 123.0 147.0 143.0 123.0 165.0 124.0 18:58:18 INFO - 2015-11-05 18:58:18,177 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,177 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 18:58:18 INFO - 2015-11-05 18:58:18,178 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 161.0 160.0 162.0 162.0 160.0 161.0 18:58:18 INFO - 2015-11-05 18:58:18,178 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,178 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:71.50 stddev:13.58 (19.0%) stddev-sans-first:13.93 18:58:18 INFO - 2015-11-05 18:58:18,178 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 80.0 96.0 71.0 71.0 71.0 100.0 104.0 72.0 18:58:18 INFO - 2015-11-05 18:58:18,179 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,179 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:90.00 stddev:22.71 (25.2%) stddev-sans-first:23.49 18:58:18 INFO - 2015-11-05 18:58:18,179 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 90.0 91.0 90.0 143.0 90.0 91.0 133.0 18:58:18 INFO - 2015-11-05 18:58:18,179 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,179 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:58:18 INFO - 2015-11-05 18:58:18,180 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 18:58:18 INFO - 2015-11-05 18:58:18,180 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,180 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 18:58:18 INFO - 2015-11-05 18:58:18,180 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 144.0 145.0 144.0 145.0 145.0 145.0 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 96.0 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.50 stddev:3.23 (5.6%) stddev-sans-first:3.42 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 57.0 57.0 57.0 57.0 58.0 67.0 56.0 56.0 18:58:18 INFO - 2015-11-05 18:58:18,181 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:68.50 stddev:2.86 (4.2%) stddev-sans-first:3.03 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 70.0 67.0 68.0 68.0 77.0 68.0 69.0 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.50 stddev:3.09 (3.6%) stddev-sans-first:3.08 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 85.0 92.0 91.0 83.0 86.0 86.0 85.0 18:58:18 INFO - 2015-11-05 18:58:18,182 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,183 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:119.00 stddev:5.28 (4.4%) stddev-sans-first:5.57 18:58:18 INFO - 2015-11-05 18:58:18,183 DEBUG : BROWSER_OUTPUT: Values: 119.0 113.0 120.0 119.0 114.0 117.0 120.0 110.0 114.0 129.0 18:58:18 INFO - 2015-11-05 18:58:18,183 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.00 stddev:3.62 (2.5%) stddev-sans-first:3.71 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 136.0 145.0 145.0 138.0 142.0 144.0 144.0 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.57 (2.4%) stddev-sans-first:1.54 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: Values: 63.0 67.0 64.0 65.0 66.0 65.0 63.0 63.0 67.0 64.0 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:58:18 INFO - 2015-11-05 18:58:18,184 DEBUG : BROWSER_OUTPUT: 18:58:18 INFO - 2015-11-05 18:58:18,994 INFO : Browser exited with error code: 0 18:58:19 INFO - 2015-11-05 18:58:19,047 INFO : Completed test kraken (00:00:58) 18:58:19 INFO - 2015-11-05 18:58:19,047 INFO : Starting test v8_7 18:58:19 INFO - 2015-11-05 18:58:19,047 DEBUG : operating with platform_type : linux_ 18:58:19 INFO - 2015-11-05 18:58:19,047 INFO : Initialising browser for v8_7 test... 18:58:19 INFO - 2015-11-05 18:58:19,054 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmbpALX/profile http://localhost:59070/getInfo.html 18:58:22 INFO - 2015-11-05 18:58:22,708 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:58:22 INFO - 2015-11-05 18:58:22,708 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:58:22 INFO - 2015-11-05 18:58:22,708 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:58:22 INFO - 2015-11-05 18:58:22,708 DEBUG : BROWSER_OUTPUT: __metrics 18:58:22 INFO - 2015-11-05 18:58:22,785 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: console.error: 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: Stack: 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:58:23 INFO - 2015-11-05 18:58:23,406 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:58:23 INFO - 2015-11-05 18:58:23,407 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:58:23 INFO - 2015-11-05 18:58:23,407 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:58:23 INFO - 2015-11-05 18:58:23,407 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:58:23 INFO - 2015-11-05 18:58:23,407 DEBUG : BROWSER_OUTPUT: 18:58:23 INFO - 2015-11-05 18:58:23,924 INFO : Browser initialized. 18:58:23 INFO - 2015-11-05 18:58:23,924 INFO : Running cycle 1/1 for v8_7 test... 18:58:23 INFO - 2015-11-05 18:58:23,925 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmbpALX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:58:35 INFO - 2015-11-05 18:58:35,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 18:58:35 INFO - 2015-11-05 18:58:35,646 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59070/tests/v8_7/run.html (next: http://localhost:59070/tests/v8_7/run.html) 18:58:57 INFO - 2015-11-05 18:58:57,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 632598528 18:58:57 INFO - 2015-11-05 18:58:57,295 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,295 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:58:57 INFO - 2015-11-05 18:58:57,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:58:57 INFO - 2015-11-05 18:58:57,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |0;Richards;163.21201240411295 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.97568506368196 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.6901408450704 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1112.2222222222222 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |5;Earley;786.1635220125786 18:58:57 INFO - 2015-11-05 18:58:57,296 DEBUG : BROWSER_OUTPUT: |6;Boyer;11720.93023255814 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: |8;Splay;663.1299734748011 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: __startTimestamp1446778737292__endTimestamp 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,297 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.21 Median:163.21 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: Values: 163.2 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.98 Median:192.98 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,298 DEBUG : BROWSER_OUTPUT: Values: 193.0 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.69 Median:281.69 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: Values: 281.7 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,299 DEBUG : BROWSER_OUTPUT: Values: 5030.2 18:58:57 INFO - 2015-11-05 18:58:57,300 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,300 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1112.22 Median:1112.22 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,300 DEBUG : BROWSER_OUTPUT: Values: 1112.2 18:58:57 INFO - 2015-11-05 18:58:57,300 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,300 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: Values: 786.2 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11720.93 Median:11720.93 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: Values: 11720.9 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: Values: 25100.0 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:663.13 Median:663.13 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: Values: 663.1 18:58:57 INFO - 2015-11-05 18:58:57,301 DEBUG : BROWSER_OUTPUT: 18:58:57 INFO - 2015-11-05 18:58:57,302 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:58:57 INFO - 2015-11-05 18:58:57,302 DEBUG : BROWSER_OUTPUT: Values: 4835.7 18:58:57 INFO - 2015-11-05 18:58:57,302 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:58:57 INFO - 2015-11-05 18:58:57,302 DEBUG : BROWSER_OUTPUT: 18:58:58 INFO - 2015-11-05 18:58:58,157 INFO : Browser exited with error code: 0 18:58:58 INFO - 2015-11-05 18:58:58,169 INFO : Completed test v8_7 (00:00:39) 18:58:58 INFO - 2015-11-05 18:58:58,312 INFO : Completed test suite (00:20:10) 18:58:58 INFO - 2015-11-05 18:58:58,312 DEBUG : Working with test: dromaeo_css 18:58:58 INFO - 2015-11-05 18:58:58,312 DEBUG : Generating results file: dromaeo_css 18:58:58 INFO - 2015-11-05 18:58:58,313 DEBUG : Working with test: kraken 18:58:58 INFO - 2015-11-05 18:58:58,313 DEBUG : Generating results file: kraken 18:58:58 INFO - 2015-11-05 18:58:58,314 INFO : javascript benchmark 18:58:58 INFO - 2015-11-05 18:58:58,314 DEBUG : Working with test: v8_7 18:58:58 INFO - 2015-11-05 18:58:58,314 DEBUG : Generating results file: v8_7 18:58:58 INFO - 2015-11-05 18:58:58,314 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:58 INFO - 2015-11-05 18:58:58,374 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 18:58:58 INFO - 2015-11-05 18:58:58,374 DEBUG : process_Request line: dromaeo_css 6928.89 graph.html#tests=[[72,1,35]] 18:58:58 INFO - 2015-11-05 18:58:58,374 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:58 INFO - 2015-11-05 18:58:58,413 DEBUG : process_Request line: kraken 1485.60 graph.html#tests=[[232,1,35]] 18:58:58 INFO - 2015-11-05 18:58:58,413 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:58:58 INFO - 2015-11-05 18:58:58,466 DEBUG : process_Request line: v8_7 21028.21 graph.html#tests=[[230,1,35]] 18:58:58 INFO - 2015-11-05 18:58:58,467 INFO : javascript benchmark 18:58:58 INFO - 2015-11-05 18:58:58,471 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [352.09160366255065, 352.13902009586553, 353.5245095346759, 354.36037951497536, 356.891148199799, 17079.57301067474, 17580.384686535974, 18522.444326670222, 18991.810081899177, 19002.23991040357, 15293.082415055105, 15306.464273750422, 15449.613759656015, 17385.73921391177, 17391.652166956654, 4746.288056791474, 4870.4885986971385, 5162.793488260465, 5326.946730532683, 5328.946710532884, 4854.101991131634, 4871.293662418947, 4871.5615594596475, 4874.683145595525, 4875.8781030474165, 3479.1128262293078, 3561.893143205695, 4734.715917044989, 4897.363342765436, 4966.15575352191, 4125.773082480462, 4986.925196122061, 5001.8499445016705, 5003.849884503471, 5022.598192144638, 4218.430511880918, 4288.9142217155795, 4310.48274207094, 4319.848805291831, 4322.222000039991, 11310.264832785842, 11770.705732356673, 13195.142315749446, 13401.66495837602, 13692.589222323346, 2070.6583413736867, 2100.674395468705, 2125.798049185325, 2186.081845624841, 2239.507308392151, 9882.752931176707, 10014.349067310673, 10067.89932100677, 10081.49592520371, 10223.182145428347, 1657.113444307302, 1660.8173100958884, 1661.3935913391647, 1670.7076261654283, 1719.3724290633954, 63261.683691581246, 66611.333886661, 69304.6534767328, 69831.65084174597, 70539.0, 15347.462838800811, 15583.922080389526, 15819.999999999769, 15849.762253566205, 15988.162840918329, 23502.882485587463, 23729.406764831016, 23833.40416489567, 23835.880820596132, 23856.0, 8903.910960890438, 8955.955220223988, 9076.183143517115, 9082.272657186442, 9205.76985575366, 7462.104547454232, 7577.583232922132, 7581.658825352873, 7664.425168112414, 7675.207441414388, 8150.877736833952, 8258.215469530385, 8280.378971577156, 8284.50292982423, 8302.418830681794, 3107.1610665120743, 3128.765342599314, 3132.0, 3136.5138403547485, 3163.6994485523837, 444.9666275029321, 471.4107365792759, 491.268010664115, 499.4580879745444, 506.57194670503367, 11088.889111108947, 11394.658160255205, 11461.885381146081, 11682.357470339042, 12084.697882553006, 468.21340148550763, 520.0223579670196, 520.1365732883471, 521.9712915789668, 528.2736237673199, 6090.573659843769, 6505.243584232231, 6508.0, 6585.111010013683, 6589.934100658932, 557670.0, 558067.0, 564048.0, 574434.0, 575832.0, 78335.60832195803, 80573.59713201514, 82362.0, 82636.0, 83176.0, 569.3566270114827, 578.5227187570272, 580.2080160580776, 582.3855832097178, 582.5339728217409, 11534.750474977895, 11603.12976526747, 11683.240589361665, 11739.706507337385, 11764.411779411166, 36185.0, 36984.445233320985, 38588.80705596454, 39834.800825995684, 40045.59954400419, 49753.502464976336, 51268.230976534636, 53375.733121334146, 53431.19853202127, 53619.731901340245, 7024.4029257513685, 7097.219305876452, 7100.644967751695, 7106.111736032996, 7147.142342918883, 12249.14256002107, 12639.747205055663, 12672.683182920133, 12683.175593586388, 12971.0, 10834.187435942493, 10842.241043126905, 10983.725406864573, 11021.063209627271, 11043.840396758225, 10728.463576820972, 11017.779644407226, 11056.944715276371, 11088.833667494833, 11161.55353785872, 10973.067289280181, 11240.0, 11298.0, 11349.262297950607, 11429.0, 6164.876702466016, 6205.689715514297, 6946.235914049552, 6959.338862808025, 7009.334113259232, 10657.94671026671, 10748.72039042976, 10989.230753847154, 10990.560377584807, 11053.944730276296], "dojo.html": [3184.7770656054076, 3288.408086544421, 3306.735461163107, 3308.2887179256454, 3310.2882880180773, 5284.630075894689, 5370.624056316059, 5531.336239651242, 5534.142207957768, 5542.0024395608825, 5392.325959255093, 5393.487618676229, 5436.130219164925, 5456.48163424475, 5573.693446860421, 4849.175640141185, 4963.1810751226185, 4977.676451030689, 5107.642465027449, 5122.206058061007, 5018.447970723218, 5066.949330506684, 5126.948730512703, 5138.820141295056, 5194.58443324535, 4846.951530484703, 4916.827911023097, 4948.925766113512, 5026.321446604698, 5037.017781532602, 4990.5508504234795, 4996.200607902754, 4997.625178111656, 5012.27322038306, 5025.522575355372, 4964.404271487445, 4983.551480366785, 4986.351774269358, 4996.750162491897, 5037.5718063964605, 5176.637635365526, 5182.948170518284, 5267.1835865440535, 5275.4460781618145, 5329.147336426153, 5970.313413957364, 5980.162777211194, 5980.491658209057, 5984.910226346608, 5992.580519363646, 5736.483716465538, 6010.609310394854, 6021.307549631804, 6030.09548567714, 6040.335563088057, 5466.644668096601, 5497.340319161726, 5556.499915007588, 5561.777528898799, 5615.691136987464, 6058.363871793486, 6059.818205453844, 6088.992974238861, 6089.5737298388685, 6095.2685677718955, 5648.689322087324, 5778.451047150514, 5901.940980590139, 5931.7627294907725, 5958.493528050078, 5803.361630220672, 5873.148393482921, 5875.177475153482, 5879.5002424794375, 5925.585209035412, 5905.763769449174, 5927.229460170151, 5934.258217722785, 5935.643861368246, 5938.910916336258, 5731.77072917087, 5781.335146458211, 5863.853403664943, 5924.851878703067, 5928.733207005609, 4549.567791059844, 4551.0, 4554.43069616298, 4587.4036375271, 4597.218472859622, 4035.0921042765144, 4037.8990525237105, 4038.1318016626565, 4063.065494936181, 4079.8164082616354, 5303.549198318186, 5391.946080539223, 5541.224228607998, 5657.8019769307875, 5668.688222147822, 5976.641401515836, 5978.4021597839865, 6006.939930600725, 6008.909866352008, 6013.789517366871, 5622.690752008679, 5646.153077038395, 5652.293463317085, 5653.632513886584, 5654.660720356792, 5086.643934924594, 5116.181410974226, 5190.6107041972, 5197.402298735694, 5225.555827754683, 6077.817665470043, 6081.817545473643, 6088.238970128734, 6090.665013424305, 6227.283862355887, 5808.448197421239, 5965.671888046026, 5983.581149319506, 5987.550933679904, 5994.310654274815, 6069.605475644069, 6105.053716673922, 6120.17377654011, 6125.295591007091, 6126.23422072241, 5826.621269617462, 5848.707564621667, 5849.473547380756, 5851.093080572518, 5853.0, 5687.0, 5814.0, 5902.291724993029, 5916.26046744157, 5918.2898052234, 5775.364709881826, 5850.53195744348, 5859.677717725566, 5865.648061116347, 5904.675242861684, 5766.711664416846, 5785.218995435563, 5786.276715410574, 5786.276715410574, 5790.392008839011, 5524.613277070566, 5629.043062679272, 5664.178694089252, 5700.572457065654, 5702.34423041339, 5790.449907258803, 5803.12953057028, 5831.096180092092, 5833.708314584169, 5858.384869588802, 5671.801486948102, 5686.800961966312, 5709.3719690834805, 5710.972025035533, 5742.598018138858], "mootools.html": [1322.0547308674295, 1485.3464475630724, 1486.6877955629318, 1672.665466906619, 1824.0514932235246, 7026.40275576576, 7417.5920324382205, 7617.695292188313, 7624.809379765508, 7630.732924347649, 7779.2998630123275, 7868.606569671508, 7874.606269686507, 7900.604969751504, 7905.762827115182, 2253.8422310438277, 2270.500489892221, 2270.9545809083806, 2274.863508189506, 2274.8976296066635, 2227.6658501224783, 2231.3306008197555, 2231.8102961248233, 2236.1614394602025, 2305.4812667149927, 2236.854604450714, 2246.3822448826622, 2247.5617254635354, 2249.7862703043184, 2280.9393631961134, 2238.9216377426874, 2256.8758718270487, 2267.2291420916968, 2270.6594010898416, 2270.852394594346, 2268.8638681679154, 2277.908883644652, 2280.680704701343, 2282.4179834142356, 2282.7146606674164, 6911.827204319882, 7063.1524217093765, 7761.18507556704, 7787.922120778776, 7793.688252469894, 4235.195312890572, 4553.521880202564, 4610.631149508032, 4617.30740388941, 4619.9076018479445, 3096.752259819209, 3132.4674805283157, 3132.7023932726584, 3148.889788857402, 3256.96743032569, 971.2618410008374, 997.4165113408665, 1015.6242190389603, 1028.280203857303, 1044.4777611194402, 10660.786784264348, 10772.515236814284, 10774.030337269605, 10784.0, 10791.028807407292, 4048.1903619276263, 4133.7106402551535, 4195.098053918422, 4209.031922657745, 4216.219999300078, 8769.079246679134, 8790.956045219733, 8791.032986371494, 8792.60433280504, 8794.780130496789, 4676.953230467651, 4677.321788340671, 4681.040386720714, 4700.95299047012, 4709.693869898446, 4345.695801293942, 4354.107407981356, 4354.6951713380395, 4355.455568053993, 4361.738295702205, 3449.5170676105367, 3530.805805680661, 3533.4699795030438, 3543.3976224041457, 3562.7149828014217, 1049.732318258839, 1065.717584840018, 1070.0583486531802, 1082.355998181081, 1082.9350238985687, 1106.9225154239125, 1109.839073334362, 1151.7696460707891, 1200.6698158006618, 1397.4200706706806, 7406.481546291816, 7462.514936529217, 7466.141393739789, 7467.290607392289, 7467.7012919483695, 477.81365267545686, 480.79325889866993, 492.32059757534375, 492.8004158315888, 494.80949834313327, 5630.8029218977135, 5955.612885162451, 6001.789937352259, 6018.939810601925, 6024.036154215304, 8617.913820861837, 9089.22741566961, 9260.629574817067, 9297.16325530692, 9307.488088155216, 9043.547822608843, 9052.728418147466, 9132.406393584528, 9138.954305228564, 9160.496172710431, 7354.448416368794, 7424.96287518559, 7430.071241094864, 7442.06974128234, 7447.069116360455, 7216.7113315466795, 7286.96356518214, 7332.853342933218, 7336.926630733625, 7350.0, 8231.753047408587, 8328.83342333162, 8361.456505327134, 8368.623411946599, 8390.916090839257, 8350.874736879074, 8495.235428811437, 8540.14598540141, 8541.316694664536, 8572.4427912188, 7297.124345078624, 7379.667914943733, 7380.298871607189, 7380.815479612837, 7382.5570465772225, 7412.481126321106, 7488.101427828696, 7520.548767073993, 7536.8492630148185, 7661.923380766121, 7071.575705457689, 7189.784306470814, 7270.854582908418, 7306.013688152244, 7329.230430804902, 6944.0, 7054.118235220598, 7063.39961103312, 7079.716811327489, 7221.097362829646, 7120.1099862517185, 7155.713771449084, 7157.391621712213, 7173.426125910019, 7180.928190718235, 6280.120783090462, 6366.076918846834, 6374.649394283359, 6631.767888123893, 6663.700133493908, 6475.643839588868, 6577.2436169841085, 6627.602343859384, 6658.1011563438315, 6658.800235992928], "ext.html": [549.3223913136611, 582.205289779451, 587.9500242479388, 604.4227762486822, 609.561115996483, 39985.60014399855, 40901.79549102254, 40912.38631420531, 40943.79528102363, 40962.7951860241, 43795.343069853974, 44264.11471770563, 44315.55684443154, 44324.113517729624, 44328.335074973904, 7532.058492688414, 7640.159582445955, 8717.738467845975, 8866.512341821197, 8884.200421962023, 10505.317154384978, 10694.0, 10747.5163617637, 10783.083437907748, 10797.190210734227, 10437.634682786103, 10550.683479495627, 10556.577736890515, 10557.683269501927, 10561.207909406787, 7769.0, 7956.602169891482, 10327.483625818717, 10477.318974266724, 10750.354978701303, 10191.286609937308, 10317.638882639072, 10329.431881246528, 10332.225083118721, 10336.79326413475, 41200.0, 41706.37440438396, 41718.58281417177, 41808.0, 41823.7908810457, 3406.0, 3629.1834337274167, 3703.518542589446, 3882.301185786557, 4155.0, 30037.0, 30086.84956575225, 30790.846045769627, 31198.22004449884, 31540.842295788374, 3585.4442561403025, 3633.7819730816236, 3637.254362855608, 3646.4165733482782, 3657.817109144559, 299334.0, 299442.0, 299562.0, 299745.5165414263, 300590.0, 54385.72807136018, 55528.44471555233, 57914.4208557909, 58281.0, 58516.7074164635, 61909.38090619036, 62399.6880015597, 62675.6866215666, 62751.37248627547, 62754.68622656858, 15466.381344746083, 15720.606984825243, 15747.055176689435, 15753.0, 15763.763543546627, 11976.520939162336, 12099.274043557414, 12116.454759535665, 12158.696032599079, 12160.148789584644, 18659.0, 18894.90552547256, 19447.8055219446, 19586.31447899317, 19590.608187836162, 7790.688372465152, 8005.239502247277, 8025.7993550160545, 8057.6776928923355, 8193.035919468404, 985.6008316631776, 999.415342024909, 1030.2768123076382, 1040.9687709368732, 1111.3887361950895, 29026.0, 29113.85443072771, 29394.853025734734, 29549.409011819644, 29625.703742962727, 1060.6340812419703, 1060.798448294837, 1084.5336505302637, 1118.3960661242838, 1125.729824842032, 14532.0554163979, 14692.191929443983, 15659.686806263811, 16027.519174424553, 16194.0, 532440.0, 544777.0, 544933.0, 545276.0, 546076.0, 52380.73809630927, 52754.0, 52821.0, 52834.471655282956, 52840.471595283554, 1343.7917122845975, 1355.8711922367556, 1361.0404664711355, 1362.1418506340942, 1367.9452821887212, 24893.0, 27827.0, 28031.719682803727, 28885.711142888304, 29361.706382935896, 48844.75577622089, 49087.75456122697, 49148.75425622849, 49213.0, 49272.29002404902, 282249.0, 287663.0, 287688.0, 288207.0, 288236.0, 28106.71893281041, 28208.0, 31360.902368416995, 32448.675513244565, 32540.51189232116, 38403.807980959915, 38756.2248755029, 39159.0, 39172.80413597914, 39541.0, 35554.288914221055, 35830.82084589561, 36097.27805443929, 36999.56005279384, 37051.25897482089, 35589.644103559665, 35688.464673029404, 35767.3446378415, 35873.64126358703, 36248.275034498634, 35112.64887351196, 35516.467252991744, 35617.46573801343, 35940.0, 36009.0997725059, 30578.0, 31316.74733010654, 33026.83486582552, 33068.66931330656, 33107.172320692174, 24233.394165145306, 24304.513909721354, 24620.50758984846, 24958.0, 24989.75010249947], "prototype.html": [327.27671845222056, 331.6302322909956, 334.3013102615533, 336.99663003369966, 345.56976564177603, 5754.309482862062, 5851.912221316684, 5880.411958804118, 5894.793682221123, 5898.02682557378, 5625.578081643873, 5682.687452190128, 5719.6854173020465, 5734.655920644765, 5753.108268218422, 4448.04367061081, 4456.974895773974, 4465.30787727901, 4470.26240670289, 4473.261911784552, 4383.802728877192, 4442.267025940716, 4453.755043472608, 4455.398521199645, 4504.279315309551, 4450.465944086714, 4456.17560751262, 4460.107978404316, 4463.977680111595, 4468.664850136237, 4434.512203657595, 4440.933385999197, 4443.688941774077, 4454.2873140297725, 4458.554144585548, 3933.174033452978, 3934.567197608261, 3937.606239376068, 3941.960580394188, 3944.5069366329208, 5448.7548060336985, 5527.811520523107, 5546.667199967975, 5573.247611572427, 5574.888502229973, 5129.25625784263, 5136.717480538568, 5139.12634852076, 5144.845654630367, 5152.9484705152845, 5902.970485147547, 6054.364291749391, 6099.176611157482, 6099.9085013724825, 6103.664298463583, 4170.249355116078, 4221.767802770846, 4241.533431322583, 4260.637845783112, 4261.97869010653, 6220.284667263278, 6279.058141278799, 6309.842253943642, 6316.494680425555, 6322.051692246107, 4359.237133501624, 4367.10474352757, 4367.47590289161, 4367.5414081520985, 4369.43197384338, 4364.650827933758, 4418.138462999748, 4419.005723712204, 4421.40311058003, 4460.620847227957, 5097.617678674114, 5119.897602047939, 5123.5132662397755, 5124.56441202502, 5126.538611524906, 6087.665178415141, 6128.0, 6133.26400831903, 6143.109249158847, 6143.232095988002, 1577.7791109244715, 1610.074207330766, 1611.8629916456998, 1611.927463264156, 1614.6044219166379, 1055.8732952045805, 1062.8033813744328, 1068.1027936533349, 1073.5061871539178, 1092.956281748737, 6034.426729460694, 6039.033754599243, 6048.697565121726, 6049.092636104531, 6049.546284028627, 6382.489400847921, 6400.007998760199, 6401.551891367652, 6405.0, 6410.583312084699, 5980.73086711099, 6012.759489620454, 6032.306284777307, 6032.698365081728, 6033.0, 3484.198634314071, 3529.435290353531, 3531.346700860349, 3557.5375201223674, 3560.430331147004, 6620.602763834186, 6624.470042396597, 6624.56940298879, 6633.635150066696, 6638.900416493757, 6555.475561955032, 6559.409653131241, 6574.638394888231, 6576.276609572943, 6578.605283682994, 6463.15978922737, 6712.12742343502, 6712.295209002984, 6720.193576770819, 6722.0, 6222.315545289924, 6299.748010079546, 6467.417932386108, 6468.8706225874275, 6471.935280647322, 6293.96853015732, 6324.905126423199, 6339.366063393808, 6339.524535659936, 6378.9362106380195, 6642.535022548375, 6645.202575690754, 6649.069130321662, 6652.168478940132, 6652.467802575879, 4469.3966314548425, 4515.503294637521, 4574.817007319803, 4575.153596584642, 4579.381783459324, 6344.238691357066, 6344.682765861596, 6346.270178929298, 6350.90473642905, 6353.0152826312, 6151.6001459904965, 6165.0, 6165.260168779775, 6179.351168127282, 6181.196444462191, 6109.297430795337, 6162.291336496181, 6170.969145154425, 6172.876542469216, 6175.2589689237575, 6101.023836186189, 6114.633122012693, 6119.785807496716, 6120.418560236771, 6126.172966649446, 6211.65835879013, 6248.218972628421, 6251.6874156292915, 6253.624782513064, 6256.468200203034, 6007.279126504847, 6103.267607886904, 6110.511159107172, 6116.052011938156, 6117.510599152146], "yui.html": [783.1929947737689, 788.6845261895245, 836.5440834745064, 848.4909054567261, 850.7065062553417, 12964.74070518589, 13192.868071319284, 13206.0, 13212.339383030834, 13245.933770331136, 12576.748465030694, 12584.0, 13871.653208669788, 13901.096428732126, 13909.513167039157, 708.6421357214625, 714.242902523327, 853.6329378367315, 868.9131086891292, 870.0125357719003, 860.7159637319669, 863.9222469977701, 868.5049521772593, 873.5981448533682, 874.54960695242, 891.2647066170402, 897.2821742605922, 898.1602201941173, 898.2723993565234, 903.9864402033975, 731.9377852882485, 737.2001378504356, 886.4592598514932, 888.6401007591936, 906.0622255965045, 659.5350278054009, 660.0495286787011, 660.9173853268342, 666.1140682891743, 668.3283300283184, 13087.738245235138, 13129.60611181666, 13147.276899770508, 13171.078024538287, 13205.603831885059, 12801.103922725413, 13075.346232688422, 13389.464421423132, 13429.932850335686, 13455.865441345559, 10443.47782610874, 10462.319949203278, 10479.266451348409, 10594.41730704811, 10615.893841061568, 3603.9099022524383, 3620.167361506868, 3649.361361761681, 3676.889693309205, 3771.0, 42432.151356972994, 43456.130877382595, 50173.74913125447, 50280.49719502795, 50465.0, 7916.089649690244, 8000.919990800134, 8030.277275045274, 8071.071826739882, 8103.351731861437, 13102.868971310356, 13136.080474366703, 13145.342732863319, 13147.60557183286, 13163.802542961863, 7093.82265443368, 7201.0, 7231.204567497571, 7275.818104547323, 7513.962430187814, 4516.796744146522, 4524.5701658342405, 4535.25168347219, 4544.727316361029, 4546.204414227563, 2781.582762585628, 2806.943861122807, 2824.4351129774127, 2829.221963959886, 2830.9150725478266, 460.723565860481, 467.93448917151625, 471.19190588140816, 472.9408823897013, 480.92545655423464, 669.9833501161539, 688.4905170174135, 696.6795274173937, 707.2962402409636, 735.7167490516083, 8355.916440835636, 8442.851059194076, 8545.444546104483, 8704.173103555153, 8748.34387420946, 548.5200449606594, 637.5951270942985, 652.3541693723274, 653.2716021635841, 664.9401553860079, 4208.894777630522, 4642.396488456479, 4646.86059418218, 4655.51117132703, 4680.882977925511, 65270.0, 66886.0, 67122.66438667776, 67276.6636166816, 67326.66336668383, 54773.0, 54909.0, 55339.72330138324, 55393.0, 55618.0, 51791.741041294554, 51995.48004519982, 52116.47883521192, 52188.73905630523, 52992.47007529953, 9085.863712044193, 9236.21492173146, 9497.952510237405, 9509.476978766234, 9574.138327550554, 35186.824065879504, 35658.0, 36169.63830361663, 39511.407328889516, 40186.19627607373, 50438.49561504338, 50729.746351268004, 50837.74581127071, 50842.74578627083, 51579.74210129076, 8179.877301840358, 8206.097329293892, 8278.586070696561, 8310.376721746014, 8479.915200847912, 12569.811452828399, 12713.745725085631, 12849.581272831267, 12914.483420663068, 13115.606531804062, 11749.765004699688, 11826.231294965799, 11901.345426001653, 11970.341631210018, 11978.281303121841, 12007.762352590216, 12056.51773929033, 12066.3363515004, 12085.637430877088, 12221.938890305491, 10994.0, 11139.443027848738, 11211.439428028403, 11303.095752339628, 11305.660830175108, 10379.429131397847, 10559.52482138321, 10602.522886470282, 10888.67333979982, 11057.391843448688, 9895.55470003866, 9931.950340248253, 9944.0, 10074.748131296483, 10082.243831712798]}, "summary": {"suite": 6928.88714543357, "subtests": {"jquery.html": {"filtered": 8090.826327965197, "value": 8090.826327965197}, "dojo.html": {"filtered": 5448.979747305468, "value": 5448.979747305468}, "mootools.html": {"filtered": 4381.711222675774, "value": 4381.711222675774}, "ext.html": {"filtered": 19268.810879892597, "value": 19268.810879892597}, "prototype.html": {"filtered": 4681.03024132849, "value": 4681.03024132849}, "yui.html": {"filtered": 6350.276330328567, "value": 6350.276330328567}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446777528, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105163015", "branch": "Firefox", "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 161.0, 161.0, 161.0, 160.0, 162.0, 162.0, 160.0, 161.0], "ai-astar": [110.0, 110.0, 107.0, 111.0, 112.0, 111.0, 100.0, 109.0, 112.0, 109.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "audio-beat-detection": [151.0, 123.0, 146.0, 166.0, 123.0, 147.0, 143.0, 123.0, 165.0, 124.0], "json-stringify-tinderbox": [69.0, 68.0, 68.0, 70.0, 67.0, 68.0, 68.0, 77.0, 68.0, 69.0], "stanford-crypto-pbkdf2": [146.0, 146.0, 147.0, 136.0, 145.0, 145.0, 138.0, 142.0, 144.0, 144.0], "json-parse-financial": [59.0, 59.0, 57.0, 57.0, 57.0, 57.0, 58.0, 67.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [63.0, 67.0, 64.0, 65.0, 66.0, 65.0, 63.0, 63.0, 67.0, 64.0], "audio-fft": [71.0, 73.0, 80.0, 96.0, 71.0, 71.0, 71.0, 100.0, 104.0, 72.0], "imaging-darkroom": [145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 144.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [119.0, 113.0, 120.0, 119.0, 114.0, 117.0, 120.0, 110.0, 114.0, 129.0], "audio-oscillator": [90.0, 90.0, 135.0, 90.0, 91.0, 90.0, 143.0, 90.0, 91.0, 133.0], "stanford-crypto-aes": [83.0, 84.0, 85.0, 85.0, 92.0, 91.0, 83.0, 86.0, 86.0, 85.0], "imaging-desaturate": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 96.0]}, "summary": {"suite": 1485.6, "subtests": {"audio-fft": {"filtered": 80.9, "value": 80.9}, "stanford-crypto-pbkdf2": {"filtered": 143.3, "value": 143.3}, "audio-beat-detection": {"filtered": 141.1, "value": 141.1}, "stanford-crypto-ccm": {"filtered": 117.5, "value": 117.5}, "imaging-darkroom": {"filtered": 144.8, "value": 144.8}, "json-parse-financial": {"filtered": 58.3, "value": 58.3}, "audio-oscillator": {"filtered": 104.3, "value": 104.3}, "ai-astar": {"filtered": 109.1, "value": 109.1}, "audio-dft": {"filtered": 160.9, "value": 160.9}, "stanford-crypto-sha256-iterative": {"filtered": 64.7, "value": 64.7}, "json-stringify-tinderbox": {"filtered": 69.2, "value": 69.2}, "imaging-gaussian-blur": {"filtered": 109.7, "value": 109.7}, "stanford-crypto-aes": {"filtered": 86.0, "value": 86.0}, "imaging-desaturate": {"filtered": 95.8, "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446777528, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105163015", "branch": "Firefox", "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.97568506368196], "Encrypt": [281.6901408450704], "NavierStokes": [4835.748792270531], "Decrypt": [5030.150753768844], "Splay": [663.1299734748011], "Richards": [163.21201240411295], "RegExp": [25100.0], "Earley": [786.1635220125786], "Boyer": [11720.93023255814], "RayTrace": [1112.2222222222222]}, "summary": {"suite": 21028.207123408243, "subtests": {"DeltaBlue": {"filtered": 342.6234759999999, "value": 342.6234759999999}, "Encrypt": {"filtered": 944.9425500000004, "value": 944.9425500000004}, "NavierStokes": {"filtered": 306.881118881119, "value": 306.881118881119}, "Decrypt": {"filtered": 52.91710189810189, "value": 52.91710189810189}, "Splay": {"filtered": 122.88842799999998, "value": 122.88842799999998}, "RegExp": {"filtered": 36.294223107569735, "value": 36.294223107569735}, "Richards": {"filtered": 216.29535399999995, "value": 216.29535399999995}, "Earley": {"filtered": 847.7409359999999, "value": 847.7409359999999}, "Boyer": {"filtered": 56.86093055555553, "value": 56.86093055555553}, "RayTrace": {"filtered": 665.324775224775, "value": 665.324775224775}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1446777528, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151105163015", "branch": "Firefox", "revision": "dae6c2b8fef8a2f504baab5dae7ccd59d57a1d9d"}}] 18:58:58 INFO - RETURN: dromaeo_css: 6928.89 18:58:58 INFO - RETURN: kraken: 1485.60 18:58:58 INFO - RETURN: v8_7: 21028.21 18:58:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21028.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1485.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6928.89"}}} 18:58:58 INFO - Return code: 0 18:58:58 INFO - # TBPL SUCCESS # 18:58:58 INFO - Running post-action listener: _resource_record_post_action 18:58:58 INFO - Running post-run listener: _resource_record_post_run 18:58:59 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 497541120; Read time: 12; Write time: 406852 18:58:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 221163520; Read time: 0; Write time: 226912 18:58:59 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 263430144; Read time: 12; Write time: 178668 18:58:59 INFO - Running post-run listener: _upload_blobber_files 18:58:59 INFO - Blob upload gear active. 18:58:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:58:59 INFO - Copying logs to upload dir... 18:58:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.147311 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-11-05 18:58:59.423280) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 18:58:59.427288) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010007 build_url: 'https://queue.taskcluster.net/v1/task/M7XWWgqsSSur869OamAfGw/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-05 18:58:59.477328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:58:59.477840) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1446776763.215294-2032619360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 18:58:59.527921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 18:58:59.528246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 18:58:59.528536) ========= ========= Total master_lag: 0.22 =========