builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1447760795.2 results: success (0) buildid: 20151117013036 builduid: 73b1a5f5ce0d4c87aff898b693ece5db revision: e61e64f29a004f9a3042810a093b24dabbf56731 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.195967) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.196448) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.196744) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006672 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.218220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.218528) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.242678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.243457) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.292336) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.292623) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.292984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.293272) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 03:46:35-- 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% 223M=0s 2015-11-17 03:46:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.492546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.492836) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014320 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.542304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:35.542612) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e61e64f29a004f9a3042810a093b24dabbf56731 --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 e61e64f29a004f9a3042810a093b24dabbf56731 --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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 03:46:36,235 truncating revision to first 12 chars 2015-11-17 03:46:36,235 Setting DEBUG logging. 2015-11-17 03:46:36,235 attempt 1/10 2015-11-17 03:46:36,235 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e61e64f29a00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 03:46:36,895 unpacking tar archive at: mozilla-central-e61e64f29a00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.935412 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:36.491054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:36.491353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:36.498490) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:36.498782) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 03:46:36.499190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-17 03:46:36.499484) ========= /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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:37 INFO - MultiFileLogger online at 20151117 03:46:37 in /builds/slave/test-pgo 03:46: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 03:46:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:37 INFO - {'append_to_log': False, 03:46:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:37 INFO - 'blob_upload_branch': 'Firefox', 03:46:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:37 INFO - 'branch': 'Firefox', 03:46:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:37 INFO - 'config_files': ('talos/linux_config.py',), 03:46:37 INFO - 'default_actions': ('clobber', 03:46:37 INFO - 'read-buildbot-config', 03:46:37 INFO - 'download-and-extract', 03:46:37 INFO - 'populate-webroot', 03:46:37 INFO - 'create-virtualenv', 03:46:37 INFO - 'install', 03:46:37 INFO - 'run-tests'), 03:46:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:37 INFO - 'download_minidump_stackwalk': True, 03:46:37 INFO - 'download_symbols': 'ondemand', 03:46:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:37 INFO - 'installer_path': 'installer.exe', 03:46:37 INFO - 'log_level': 'info', 03:46:37 INFO - 'log_name': 'talos', 03:46:37 INFO - 'log_to_console': True, 03:46:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:37 INFO - 'opt_config_files': (), 03:46:37 INFO - 'pip_index': False, 03:46:37 INFO - 'sps_profile': False, 03:46:37 INFO - 'sps_profile_interval': 0, 03:46:37 INFO - 'suite': 'dromaeojs', 03:46:37 INFO - 'system_bits': '64', 03:46:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:37 INFO - 'title': 'talos-linux64-ix-057', 03:46:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:37 INFO - 'use_talos_json': True, 03:46:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:37 INFO - 'work_dir': 'build'} 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running clobber step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: clobber 03:46:37 INFO - rmtree: /builds/slave/test-pgo/build 03:46:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:37 INFO - Running post-action listener: _resource_record_post_action 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running read-buildbot-config step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: read_buildbot_config 03:46:37 INFO - Using buildbot properties: 03:46:37 INFO - { 03:46:37 INFO - "properties": { 03:46:37 INFO - "buildnumber": 561, 03:46:37 INFO - "product": "firefox", 03:46:37 INFO - "script_repo_revision": "production", 03:46:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:46:37 INFO - "repository": "", 03:46:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 03:46:37 INFO - "buildid": "20151117013036", 03:46:37 INFO - "slavename": "talos-linux64-ix-057", 03:46:37 INFO - "pgo_build": "True", 03:46:37 INFO - "basedir": "/builds/slave/test-pgo", 03:46:37 INFO - "project": "", 03:46:37 INFO - "platform": "ubuntu64_hw", 03:46:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:46:37 INFO - "slavebuilddir": "test", 03:46:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 03:46:37 INFO - "branch": "mozilla-central", 03:46:37 INFO - "repo_path": "mozilla-central", 03:46:37 INFO - "stage_platform": "linux64-pgo", 03:46:37 INFO - "builduid": "73b1a5f5ce0d4c87aff898b693ece5db", 03:46:37 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:37 INFO - }, 03:46:37 INFO - "sourcestamp": { 03:46:37 INFO - "repository": "", 03:46:37 INFO - "hasPatch": false, 03:46:37 INFO - "project": "", 03:46:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 03:46:37 INFO - "changes": [ 03:46:37 INFO - { 03:46:37 INFO - "category": null, 03:46:37 INFO - "files": [ 03:46:37 INFO - { 03:46:37 INFO - "url": null, 03:46:37 INFO - "name": "https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:46:37 INFO - } 03:46:37 INFO - ], 03:46:37 INFO - "repository": "", 03:46:37 INFO - "rev": "e61e64f29a004f9a3042810a093b24dabbf56731", 03:46:37 INFO - "who": "sendchange", 03:46:37 INFO - "when": 1447760719, 03:46:37 INFO - "number": 6671296, 03:46:37 INFO - "comments": "", 03:46:37 INFO - "project": "", 03:46:37 INFO - "at": "Tue 17 Nov 2015 03:45:19", 03:46:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 03:46:37 INFO - "revlink": "", 03:46:37 INFO - "properties": [ 03:46:37 INFO - [ 03:46:37 INFO - "buildid", 03:46:37 INFO - "20151117013036", 03:46:37 INFO - "Change" 03:46:37 INFO - ], 03:46:37 INFO - [ 03:46:37 INFO - "builduid", 03:46:37 INFO - "73b1a5f5ce0d4c87aff898b693ece5db", 03:46:37 INFO - "Change" 03:46:37 INFO - ], 03:46:37 INFO - [ 03:46:37 INFO - "pgo_build", 03:46:37 INFO - "True", 03:46:37 INFO - "Change" 03:46:37 INFO - ] 03:46:37 INFO - ], 03:46:37 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:37 INFO - } 03:46:37 INFO - ], 03:46:37 INFO - "revision": "e61e64f29a004f9a3042810a093b24dabbf56731" 03:46:37 INFO - } 03:46:37 INFO - } 03:46:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:46:37 INFO - Running post-action listener: _resource_record_post_action 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running download-and-extract step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: download_and_extract 03:46:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:37 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json 03:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json 03:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:38 INFO - Downloaded 1302 bytes. 03:46:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:38 INFO - Using the following test package requirements: 03:46:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'jsshell-linux-x86_64.zip'], 03:46:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:46:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:46:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:46:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:46:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:38 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:39 INFO - Downloaded 22461931 bytes. 03:46:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:40 INFO - Return code: 0 03:46:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:40 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:48 INFO - Downloaded 22461931 bytes. 03:46:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:46:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:49 INFO - Return code: 0 03:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:49 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:50 INFO - Downloaded 11131693 bytes. 03:46:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:46:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:46:50 INFO - Return code: 0 03:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:50 INFO - https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:46:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:46:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:46:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:51 INFO - Downloaded 57178026 bytes. 03:46:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:46:51 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:51 INFO - Contents: 03:46:51 INFO - build_url:https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:46:51 INFO - Running post-action listener: _resource_record_post_action 03:46:51 INFO - Running post-action listener: set_extra_try_arguments 03:46:51 INFO - ##### 03:46:51 INFO - ##### Running populate-webroot step. 03:46:51 INFO - ##### 03:46:51 INFO - Running pre-action listener: _resource_record_pre_action 03:46:51 INFO - Running main action method: populate_webroot 03:46:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:46:51 INFO - '../fennec_ids.txt'], 03:46:51 INFO - 'tests': ['tcheck2']}, 03:46:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:51 INFO - '--tppagecycles', 03:46:51 INFO - '7'], 03:46:51 INFO - 'tests': ['tsvgm']}}, 03:46:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'tests': ['damp', 'tps']}, 03:46:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['damp', 'tps']}, 03:46:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:51 INFO - 'other': {'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'other_l64': {'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:51 INFO - 'ts_paint', 03:46:51 INFO - 'tpaint', 03:46:51 INFO - 'sessionrestore', 03:46:51 INFO - 'sessionrestore_no_auto_restore']}, 03:46:51 INFO - 'svgr': {'tests': ['tsvgx', 03:46:51 INFO - 'tsvgr_opacity', 03:46:51 INFO - 'tart', 03:46:51 INFO - 'tscrollx', 03:46:51 INFO - 'cart']}, 03:46:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['tsvgx', 03:46:51 INFO - 'tsvgr_opacity', 03:46:51 INFO - 'tart', 03:46:51 INFO - 'tscrollx', 03:46:51 INFO - 'cart']}, 03:46:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'tests': ['tp5o']}, 03:46:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'talos_options': ['--e10s'], 03:46:51 INFO - 'tests': ['tp5o']}, 03:46:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'talos_options': ['--xperf_path', 03:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:51 INFO - 'tests': ['tp5n']}, 03:46:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:51 INFO - 'talos_options': ['--e10s', 03:46:51 INFO - '--xperf_path', 03:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:51 INFO - 'tests': ['tp5n']}}, 03:46:51 INFO - 'talos.zip': {'path': '', 03:46:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:51 INFO - Running post-action listener: _resource_record_post_action 03:46:51 INFO - ##### 03:46:51 INFO - ##### Running create-virtualenv step. 03:46:51 INFO - ##### 03:46:51 INFO - Running pre-action listener: _resource_record_pre_action 03:46:51 INFO - Running main action method: create_virtualenv 03:46:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:46:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:51 INFO - Using real prefix '/usr' 03:46:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:46:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:54 INFO - Installing pip.................done. 03:46:54 INFO - Return code: 0 03:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:46:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:46:54 INFO - Using env: {'DISPLAY': ':0', 03:46:54 INFO - 'HOME': '/home/cltbld', 03:46:54 INFO - 'LANG': 'en_US.UTF-8', 03:46:54 INFO - 'LANGUAGE': 'en_US:en', 03:46:54 INFO - 'LOGNAME': 'cltbld', 03:46:54 INFO - 'MAIL': '/var/mail/cltbld', 03:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:54 INFO - 'MOZ_NO_REMOTE': '1', 03:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:54 INFO - 'NO_EM_RESTART': '1', 03:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:54 INFO - 'SHELL': '/bin/bash', 03:46:54 INFO - 'SHLVL': '1', 03:46:54 INFO - 'TERM': 'linux', 03:46:54 INFO - 'TMOUT': '86400', 03:46:54 INFO - 'USER': 'cltbld', 03:46:54 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:54 INFO - '_': '/tools/buildbot/bin/python'} 03:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:46:54 INFO - Cleaning up... 03:46:54 INFO - Return code: 0 03:46:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:46:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:46:54 INFO - Using env: {'DISPLAY': ':0', 03:46:54 INFO - 'HOME': '/home/cltbld', 03:46:54 INFO - 'LANG': 'en_US.UTF-8', 03:46:54 INFO - 'LANGUAGE': 'en_US:en', 03:46:54 INFO - 'LOGNAME': 'cltbld', 03:46:54 INFO - 'MAIL': '/var/mail/cltbld', 03:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:54 INFO - 'MOZ_NO_REMOTE': '1', 03:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:54 INFO - 'NO_EM_RESTART': '1', 03:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:54 INFO - 'SHELL': '/bin/bash', 03:46:54 INFO - 'SHLVL': '1', 03:46:54 INFO - 'TERM': 'linux', 03:46:54 INFO - 'TMOUT': '86400', 03:46:54 INFO - 'USER': 'cltbld', 03:46:54 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:54 INFO - '_': '/tools/buildbot/bin/python'} 03:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:54 INFO - Downloading/unpacking psutil>=0.7.1 03:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:46:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:56 INFO - Installing collected packages: psutil 03:46:56 INFO - Running setup.py install for psutil 03:46:56 INFO - building 'psutil._psutil_linux' extension 03:46:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:46:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:46:57 INFO - building 'psutil._psutil_posix' extension 03:46:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:46:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:46:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:57 INFO - Successfully installed psutil 03:46:57 INFO - Cleaning up... 03:46:57 INFO - Return code: 0 03:46:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:57 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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:46:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:46:57 INFO - Using env: {'DISPLAY': ':0', 03:46:57 INFO - 'HOME': '/home/cltbld', 03:46:57 INFO - 'LANG': 'en_US.UTF-8', 03:46:57 INFO - 'LANGUAGE': 'en_US:en', 03:46:57 INFO - 'LOGNAME': 'cltbld', 03:46:57 INFO - 'MAIL': '/var/mail/cltbld', 03:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:57 INFO - 'MOZ_NO_REMOTE': '1', 03:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:57 INFO - 'NO_EM_RESTART': '1', 03:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:57 INFO - 'SHELL': '/bin/bash', 03:46:57 INFO - 'SHLVL': '1', 03:46:57 INFO - 'TERM': 'linux', 03:46:57 INFO - 'TMOUT': '86400', 03:46:57 INFO - 'USER': 'cltbld', 03:46:57 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:57 INFO - '_': '/tools/buildbot/bin/python'} 03:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:46:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:59 INFO - Installing collected packages: mozsystemmonitor 03:46:59 INFO - Running setup.py install for mozsystemmonitor 03:46:59 INFO - Successfully installed mozsystemmonitor 03:46:59 INFO - Cleaning up... 03:46:59 INFO - Return code: 0 03:46:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:59 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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:46:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:46:59 INFO - Using env: {'DISPLAY': ':0', 03:46:59 INFO - 'HOME': '/home/cltbld', 03:46:59 INFO - 'LANG': 'en_US.UTF-8', 03:46:59 INFO - 'LANGUAGE': 'en_US:en', 03:46:59 INFO - 'LOGNAME': 'cltbld', 03:46:59 INFO - 'MAIL': '/var/mail/cltbld', 03:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:59 INFO - 'MOZ_NO_REMOTE': '1', 03:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:59 INFO - 'NO_EM_RESTART': '1', 03:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:59 INFO - 'SHELL': '/bin/bash', 03:46:59 INFO - 'SHLVL': '1', 03:46:59 INFO - 'TERM': 'linux', 03:46:59 INFO - 'TMOUT': '86400', 03:46:59 INFO - 'USER': 'cltbld', 03:46:59 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:59 INFO - '_': '/tools/buildbot/bin/python'} 03:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:01 INFO - Downloading docopt-0.6.1.tar.gz 03:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:01 INFO - Running setup.py install for blobuploader 03:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:47:02 INFO - Running setup.py install for requests 03:47:02 INFO - Running setup.py install for docopt 03:47:02 INFO - Successfully installed blobuploader requests docopt 03:47:02 INFO - Cleaning up... 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:47:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:02 INFO - Using env: {'DISPLAY': ':0', 03:47:02 INFO - 'HOME': '/home/cltbld', 03:47:02 INFO - 'LANG': 'en_US.UTF-8', 03:47:02 INFO - 'LANGUAGE': 'en_US:en', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MAIL': '/var/mail/cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SHLVL': '1', 03:47:02 INFO - 'TERM': 'linux', 03:47:02 INFO - 'TMOUT': '86400', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:02 INFO - Running setup.py (path:/tmp/pip-IuPV0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:02 INFO - Running setup.py (path:/tmp/pip-UzfR2O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:02 INFO - Running setup.py (path:/tmp/pip-d5dxrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:02 INFO - Running setup.py (path:/tmp/pip-ZniJeh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:03 INFO - Running setup.py (path:/tmp/pip-MkSsZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:03 INFO - Running setup.py (path:/tmp/pip-96ji6E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:03 INFO - Running setup.py (path:/tmp/pip-_NqGVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:03 INFO - Running setup.py (path:/tmp/pip-ttBSd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:03 INFO - Running setup.py (path:/tmp/pip-f3tBCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:03 INFO - Running setup.py (path:/tmp/pip-SaazpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:03 INFO - Running setup.py (path:/tmp/pip-FeparZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:03 INFO - Running setup.py (path:/tmp/pip-ZymwUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:03 INFO - Running setup.py (path:/tmp/pip-qRhQYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:03 INFO - Running setup.py (path:/tmp/pip-VbPJ4e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:03 INFO - Running setup.py (path:/tmp/pip-TgnHLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:03 INFO - Running setup.py (path:/tmp/pip-sXxhYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:03 INFO - Running setup.py (path:/tmp/pip-nUF3h8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:03 INFO - Running setup.py install for manifestparser 03:47:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Running setup.py install for mozcrash 03:47:04 INFO - Running setup.py install for mozdebug 03:47:04 INFO - Running setup.py install for mozdevice 03:47:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Running setup.py install for mozfile 03:47:04 INFO - Running setup.py install for mozhttpd 03:47:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Running setup.py install for mozinfo 03:47:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Running setup.py install for mozInstall 03:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:47:04 INFO - Running setup.py install for mozleak 03:47:04 INFO - Running setup.py install for mozlog 03:47:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Running setup.py install for moznetwork 03:47:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Running setup.py install for mozprocess 03:47:05 INFO - Running setup.py install for mozprofile 03:47:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Running setup.py install for mozrunner 03:47:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Running setup.py install for mozscreenshot 03:47:05 INFO - Running setup.py install for moztest 03:47:05 INFO - Running setup.py install for mozversion 03:47:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:05 INFO - Cleaning up... 03:47:05 INFO - Return code: 0 03:47:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:05 INFO - Using env: {'DISPLAY': ':0', 03:47:05 INFO - 'HOME': '/home/cltbld', 03:47:05 INFO - 'LANG': 'en_US.UTF-8', 03:47:05 INFO - 'LANGUAGE': 'en_US:en', 03:47:05 INFO - 'LOGNAME': 'cltbld', 03:47:05 INFO - 'MAIL': '/var/mail/cltbld', 03:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:05 INFO - 'MOZ_NO_REMOTE': '1', 03:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:05 INFO - 'NO_EM_RESTART': '1', 03:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:05 INFO - 'SHELL': '/bin/bash', 03:47:05 INFO - 'SHLVL': '1', 03:47:05 INFO - 'TERM': 'linux', 03:47:05 INFO - 'TMOUT': '86400', 03:47:05 INFO - 'USER': 'cltbld', 03:47:05 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:05 INFO - '_': '/tools/buildbot/bin/python'} 03:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:05 INFO - Running setup.py (path:/tmp/pip-5DU4Dc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:06 INFO - Running setup.py (path:/tmp/pip-fxgEeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:06 INFO - Running setup.py (path:/tmp/pip-RXL6dG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:06 INFO - Running setup.py (path:/tmp/pip-a6o4QV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:06 INFO - Running setup.py (path:/tmp/pip-ULYl_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:06 INFO - Running setup.py (path:/tmp/pip-9t1735-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:06 INFO - Running setup.py (path:/tmp/pip-AXib8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:06 INFO - Running setup.py (path:/tmp/pip-cey8S9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:06 INFO - Running setup.py (path:/tmp/pip-s1_HBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:06 INFO - Running setup.py (path:/tmp/pip-i_GBb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:06 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)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:06 INFO - Running setup.py (path:/tmp/pip-50OLUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:06 INFO - Running setup.py (path:/tmp/pip-6VdQ9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:06 INFO - Running setup.py (path:/tmp/pip-rhWE15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:06 INFO - Running setup.py (path:/tmp/pip-2bvGcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:07 INFO - Running setup.py (path:/tmp/pip-VaNmUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:07 INFO - Running setup.py (path:/tmp/pip-rbflp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:07 INFO - Running setup.py (path:/tmp/pip-5Yddrp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:08 INFO - Downloading blessings-1.5.1.tar.gz 03:47:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:47:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:08 INFO - Installing collected packages: blessings 03:47:08 INFO - Running setup.py install for blessings 03:47:09 INFO - Successfully installed blessings 03:47:09 INFO - Cleaning up... 03:47:09 INFO - Return code: 0 03:47:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:09 INFO - Reading from file tmpfile_stdout 03:47:09 INFO - Current package versions: 03:47:09 INFO - argparse == 1.2.1 03:47:09 INFO - blessings == 1.5.1 03:47:09 INFO - blobuploader == 1.2.4 03:47:09 INFO - docopt == 0.6.1 03:47:09 INFO - manifestparser == 1.1 03:47:09 INFO - mozInstall == 1.12 03:47:09 INFO - mozcrash == 0.16 03:47:09 INFO - mozdebug == 0.1 03:47:09 INFO - mozdevice == 0.47 03:47:09 INFO - mozfile == 1.2 03:47:09 INFO - mozhttpd == 0.7 03:47:09 INFO - mozinfo == 0.9 03:47:09 INFO - mozleak == 0.1 03:47:09 INFO - mozlog == 3.0 03:47:09 INFO - moznetwork == 0.27 03:47:09 INFO - mozprocess == 0.22 03:47:09 INFO - mozprofile == 0.27 03:47:09 INFO - mozrunner == 6.11 03:47:09 INFO - mozscreenshot == 0.1 03:47:09 INFO - mozsystemmonitor == 0.0 03:47:09 INFO - moztest == 0.7 03:47:09 INFO - mozversion == 1.4 03:47:09 INFO - psutil == 3.1.1 03:47:09 INFO - requests == 1.2.3 03:47:09 INFO - wsgiref == 0.1.2 03:47:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:09 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 0x7fdaf2ed2c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25f33d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, '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-1447760371.53378-2055380518', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:09 INFO - Using env: {'DISPLAY': ':0', 03:47:09 INFO - 'HOME': '/home/cltbld', 03:47:09 INFO - 'LANG': 'en_US.UTF-8', 03:47:09 INFO - 'LANGUAGE': 'en_US:en', 03:47:09 INFO - 'LOGNAME': 'cltbld', 03:47:09 INFO - 'MAIL': '/var/mail/cltbld', 03:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:09 INFO - 'MOZ_NO_REMOTE': '1', 03:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:09 INFO - 'NO_EM_RESTART': '1', 03:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:09 INFO - 'SHELL': '/bin/bash', 03:47:09 INFO - 'SHLVL': '1', 03:47:09 INFO - 'TERM': 'linux', 03:47:09 INFO - 'TMOUT': '86400', 03:47:09 INFO - 'USER': 'cltbld', 03:47:09 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:09 INFO - '_': '/tools/buildbot/bin/python'} 03:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:47:09 INFO - Cleaning up... 03:47:09 INFO - Return code: 0 03:47:09 INFO - Running post-action listener: _resource_record_post_action 03:47:09 INFO - Running post-action listener: _start_resource_monitoring 03:47:09 INFO - Starting resource monitoring. 03:47:09 INFO - ##### 03:47:09 INFO - ##### Running install step. 03:47:09 INFO - ##### 03:47:09 INFO - Running pre-action listener: _resource_record_pre_action 03:47:09 INFO - Running main action method: install 03:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:09 INFO - Reading from file tmpfile_stdout 03:47:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:47:09 INFO - Reading from file tmpfile_stdout 03:47:09 INFO - Output received: 03:47:09 INFO - Usage: mozinstall [options] installer 03:47:09 INFO - Options: 03:47:09 INFO - -h, --help show this help message and exit 03:47:09 INFO - -d DEST, --destination=DEST 03:47:09 INFO - Directory to install application into. [default: 03:47:09 INFO - "/builds/slave/test-pgo"] 03:47:09 INFO - --app=APP Application being installed. [default: firefox] 03:47:09 INFO - mkdir: /builds/slave/test-pgo/build/application 03:47:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:47:24 INFO - Reading from file tmpfile_stdout 03:47:24 INFO - Output received: 03:47:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:24 INFO - Running post-action listener: _resource_record_post_action 03:47:24 INFO - ##### 03:47:24 INFO - ##### Running run-tests step. 03:47:24 INFO - ##### 03:47:24 INFO - Running pre-action listener: _resource_record_pre_action 03:47:24 INFO - Running main action method: run_tests 03:47:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:24 INFO - Python 2.7.3 03:47:24 INFO - Return code: 0 03:47:24 INFO - grabbing minidump binary from tooltool 03:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:24 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 0x267c8c0>, '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 0x2629420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26298b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:47:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:47:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:24 INFO - Return code: 0 03:47:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:24 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/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:24 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/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost 03:47:24 INFO - Using env: {'DISPLAY': ':0', 03:47:24 INFO - 'HOME': '/home/cltbld', 03:47:24 INFO - 'LANG': 'en_US.UTF-8', 03:47:24 INFO - 'LANGUAGE': 'en_US:en', 03:47:24 INFO - 'LOGNAME': 'cltbld', 03:47:24 INFO - 'MAIL': '/var/mail/cltbld', 03:47:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:24 INFO - 'MOZ_NO_REMOTE': '1', 03:47:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:24 INFO - 'NO_EM_RESTART': '1', 03:47:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:24 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:24 INFO - 'SHELL': '/bin/bash', 03:47:24 INFO - 'SHLVL': '1', 03:47:24 INFO - 'TERM': 'linux', 03:47:24 INFO - 'TMOUT': '86400', 03:47:24 INFO - 'USER': 'cltbld', 03:47:24 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1447760371.53378-2055380518', 03:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:24 INFO - '_': '/tools/buildbot/bin/python'} 03:47:24 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/vDnpw1RBSy6QjhrWlnjyJg/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 03:47:24 INFO - mozversion INFO | application_buildid: 20151117013036 03:47:24 INFO - mozversion INFO | application_changeset: e61e64f29a004f9a3042810a093b24dabbf56731 03:47:24 INFO - mozversion INFO | application_display_name: Nightly 03:47:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:24 INFO - mozversion INFO | application_name: Firefox 03:47:24 INFO - mozversion INFO | application_remotingname: firefox 03:47:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:47:24 INFO - mozversion INFO | application_vendor: Mozilla 03:47:24 INFO - mozversion INFO | application_version: 45.0a1 03:47:24 INFO - mozversion INFO | platform_buildid: 20151117013036 03:47:24 INFO - mozversion INFO | platform_changeset: e61e64f29a004f9a3042810a093b24dabbf56731 03:47:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:47:24 INFO - mozversion INFO | platform_version: 45.0a1 03:47:24 INFO - 2015-11-17 03:47:24,676 DEBUG : using testdate: 1447760844 03:47:24 INFO - 2015-11-17 03:47:24,676 DEBUG : actual date: 1447760844 03:47:24 INFO - 2015-11-17 03:47:24,724 INFO : starting webserver on 'localhost:49722' 03:47:24 INFO - 2015-11-17 03:47:24,725 INFO : Starting test suite talos-linux64-ix-057 03:47:24 INFO - 2015-11-17 03:47:24,725 INFO : Starting test dromaeo_css 03:47:24 INFO - 2015-11-17 03:47:24,725 DEBUG : operating with platform_type : linux_ 03:47:24 INFO - 2015-11-17 03:47:24,726 INFO : Initialising browser for dromaeo_css test... 03:47:24 INFO - 2015-11-17 03:47:24,742 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUqAYUE/profile http://localhost:49722/getInfo.html 03:47:28 INFO - 2015-11-17 03:47:28,617 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:28 INFO - 2015-11-17 03:47:28,617 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:28 INFO - 2015-11-17 03:47:28,617 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:28 INFO - 2015-11-17 03:47:28,618 DEBUG : BROWSER_OUTPUT: __metrics 03:47:28 INFO - 2015-11-17 03:47:28,762 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:29 INFO - 2015-11-17 03:47:29,911 INFO : Browser initialized. 03:47:29 INFO - 2015-11-17 03:47:29,912 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:29 INFO - 2015-11-17 03:47:29,912 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUqAYUE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:41 INFO - 2015-11-17 03:47:41,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 141758464 03:47:41 INFO - 2015-11-17 03:47:41,722 DEBUG : BROWSER_OUTPUT: 03:48:32 INFO - 2015-11-17 03:48:32,400 DEBUG : BROWSER_OUTPUT: 1447760912392 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] 03:50:41 INFO - 2015-11-17 03:50:41,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49722/tests/dromaeo/cssquery-ext.html) 03:50:43 INFO - 2015-11-17 03:50:43,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 265662464 03:50:43 INFO - 2015-11-17 03:50:43,221 DEBUG : BROWSER_OUTPUT: 03:53:45 INFO - 2015-11-17 03:53:45,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-ext.html (next: http://localhost:49722/tests/dromaeo/cssquery-jquery.html) 03:53:46 INFO - 2015-11-17 03:53:46,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 222412800 03:53:46 INFO - 2015-11-17 03:53:46,322 DEBUG : BROWSER_OUTPUT: 03:56:48 INFO - 2015-11-17 03:56:48,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49722/tests/dromaeo/cssquery-mootools.html) 03:56:48 INFO - 2015-11-17 03:56:48,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 208347136 03:56:48 INFO - 2015-11-17 03:56:48,789 DEBUG : BROWSER_OUTPUT: 03:59:50 INFO - 2015-11-17 03:59:50,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49722/tests/dromaeo/cssquery-prototype.html) 03:59:51 INFO - 2015-11-17 03:59:51,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 198356992 03:59:51 INFO - 2015-11-17 03:59:51,302 DEBUG : BROWSER_OUTPUT: 04:02:53 INFO - 2015-11-17 04:02:53,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49722/tests/dromaeo/cssquery-yui.html) 04:02:54 INFO - 2015-11-17 04:02:54,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 201416704 04:02:54 INFO - 2015-11-17 04:02:54,407 DEBUG : BROWSER_OUTPUT: 04:05:56 INFO - 2015-11-17 04:05:56,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/dromaeo/cssquery-yui.html (next: http://localhost:49722/tests/dromaeo/cssquery-dojo.html) 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 247283712 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:57 INFO - 2015-11-17 04:05:57,038 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:57 INFO - 2015-11-17 04:05:57,039 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3253.446914024616;3314.701676849083;3361.226917808904;3370.427027405341;3376.6285708572054;5412.4587541245855;5522.0336441122845;5541.196526503654;5691.08942569189;5697.373288938219;5479.123340265558;5563.944360556393;5626.606137570372;5634.014047541674;5650.5479561635075;4961.776720047588;4973.254011898217;4982.9252561211615;5035.823746168885;5038.345015148026;4953.281774142747;5143.177091665334;5160.14857548504;5225.242339860718;5244.213367994793;5034.672746271499;5082.79668813247;5128.102582048164;5136.563392111675;5165.251038599419;5105.412877519096;5197.610179236534;5203.349581302337;5212.556932660728;5253.028189784902;4909.361782968227;5024.296598476216;5122.410922743895;5152.407473140599;5167.379914410257;5333.759980800874;5416.566674666017;5460.563154947635;5474.096774032319;5491.28613280275;6105.572609917308;6107.206063211798;6113.755449782004;6114.357992410777;6114.510839132903;5956.255468066492;6072.210612620375;6154.476869466101;6172.47533959614;6180.134781130645;5590.664560126405;5670.461306175906;5764.193012978187;5801.53587712982;5803.245578074823;6229.2524897012645;6246.843828904313;6247.875042499125;6250.249970003629;6253.937460625427;6005.669688167105;6012.819615411545;6012.947734146507;6015.3383127855905;6021.458068773832;5880.94119058804;5907.320658124285;5982.40175982407;5984.7606095756555;6039.66781826995;5995.940040599626;6011.308699499614;6068.362821903725;6073.635581865014;6084.969575152096;6108.908366374508;6113.327533971348;6119.173911521976;6123.601965872204;6128.816135515942;4483;4492.348609451677;4584.266517357207;4587.311903214478;4607.493175750665;4018.0758425562285;4062.207869465426;4062.9187416252103;4095.9385609215888;4098.672106231495;5505.972470137704;5787.102999035156;5787.913181302284;5789.3052833659385;5795.768169273266;5993.880122397528;6017.398260173947;6051.515878729691;6061.6666083365835;6129.448349648553;5759.769609215668;5855.707214639337;5855.912161317584;5856.736446859902;5859.20900678403;5054.873628159252;5303.549198318109;5317.1492561190025;5319.654222475604;5320.813771517978;6002;6051.969740151271;6057.515398768176;6101.84745381369;6128.95807712681;6033.607815491979;6042.0332746760305;6046.395360463918;6047.818565443044;6128.4790792783115;5880.500157486662;6014.518838492998;6158.630482171084;6163.876722465436;6188.319284878749;5999.130126131774;6112.723886728499;6113.266408031065;6117.663528505975;6127.234095738033;6176.938230617637;6191.5665903388135;6195.411435913581;6201.441870231521;6202.627842329474;5780.132980053026;5826.70866456684;5916.55625828056;6068.757249710139;6074.969625152023;5923.259592550931;5951.880962380815;5960.374160713236;5967.403259674172;5970.641761494324;5823.5923485355615;5866.2960444746905;5867.677277749594;5870.383609720918;5876.382979787061;5764.711764411679;5766.192733017297;5871.647701137946;5934.19888315072;5947.940520594739;5828.883422331445;5843.590948633555;5844.824655260349;5845.853853653693;5866.120081987736 04:05:57 INFO - 2015-11-17 04:05:57,039 DEBUG : BROWSER_OUTPUT: |1;ext.html;595.062776127599;599.6402158704777;600.0099835271801;607.204562023749;612.3631423319748;31586;38917;39550;39574.208515829705;39735.403968940416;42713;43139.78430107853;43205.35191972115;43206.56793432065;43227.78386108073;7485.251474852498;7618.580978046205;8627.65489380424;8791.164839340252;8798.340124490656;7614.238576142397;10329.948350258239;10409.68770936873;10499.212559058064;10552.472376381189;10169.491525423698;10248.641297554586;10270.897291027106;10274.589016439333;10289.948550257239;7732.574708391036;7916.208379162038;10115.089641932225;10212.591496340137;10217.540210690537;10312.071913527743;10574.841377379345;10577.682669519927;10580.68257952255;10582.206334524864;40498.190036199114;40512.392314115314;40543.972801359814;40564;41151.1769764606;3296.703296703284;3891.0855948851995;3966.0283230608397;3967.0677390813134;4003.779792111433;30442.54336184959;30465;30858.691413085806;32036.679633203836;32363.352732945208;3552.3326753102474;3558.1104723819044;3610.151614370621;3616.2044350242904;3639.927201455956;275797;276469;277095;277670.22329776647;278296.60851695813;57279.42720572824;58295.41704582985;58972;59477.810443790884;59499.405005950255;63421.682891585246;64190.35809641844;64212;64325.35674643287;64524.67737661282;15410.768838467431;15705.764413533807;15757.763633545506;15785.842141578667;15809.525714228592;12330.383480825923;12423.378831058411;12430.067744919168;12437.502499900083;12445.564405245954;18944.52638684044;19001.334953276568;19135.521611959535;19659.508512287306;19730.802691973182;7340.559566426032;7557.735479258309;7595.772126836204;7610.467267291237;7643.4267429942975;930.2325581395403;942.5240253671989;947.7393716727955;991.5240684471494;1025.6256466389714;28497.355077702236;28621.71378286232;28658.85670571634;28942.42115157685;29148.85425572901;1045.785613949154;1052.5737076484036;1115.6318414923219;1125.926814757038;1200.4237965776476;14734.189619570812;14838;15183.620409489851;15230.847691523164;16073.758893616605;320355;324163;325295;326846;327255;53321;53506.46493535015;53560.19659705107;53582.73208633932;53636;1325.118796000668;1346.3402932562974;1347.5148946379295;1361.0200655528201;1363.2842757552364;26106.608400874382;28597.571036434885;28769.100296082255;29224.123276301743;29716;46789.76605116953;47017.764911175225;47142.29286560773;47206.76396617995;47259;279106;282002;282839;283156;283301;27747;28267.43465130645;31135.84432077825;31704.365912681154;31950.360992779548;38468.807655961544;38610.42084368681;38920.221595568495;39245.80377098211;39583;34900;35111.824440878656;35380.29239415146;35451.46822797608;35741.46387804133;34846.12884677904;35065.12337191489;35268.64731352756;35555;35866.64133358633;35375.29249415049;35604;35612.28775424529;36364.636353636124;36687.04724862109;31413.52879706852;32164;32316;32362.676373235965;32460.350792983536;24919.626205607292;25129.497410052063;25132.12037578676;25267.113880996716;25436.745632543436 04:05:57 INFO - 2015-11-17 04:05:57,039 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.54124555586634;348.16787876974035;348.5817019576508;350;351.0609120602388;13712.382942767574;13941.302934853242;16222.432214872482;16550.503484895456;17673.82326176738;16572.171391430442;16899.746503802424;17018;17569.73645395317;17591.29634814609;5239;5368.865778355534;5387.434319396466;5420.5934554908345;5425.37608175059;3873.767573945572;3983.960160398388;5416;5825.330087040003;6017.578769486116;5918.437748413894;5942.316633587149;5942.5840191186635;5973.790917317895;5975.223220981266;5798.42015798421;5952.3154837193415;5952.791652292149;5955.315138759033;5961.284645842505;5198.090334191539;5276.630635855492;5282.867928301785;5288.603354748371;5300.443453437372;20706.585868282702;20724.689129663067;20885.895570522203;21082.472938176667;21121.366359009255;2078.5842831433624;2087.926922557718;2143.178298446324;2147.5704859028256;2170.967435488469;12995.805062924064;13106.737865242641;13227.669308267274;13321.533746318832;13469.191848489025;1778.262021261175;1801.234475347985;1802.6034272460038;1808.620189760152;1883.0772921268617;60776;61291.693541532455;61657;62061.37938620601;62476;9510.239180865514;9862.65480708186;9876.753081172885;9911.513273009106;9930.354526955725;12712.982961363068;12750.426230819636;12814.615561533168;12840.357982101044;12842.293673847842;7565;7592.620368981528;7627.656755446018;7764.805879853049;7777.494462859896;7416.85166296671;7510.399168066541;7512.887306690404;7762.379009679212;7822.295993360625;5962.731677074542;6001.339852616209;6003.369646187175;6006.189164462829;6033.637981721023;1616.4504068616727;1683.2677785163494;1693.5088824240831;1698.2273065755298;1704.7783788107467;855.1747563601155;882.5498995512206;904.742148487691;918.1552971266451;966.3042609321277;11565.935027217794;12435.191712538655;17389.65220695579;17493.65012699739;17892.10539473021;497.420505111541;497.8232727381727;505.72943475241306;509.17005281391096;528.5058470330254;6475.190601174853;6610;6620.569662971891;6633.668316584151;6738.19141702989;565712;569771;571130;574184;576897;70208.64895675489;77285;78749;79279.60360198162;79602.6019869897;556.1435389500206;567.1917517537493;567.9034564124108;568.1364326224199;568.590614757374;11079.224454288122;11423.143264255048;11557.01765349921;11657.300561966309;11666.76666466683;35733.82133089318;35763;36118.27763444664;36856.44715329219;37090;47775;48533;48661;49533.50466495289;49575.256371155185;6686.83282917931;6722.428593569602;6784.76253331131;6791.04925310447;6791.796246112624;8784.824303513766;11770.705732356759;11876.465559050037;12110.51557937708;12451.937740311241;10685.626003089854;10779.461026948464;10875.836862446911;10928.508217130408;10941.23411361197;10159.288849780445;10448.081969261528;10509.684709458728;10549.947250264007;10969;8845.292376609726;8849.24781393563;10892.128629709763;10985.560577576807;11228.326300422;6760.222574404006;6848.2466928638805;6873.862522749417;6885.862282754217;6918.965405172942;10720;10763.327244765507;10909.83635245456;10958.342499450058;11046.944765276123 04:05:57 INFO - 2015-11-17 04:05:57,040 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.959861204163;1708.632643981544;1768.3103589600057;1785.6964316066267;1799.424184261036;7045.978333141691;7761.107472640648;7852.528848269108;7882.330001949841;7891.36869050476;7606.657700403482;7771.378289736822;7787.454878158531;7788.805279867992;7790.259925307101;1988.8309493693052;2035.155410504639;2248.2580748353084;2296.334063121693;2326.1044497868356;2276.635738281875;2282.463621049052;2286.3598192506124;2287.691161693175;2289.53064621753;2224.232639739287;2299.9310020699404;2301.5857145713767;2301.7698230177016;2301.8964146613444;1999.820016198542;2037.1749441476227;2219.5782801267787;2249.6513040478753;2251.5271792923504;2271.943201419978;2274.5337205872756;2303.285981345788;2304.7003889494426;2340.9180678676166;7788.260115289038;7871.921280787176;7875.684972601089;7889.053313602347;7890.250426209501;4669.649776266793;4739.0758802033615;4743.0988112258565;4746.430428348585;4781.019890922353;3118.5322201669705;3133.7934895065337;3161.3045130071346;3177.9682203177904;3231.579894613709;1024.8052869954686;1025.0979138358198;1042.6246551241547;1060.8355704865758;1080.6060182364818;10903.781924361547;10906.072983796386;10915.126789856793;10920.726981825517;10927.978324010084;4162.708610397243;4282.464691913511;4286.099919016979;4299.484061912591;4380.189664912002;9386.15524602789;9422.575984080733;9429.622815087458;9434.528273586293;9436.764080897896;4734.076855013308;4736.550027747358;4783.473817880031;4783.7129772213775;4783.760811959388;4330.437043184366;4342.761148136883;4343.3484977253665;4344.087741574304;4348.130373925228;3696.8706095287075;3740.382836831947;3747.100695833035;3760.9059773505883;3779.4141908004303;1180.2092597959388;1197.060307658484;1212.1393810394718;1213.5327898759042;1219.0552321950559;1014.3356101753363;1280.7630588341187;1286;1290.4193113099143;1362.8500864904852;6409.775657851953;7627.199144089902;7768.456208065494;7768.65041073153;7769.339606133542;692.9341712537301;694.6804469943883;704.2745971649107;706.3854446631361;709.4395427612128;5504.889902201933;5560.221568980346;5581.553475721932;5616.045272303718;5620.606557541015;9418.858717119248;9450.054994500633;9475;9629.470379129076;9656.32405731606;9293.303002274857;9395.530223488799;9474.526273686288;9512.762180945532;9532.666356677482;7315.012473316035;7343.926560734431;7396.778096657109;7405.111386633531;7417.629118544159;6964.895526567004;7131.42948564124;7148.17795953472;7159.856802863809;7194.2086370498155;8179.263866252066;8259.091499935123;8452.070272270168;8460.619272132892;8461.111583283913;8435.746927592181;8516.74449766508;8661.523616200917;8668.219860212359;8775.166359195866;7058.188308344401;7084.681189346388;7128.144622645315;7137.714491420285;7154.284571543012;7472.77581672529;7664.425168112302;7671.462997590115;7733.4973226740085;7757.92242077572;7125.964370178116;7182.8563428730085;7251.492395532473;7314;7316.231795661379;7111.7866464006165;7125.501214915113;7158.176809666955;7250.782476525713;7313.707451701873;6570.47436205112;6593.736250549924;6637.734490620514;6668.933310666831;6672.165979252593;6241.095041219089;6481.254655714464;6641.203055633355;6642.269350371552;6648.501362397937;6409.775657851953;6469.061986012096;6469.547131700736;6486.610803351814;6487.675616219264 04:05:57 INFO - 2015-11-17 04:05:57,044 DEBUG : BROWSER_OUTPUT: |4;prototype.html;326.5183853815622;326.8398484742476;333.3483040655519;335.6593058046084;339.84197348233084;5865.442782935625;5929.34777174511;5992.520598352126;6029.969850150748;6096.390360963901;5866.6480011199255;5940.465358117768;5995.790147344844;6016.067509536018;6025.427584379488;4652.976735116336;4654.4880063193195;4656.0687862427485;4661.836835710751;4666.090112428078;4355.956440435587;4435.534268901767;4530.456345238576;4640;4665.346851440784;4563.5664611861985;4565.931511027337;4588.77056147193;4590.380298659688;4628.259478483444;4630.467496237942;4635.281531362611;4637.049404871993;4637.814487420499;4646.3495110684535;4048.352263637804;4052.53395859477;4053.4527838741687;4054.553999060101;4061.1268577256033;5604.187392828057;5691.9146212806845;5727.484526392603;5728.198052272685;5741.138829175616;5332.120200166968;5368.570514358842;5372.059889519358;5377.327834020747;5386.78452861885;6063.787767428119;6389.105525226472;6396.0725694774;6396.93603063968;6404.583702059398;4343.500497442803;4405.074934263808;4454.866354009385;4489.551044895517;4492.124035813018;6584.604923704593;6627.138471998657;6628.370304821035;6630.038644396535;6643.368879956396;4584.083183363274;4585.472670642852;4588.357629931812;4590.242609969385;4590.334401511829;4391.099824536026;4509.616682582017;4528.932066019012;4650.627949764011;4667.043256132485;5267.394249661262;5276.208568714724;5288.735563221823;5289.809792796667;5297.364316282071;6364.904526432108;6453.096566480603;6453.741850326029;6460.063290822804;6465.2564955030775;1585.484717466828;1606.6063814365555;1607.9196040198178;1609.3562574969872;1609.3562574970106;1050.821360368739;1064.302881612545;1067.2795862792584;1068.124138206663;1092.4428541443763;6236.594621349598;6239.407256310643;6240.251169859646;6242.625442473466;6247.312795592481;6661.2006559213205;6669.566478179;6672.366125218096;6673.666316684146;6677.933220667828;6065.909011364833;6228.750849966042;6236.438720515175;6238.563300568917;6244.687765611701;3583.8566457341412;3617.149969757105;3617.1680513482047;3617.565892092966;3623.1847834237615;6784.559003664845;6788.253292137861;6792.864142717118;6793.490488213305;6801.7619383322335;6684.63234522106;6814;6827.1807383113355;6829.726810927507;6830.077939478107;6779.017042528806;6801.829954251084;6807.115075040312;6814.250432452426;6818;6394.680265986775;6520.282768895323;6596.406323430914;6638.634875081917;6648.9002664961035;6568.343165683394;6611.471082313499;6626.304238054935;6628.83427914306;6640.369164929324;6861.965690171517;6865.588064716133;6866.519343645897;6870;6873.896891546531;4368.4321038264825;4476.328550717419;4481.708688935209;4516.977415112903;4525.094981003746;6628.304028077176;6639.136912201383;6644.235912870082;6648.867022659423;6649.434798042221;6443.09796628463;6466.288708241996;6480.25477070143;6482.416582507597;6486.610803351814;6368.872622547616;6472.741090356333;6482.805515834532;6564.376384243489;6571.178602674666;6425.6827350394;6436;6439.613623182624;6440.162778838721;6443.645599491885;6598.10925525048;6598.967005164944;6599.109120268894;6600.1089852869245;6611.107500487373;6185.567010309415;6389.8722025560155;6394.296627371078;6398.648074355955;6412.294647588855 04:05:57 INFO - 2015-11-17 04:05:57,045 DEBUG : BROWSER_OUTPUT: |5;yui.html;786.1892101966959;846.5132548784443;852.6035393542002;856.5503110866795;858.9914100858994;13278.93360533196;13363.866361336395;13620.931895340522;13651.863481365184;13655.453781848726;12492.437840297185;12528.624141275777;12633.55782547611;12638.810417843717;12655.810162847565;682.8224661587973;697.8883378659416;818.9803694400465;820.7168526858254;823.9505629662209;823.2508417340222;842.9072801991776;843.3169133002287;846.2172490446343;850.7915560687641;878.5343767803074;883.849745543256;885.4731434796286;886.0829041941591;886.5434301334818;712.7612249896291;730.4704089535071;868.8392647360258;871.4074429388014;874.1695389380114;643.4498503779295;644.5745807766851;645.4416929356073;645.5932762359683;645.8288553533317;13396.933015334958;13484.460621575125;13529.255890925995;13545;13549.661258468519;11203.663890083311;11821.34982575958;11838.408079595985;12130.332831694253;12432;9673.371230870041;9810.362326448758;9916.157126644244;9954.104130628279;9994.400335979864;3594.4967704521387;3624.1664417184197;3631.4734363517405;3642.9981755017316;3651.5070465487083;44644;45108;45164.774176129235;45536.3169552457;46890.76554617205;9530.428174309563;9538.189253913357;9595.376300540582;9602.519874006271;9738.756531086638;12491.87508124907;12613.180143290656;12617;12625.810612840814;12631.621051368473;6681.064650948871;6903.792886213421;7039.577625342394;7096.822579435556;7147.035150254753;4310;4323.610875021263;4323.697341186087;4335.826566937287;4363.410939523187;2948.1450379390167;2974.449726800549;2984.940301193964;2985.387995460925;3003.7897347185926;447.29550957242475;451.9231730605805;465.60423639906486;466.28658153025924;466.36108531312317;633.3381616210978;656.1306269193337;671.4829581222432;681.7681988124061;701.4423533290944;8010.239027292398;8249.876251856227;8791.164839340252;8794.34042446819;8924.375293729376;542.6879544262065;568.464647671382;606.9787557435469;705.982350441243;719.4675939804507;3818.4272359145793;3904.531456225271;4021.698372622065;4042.43405923171;4148.647364973951;51415;54693.179602305994;54875.72562137164;54920.725396373564;55123.44876551183;49054.50945490571;49169;50481;50936.74531627318;51393.486065139616;45448.77275613601;46223.76888115538;46710.76644616755;47000;47296.97975672038;8287;8525.916308798662;8694.434861733967;8715;9019.113883557198;34772.82613587017;34852.30295394129;35452;35512.64487355093;35615.82192089126;41444.58555414528;41571;43050.569494304655;44887.77556112198;45402.54597453983;7867.134615192439;8287.41988060854;8297.917020829715;8343.123971983097;8356.749297521084;9948.40494872958;11385.658430247106;11488.885111148782;11667.241629294069;12102;10827.643430536558;10961.287516311415;11323.15076369259;11399.544018239509;11673.766524669629;10351.482425878827;10555.894441055798;10983.780324393627;11371.43142842871;11505.194636375374;7309.707611695685;9652.613895444385;10583.31208471447;10787.298825576312;11085.334879907232;9420.246380289424;9495.335326527353;9583.304458018625;9686;9762.56068476906;9630;9813.214942804701;9841.163501102486;9896.851547226654;9948.55231514598 04:05:57 INFO - 2015-11-17 04:05:57,045 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:57 INFO - 2015-11-17 04:05:57,045 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:57 INFO - 2015-11-17 04:05:57,045 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1066 04:05:57 INFO - 2015-11-17 04:05:57,046 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:57 INFO - 2015-11-17 04:05:57,046 DEBUG : BROWSER_OUTPUT: __startTimestamp1447761957032__endTimestamp 04:05:57 INFO - 2015-11-17 04:05:57,046 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5613.24 Median:5856.74 stddev:648.35 (11.1%) stddev-sans-first:623.35 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: Values: 3253.4 3314.7 3361.2 3370.4 3376.6 5412.5 5522.0 5541.2 5691.1 5697.4 5479.1 5563.9 5626.6 5634.0 5650.5 4961.8 4973.3 4982.9 5035.8 5038.3 4953.3 5143.2 5160.1 5225.2 5244.2 5034.7 5082.8 5128.1 5136.6 5165.3 5105.4 5197.6 5203.3 5212.6 5253.0 4909.4 5024.3 5122.4 5152.4 5167.4 5333.8 5416.6 5460.6 5474.1 5491.3 6105.6 6107.2 6113.8 6114.4 6114.5 5956.3 6072.2 6154.5 6172.5 6180.1 5590.7 5670.5 5764.2 5801.5 5803.2 6229.3 6246.8 6247.9 6250.2 6253.9 6005.7 6012.8 6012.9 6015.3 6021.5 5880.9 5907.3 5982.4 5984.8 6039.7 5995.9 6011.3 6068.4 6073.6 6085.0 6108.9 6113.3 6119.2 6123.6 6128.8 4483.0 4492.3 4584.3 4587.3 4607.5 4018.1 4062.2 4062.9 4095.9 4098.7 5506.0 5787.1 5787.9 5789.3 5795.8 5993.9 6017.4 6051.5 6061.7 6129.4 5759.8 5855.7 5855.9 5856.7 5859.2 5054.9 5303.5 5317.1 5319.7 5320.8 6002.0 6052.0 6057.5 6101.8 6129.0 6033.6 6042.0 6046.4 6047.8 6128.5 5880.5 6014.5 6158.6 6163.9 6188.3 5999.1 6112.7 6113.3 6117.7 6127.2 6176.9 6191.6 6195.4 6201.4 6202.6 5780.1 5826.7 5916.6 6068.8 6075.0 5923.3 5951.9 5960.4 5967.4 5970.6 5823.6 5866.3 5867.7 5870.4 5876.4 5764.7 5766.2 5871.6 5934.2 5947.9 5828.9 5843.6 5844.8 5845.9 5866.1 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,047 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46674.22 Median:178877.68 stddev:77146.09 (43.1%) stddev-sans-first:77284.92 04:05:57 INFO - 2015-11-17 04:05:57,048 DEBUG : BROWSER_OUTPUT: Values: 595.1 599.6 600.0 607.2 612.4 31586.0 38917.0 39550.0 39574.2 39735.4 42713.0 43139.8 43205.4 43206.6 43227.8 7485.3 7618.6 8627.7 8791.2 8798.3 7614.2 10329.9 10409.7 10499.2 10552.5 10169.5 10248.6 10270.9 10274.6 10289.9 7732.6 7916.2 10115.1 10212.6 10217.5 10312.1 10574.8 10577.7 10580.7 10582.2 40498.2 40512.4 40544.0 40564.0 41151.2 3296.7 3891.1 3966.0 3967.1 4003.8 30442.5 30465.0 30858.7 32036.7 32363.4 3552.3 3558.1 3610.2 3616.2 3639.9 275797.0 276469.0 277095.0 277670.2 278296.6 57279.4 58295.4 58972.0 59477.8 59499.4 63421.7 64190.4 64212.0 64325.4 64524.7 15410.8 15705.8 15757.8 15785.8 15809.5 12330.4 12423.4 12430.1 12437.5 12445.6 18944.5 19001.3 19135.5 19659.5 19730.8 7340.6 7557.7 7595.8 7610.5 7643.4 930.2 942.5 947.7 991.5 1025.6 28497.4 28621.7 28658.9 28942.4 29148.9 1045.8 1052.6 1115.6 1125.9 1200.4 14734.2 14838.0 15183.6 15230.8 16073.8 320355.0 324163.0 325295.0 326846.0 327255.0 53321.0 53506.5 53560.2 53582.7 53636.0 1325.1 1346.3 1347.5 1361.0 1363.3 26106.6 28597.6 28769.1 29224.1 29716.0 46789.8 47017.8 47142.3 47206.8 47259.0 279106.0 282002.0 282839.0 283156.0 283301.0 27747.0 28267.4 31135.8 31704.4 31950.4 38468.8 38610.4 38920.2 39245.8 39583.0 34900.0 35111.8 35380.3 35451.5 35741.5 34846.1 35065.1 35268.6 35555.0 35866.6 35375.3 35604.0 35612.3 36364.6 36687.0 31413.5 32164.0 32316.0 32362.7 32460.4 24919.6 25129.5 25132.1 25267.1 25436.7 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28957.12 Median:501.78 stddev:93467.93 (18627.4%) stddev-sans-first:93705.44 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: Values: 347.5 348.2 348.6 350.0 351.1 13712.4 13941.3 16222.4 16550.5 17673.8 16572.2 16899.7 17018.0 17569.7 17591.3 5239.0 5368.9 5387.4 5420.6 5425.4 3873.8 3984.0 5416.0 5825.3 6017.6 5918.4 5942.3 5942.6 5973.8 5975.2 5798.4 5952.3 5952.8 5955.3 5961.3 5198.1 5276.6 5282.9 5288.6 5300.4 20706.6 20724.7 20885.9 21082.5 21121.4 2078.6 2087.9 2143.2 2147.6 2171.0 12995.8 13106.7 13227.7 13321.5 13469.2 1778.3 1801.2 1802.6 1808.6 1883.1 60776.0 61291.7 61657.0 62061.4 62476.0 9510.2 9862.7 9876.8 9911.5 9930.4 12713.0 12750.4 12814.6 12840.4 12842.3 7565.0 7592.6 7627.7 7764.8 7777.5 7416.9 7510.4 7512.9 7762.4 7822.3 5962.7 6001.3 6003.4 6006.2 6033.6 1616.5 1683.3 1693.5 1698.2 1704.8 855.2 882.5 904.7 918.2 966.3 11565.9 12435.2 17389.7 17493.7 17892.1 497.4 497.8 505.7 509.2 528.5 6475.2 6610.0 6620.6 6633.7 6738.2 565712.0 569771.0 571130.0 574184.0 576897.0 70208.6 77285.0 78749.0 79279.6 79602.6 556.1 567.2 567.9 568.1 568.6 11079.2 11423.1 11557.0 11657.3 11666.8 35733.8 35763.0 36118.3 36856.4 37090.0 47775.0 48533.0 48661.0 49533.5 49575.3 6686.8 6722.4 6784.8 6791.0 6791.8 8784.8 11770.7 11876.5 12110.5 12451.9 10685.6 10779.5 10875.8 10928.5 10941.2 10159.3 10448.1 10509.7 10549.9 10969.0 8845.3 8849.2 10892.1 10985.6 11228.3 6760.2 6848.2 6873.9 6885.9 6919.0 10720.0 10763.3 10909.8 10958.3 11046.9 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5501.60 Median:6483.93 stddev:2877.40 (44.4%) stddev-sans-first:2868.45 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: Values: 1338.0 1708.6 1768.3 1785.7 1799.4 7046.0 7761.1 7852.5 7882.3 7891.4 7606.7 7771.4 7787.5 7788.8 7790.3 1988.8 2035.2 2248.3 2296.3 2326.1 2276.6 2282.5 2286.4 2287.7 2289.5 2224.2 2299.9 2301.6 2301.8 2301.9 1999.8 2037.2 2219.6 2249.7 2251.5 2271.9 2274.5 2303.3 2304.7 2340.9 7788.3 7871.9 7875.7 7889.1 7890.3 4669.6 4739.1 4743.1 4746.4 4781.0 3118.5 3133.8 3161.3 3178.0 3231.6 1024.8 1025.1 1042.6 1060.8 1080.6 10903.8 10906.1 10915.1 10920.7 10928.0 4162.7 4282.5 4286.1 4299.5 4380.2 9386.2 9422.6 9429.6 9434.5 9436.8 4734.1 4736.6 4783.5 4783.7 4783.8 4330.4 4342.8 4343.3 4344.1 4348.1 3696.9 3740.4 3747.1 3760.9 3779.4 1180.2 1197.1 1212.1 1213.5 1219.1 1014.3 1280.8 1286.0 1290.4 1362.9 6409.8 7627.2 7768.5 7768.7 7769.3 692.9 694.7 704.3 706.4 709.4 5504.9 5560.2 5581.6 5616.0 5620.6 9418.9 9450.1 9475.0 9629.5 9656.3 9293.3 9395.5 9474.5 9512.8 9532.7 7315.0 7343.9 7396.8 7405.1 7417.6 6964.9 7131.4 7148.2 7159.9 7194.2 8179.3 8259.1 8452.1 8460.6 8461.1 8435.7 8516.7 8661.5 8668.2 8775.2 7058.2 7084.7 7128.1 7137.7 7154.3 7472.8 7664.4 7671.5 7733.5 7757.9 7126.0 7182.9 7251.5 7314.0 7316.2 7111.8 7125.5 7158.2 7250.8 7313.7 6570.5 6593.7 6637.7 6668.9 6672.2 6241.1 6481.3 6641.2 6642.3 6648.5 6409.8 6469.1 6469.5 6486.6 6487.7 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5371.44 Median:6081.15 stddev:1628.84 (26.8%) stddev-sans-first:1588.78 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: Values: 326.5 326.8 333.3 335.7 339.8 5865.4 5929.3 5992.5 6030.0 6096.4 5866.6 5940.5 5995.8 6016.1 6025.4 4653.0 4654.5 4656.1 4661.8 4666.1 4356.0 4435.5 4530.5 4640.0 4665.3 4563.6 4565.9 4588.8 4590.4 4628.3 4630.5 4635.3 4637.0 4637.8 4646.3 4048.4 4052.5 4053.5 4054.6 4061.1 5604.2 5691.9 5727.5 5728.2 5741.1 5332.1 5368.6 5372.1 5377.3 5386.8 6063.8 6389.1 6396.1 6396.9 6404.6 4343.5 4405.1 4454.9 4489.6 4492.1 6584.6 6627.1 6628.4 6630.0 6643.4 4584.1 4585.5 4588.4 4590.2 4590.3 4391.1 4509.6 4528.9 4650.6 4667.0 5267.4 5276.2 5288.7 5289.8 5297.4 6364.9 6453.1 6453.7 6460.1 6465.3 1585.5 1606.6 1607.9 1609.4 1609.4 1050.8 1064.3 1067.3 1068.1 1092.4 6236.6 6239.4 6240.3 6242.6 6247.3 6661.2 6669.6 6672.4 6673.7 6677.9 6065.9 6228.8 6236.4 6238.6 6244.7 3583.9 3617.1 3617.2 3617.6 3623.2 6784.6 6788.3 6792.9 6793.5 6801.8 6684.6 6814.0 6827.2 6829.7 6830.1 6779.0 6801.8 6807.1 6814.3 6818.0 6394.7 6520.3 6596.4 6638.6 6648.9 6568.3 6611.5 6626.3 6628.8 6640.4 6862.0 6865.6 6866.5 6870.0 6873.9 4368.4 4476.3 4481.7 4517.0 4525.1 6628.3 6639.1 6644.2 6648.9 6649.4 6443.1 6466.3 6480.3 6482.4 6486.6 6368.9 6472.7 6482.8 6564.4 6571.2 6425.7 6436.0 6439.6 6440.2 6443.6 6598.1 6599.0 6599.1 6600.1 6611.1 6185.6 6389.9 6394.3 6398.6 6412.3 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,049 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13199.33 Median:51165.12 stddev:15448.30 (30.2%) stddev-sans-first:15463.51 04:05:57 INFO - 2015-11-17 04:05:57,051 DEBUG : BROWSER_OUTPUT: Values: 786.2 846.5 852.6 856.6 859.0 13278.9 13363.9 13620.9 13651.9 13655.5 12492.4 12528.6 12633.6 12638.8 12655.8 682.8 697.9 819.0 820.7 824.0 823.3 842.9 843.3 846.2 850.8 878.5 883.8 885.5 886.1 886.5 712.8 730.5 868.8 871.4 874.2 643.4 644.6 645.4 645.6 645.8 13396.9 13484.5 13529.3 13545.0 13549.7 11203.7 11821.3 11838.4 12130.3 12432.0 9673.4 9810.4 9916.2 9954.1 9994.4 3594.5 3624.2 3631.5 3643.0 3651.5 44644.0 45108.0 45164.8 45536.3 46890.8 9530.4 9538.2 9595.4 9602.5 9738.8 12491.9 12613.2 12617.0 12625.8 12631.6 6681.1 6903.8 7039.6 7096.8 7147.0 4310.0 4323.6 4323.7 4335.8 4363.4 2948.1 2974.4 2984.9 2985.4 3003.8 447.3 451.9 465.6 466.3 466.4 633.3 656.1 671.5 681.8 701.4 8010.2 8249.9 8791.2 8794.3 8924.4 542.7 568.5 607.0 706.0 719.5 3818.4 3904.5 4021.7 4042.4 4148.6 51415.0 54693.2 54875.7 54920.7 55123.4 49054.5 49169.0 50481.0 50936.7 51393.5 45448.8 46223.8 46710.8 47000.0 47297.0 8287.0 8525.9 8694.4 8715.0 9019.1 34772.8 34852.3 35452.0 35512.6 35615.8 41444.6 41571.0 43050.6 44887.8 45402.5 7867.1 8287.4 8297.9 8343.1 8356.7 9948.4 11385.7 11488.9 11667.2 12102.0 10827.6 10961.3 11323.2 11399.5 11673.8 10351.5 10555.9 10983.8 11371.4 11505.2 7309.7 9652.6 10583.3 10787.3 11085.3 9420.2 9495.3 9583.3 9686.0 9762.6 9630.0 9813.2 9841.2 9896.9 9948.6 04:05:57 INFO - 2015-11-17 04:05:57,051 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:57 INFO - 2015-11-17 04:05:57,051 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-11-17 04:05:57,737 INFO : Browser exited with error code: 0 04:05:57 INFO - 2015-11-17 04:05:57,761 INFO : Completed test dromaeo_css (00:18:33) 04:05:57 INFO - 2015-11-17 04:05:57,761 INFO : Starting test kraken 04:05:57 INFO - 2015-11-17 04:05:57,761 DEBUG : operating with platform_type : linux_ 04:05:57 INFO - 2015-11-17 04:05:57,761 INFO : Initialising browser for kraken test... 04:05:57 INFO - 2015-11-17 04:05:57,767 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF27I2m/profile http://localhost:49722/getInfo.html 04:06:01 INFO - 2015-11-17 04:06:01,461 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:01 INFO - 2015-11-17 04:06:01,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:01 INFO - 2015-11-17 04:06:01,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:01 INFO - 2015-11-17 04:06:01,462 DEBUG : BROWSER_OUTPUT: __metrics 04:06:01 INFO - 2015-11-17 04:06:01,538 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:02 INFO - 2015-11-17 04:06:02,772 INFO : Browser initialized. 04:06:02 INFO - 2015-11-17 04:06:02,773 INFO : Running cycle 1/1 for kraken test... 04:06:02 INFO - 2015-11-17 04:06:02,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF27I2m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:14 INFO - 2015-11-17 04:06:14,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 141737984 04:06:14 INFO - 2015-11-17 04:06:14,463 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2015-11-17 04:06:16,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:17 INFO - 2015-11-17 04:06:17,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 181366784 04:06:17 INFO - 2015-11-17 04:06:17,524 DEBUG : BROWSER_OUTPUT: 04:06:20 INFO - 2015-11-17 04:06:20,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-dft) 04:06:20 INFO - 2015-11-17 04:06:20,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 169304064 04:06:20 INFO - 2015-11-17 04:06:20,658 DEBUG : BROWSER_OUTPUT: 04:06:23 INFO - 2015-11-17 04:06:23,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-fft) 04:06:24 INFO - 2015-11-17 04:06:24,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 150200320 04:06:24 INFO - 2015-11-17 04:06:24,055 DEBUG : BROWSER_OUTPUT: 04:06:26 INFO - 2015-11-17 04:06:26,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49722/tests/kraken/driver.html?testName=audio-oscillator) 04:06:26 INFO - 2015-11-17 04:06:26,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 153862144 04:06:26 INFO - 2015-11-17 04:06:26,591 DEBUG : BROWSER_OUTPUT: 04:06:28 INFO - 2015-11-17 04:06:28,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:29 INFO - 2015-11-17 04:06:29,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 154382336 04:06:29 INFO - 2015-11-17 04:06:29,294 DEBUG : BROWSER_OUTPUT: 04:06:32 INFO - 2015-11-17 04:06:32,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:32 INFO - 2015-11-17 04:06:32,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 155688960 04:06:32 INFO - 2015-11-17 04:06:32,794 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2015-11-17 04:06:36,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49722/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:36 INFO - 2015-11-17 04:06:36,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 156012544 04:06:36 INFO - 2015-11-17 04:06:36,752 DEBUG : BROWSER_OUTPUT: 04:06:39 INFO - 2015-11-17 04:06:39,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49722/tests/kraken/driver.html?testName=json-parse-financial) 04:06:40 INFO - 2015-11-17 04:06:40,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 157663232 04:06:40 INFO - 2015-11-17 04:06:40,067 DEBUG : BROWSER_OUTPUT: 04:06:41 INFO - 2015-11-17 04:06:41,635 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:42 INFO - 2015-11-17 04:06:42,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 166432768 04:06:42 INFO - 2015-11-17 04:06:42,197 DEBUG : BROWSER_OUTPUT: 04:06:43 INFO - 2015-11-17 04:06:43,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:44 INFO - 2015-11-17 04:06:44,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 165138432 04:06:44 INFO - 2015-11-17 04:06:44,599 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-11-17 04:06:46,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:47 INFO - 2015-11-17 04:06:47,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 169000960 04:06:47 INFO - 2015-11-17 04:06:47,253 DEBUG : BROWSER_OUTPUT: 04:06:49 INFO - 2015-11-17 04:06:49,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:50 INFO - 2015-11-17 04:06:50,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 179912704 04:06:50 INFO - 2015-11-17 04:06:50,225 DEBUG : BROWSER_OUTPUT: 04:06:52 INFO - 2015-11-17 04:06:52,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:53 INFO - 2015-11-17 04:06:53,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 177360896 04:06:53 INFO - 2015-11-17 04:06:53,300 DEBUG : BROWSER_OUTPUT: 04:06:54 INFO - 2015-11-17 04:06:54,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49722/tests/kraken/driver.html?testName=ai-astar) 04:06:55 INFO - 2015-11-17 04:06:55,229 DEBUG : BROWSER_OUTPUT: RSS: Main: 235663360 04:06:55 INFO - 2015-11-17 04:06:55,229 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;107;110;114;113;100;109;110;106 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;124;151;159;125;150;151;125;164;129 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;162;159;162;160;160;161;162;162 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;86;93;73;73;73;122;90;72 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;134;90;91;91;138;90;91;134 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;110;109;109;109 04:06:55 INFO - 2015-11-17 04:06:55,233 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;146;146;145;148;147;147;147;147 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;97;96;96;97;96;96 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;56;55;55;56;59;68;55;55 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;70;70;71;71;70;70;69;69 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;85;86;85;84;86;85;85;85;85 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;118;122;112;123;116;117;118;125;115 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;146;151;146;150;141;139;149;141;140 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;67;71;67;65;70;67;68;65 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1447762015231__endTimestamp 04:06:55 INFO - 2015-11-17 04:06:55,234 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.92 (3.6%) stddev-sans-first:4.15 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 107.0 110.0 114.0 113.0 100.0 109.0 110.0 106.0 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:150.50 stddev:15.38 (10.2%) stddev-sans-first:16.09 04:06:55 INFO - 2015-11-17 04:06:55,236 DEBUG : BROWSER_OUTPUT: Values: 150.0 124.0 151.0 159.0 125.0 150.0 151.0 125.0 164.0 129.0 04:06:55 INFO - 2015-11-17 04:06:55,237 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,237 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.50 04:06:55 INFO - 2015-11-17 04:06:55,237 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 162.0 159.0 162.0 160.0 160.0 161.0 162.0 162.0 04:06:55 INFO - 2015-11-17 04:06:55,237 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,238 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:73.00 stddev:16.13 (22.1%) stddev-sans-first:16.56 04:06:55 INFO - 2015-11-17 04:06:55,238 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 86.0 93.0 73.0 73.0 73.0 122.0 90.0 72.0 04:06:55 INFO - 2015-11-17 04:06:55,238 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,238 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:90.50 stddev:21.65 (23.9%) stddev-sans-first:22.37 04:06:55 INFO - 2015-11-17 04:06:55,238 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 134.0 90.0 91.0 91.0 138.0 90.0 91.0 134.0 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 146.0 146.0 145.0 148.0 147.0 147.0 147.0 147.0 04:06:55 INFO - 2015-11-17 04:06:55,239 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:4.06 (7.2%) stddev-sans-first:4.24 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 56.0 55.0 55.0 56.0 59.0 68.0 55.0 55.0 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 70.0 70.0 71.0 71.0 70.0 70.0 69.0 69.0 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,240 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:1.95 (2.3%) stddev-sans-first:0.60 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: Values: 91.0 85.0 86.0 85.0 84.0 86.0 85.0 85.0 85.0 85.0 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:118.00 stddev:3.95 (3.3%) stddev-sans-first:4.16 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: Values: 117.0 118.0 122.0 112.0 123.0 116.0 117.0 118.0 125.0 115.0 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:146.00 stddev:5.01 (3.4%) stddev-sans-first:4.63 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: Values: 137.0 146.0 151.0 146.0 150.0 141.0 139.0 149.0 141.0 140.0 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.95 (2.9%) stddev-sans-first:2.01 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 71.0 67.0 65.0 70.0 67.0 68.0 65.0 04:06:55 INFO - 2015-11-17 04:06:55,241 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:55 INFO - 2015-11-17 04:06:55,242 DEBUG : BROWSER_OUTPUT: 04:06:56 INFO - 2015-11-17 04:06:56,078 INFO : Browser exited with error code: 0 04:06:56 INFO - 2015-11-17 04:06:56,126 INFO : Completed test kraken (00:00:58) 04:06:56 INFO - 2015-11-17 04:06:56,126 INFO : Starting test v8_7 04:06:56 INFO - 2015-11-17 04:06:56,126 DEBUG : operating with platform_type : linux_ 04:06:56 INFO - 2015-11-17 04:06:56,127 INFO : Initialising browser for v8_7 test... 04:06:56 INFO - 2015-11-17 04:06:56,133 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM71A9N/profile http://localhost:49722/getInfo.html 04:06:59 INFO - 2015-11-17 04:06:59,937 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:59 INFO - 2015-11-17 04:06:59,937 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:59 INFO - 2015-11-17 04:06:59,937 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:59 INFO - 2015-11-17 04:06:59,937 DEBUG : BROWSER_OUTPUT: __metrics 04:07:00 INFO - 2015-11-17 04:07:00,098 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:01 INFO - 2015-11-17 04:07:01,153 INFO : Browser initialized. 04:07:01 INFO - 2015-11-17 04:07:01,154 INFO : Running cycle 1/1 for v8_7 test... 04:07:01 INFO - 2015-11-17 04:07:01,154 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM71A9N/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:12 INFO - 2015-11-17 04:07:12,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 141324288 04:07:12 INFO - 2015-11-17 04:07:12,872 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49722/tests/v8_7/run.html (next: http://localhost:49722/tests/v8_7/run.html) 04:07:34 INFO - 2015-11-17 04:07:34,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 178712576 04:07:34 INFO - 2015-11-17 04:07:34,563 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,563 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:34 INFO - 2015-11-17 04:07:34,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:34 INFO - 2015-11-17 04:07:34,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:34 INFO - 2015-11-17 04:07:34,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:34 INFO - 2015-11-17 04:07:34,564 DEBUG : BROWSER_OUTPUT: |0;Richards;171.0863986313088 04:07:34 INFO - 2015-11-17 04:07:34,564 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.51468585878234 04:07:34 INFO - 2015-11-17 04:07:34,564 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.61507595299514 04:07:34 INFO - 2015-11-17 04:07:34,564 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 04:07:34 INFO - 2015-11-17 04:07:34,565 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1101.3215859030836 04:07:34 INFO - 2015-11-17 04:07:34,565 DEBUG : BROWSER_OUTPUT: |5;Earley;819.672131147541 04:07:34 INFO - 2015-11-17 04:07:34,565 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 04:07:34 INFO - 2015-11-17 04:07:34,565 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 04:07:34 INFO - 2015-11-17 04:07:34,565 DEBUG : BROWSER_OUTPUT: |8;Splay;582.4111822947001 04:07:34 INFO - 2015-11-17 04:07:34,566 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:07:34 INFO - 2015-11-17 04:07:34,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:34 INFO - 2015-11-17 04:07:34,566 DEBUG : BROWSER_OUTPUT: __startTimestamp1447762054560__endTimestamp 04:07:34 INFO - 2015-11-17 04:07:34,566 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,566 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:34 INFO - 2015-11-17 04:07:34,567 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:34 INFO - 2015-11-17 04:07:34,567 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,567 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.09 Median:171.09 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,567 DEBUG : BROWSER_OUTPUT: Values: 171.1 04:07:34 INFO - 2015-11-17 04:07:34,567 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,568 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.51 Median:194.51 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,568 DEBUG : BROWSER_OUTPUT: Values: 194.5 04:07:34 INFO - 2015-11-17 04:07:34,568 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,568 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.62 Median:286.62 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,568 DEBUG : BROWSER_OUTPUT: Values: 286.6 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: Values: 5076.1 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: Values: 1101.3 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:819.67 Median:819.67 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,569 DEBUG : BROWSER_OUTPUT: Values: 819.7 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: Values: 12084.3 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: Values: 26025.6 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:582.41 Median:582.41 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: Values: 582.4 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:34 INFO - 2015-11-17 04:07:34,570 DEBUG : BROWSER_OUTPUT: 04:07:35 INFO - 2015-11-17 04:07:35,474 INFO : Browser exited with error code: 0 04:07:35 INFO - 2015-11-17 04:07:35,486 INFO : Completed test v8_7 (00:00:39) 04:07:35 INFO - 2015-11-17 04:07:35,523 INFO : Completed test suite (00:20:10) 04:07:35 INFO - 2015-11-17 04:07:35,523 DEBUG : Working with test: dromaeo_css 04:07:35 INFO - 2015-11-17 04:07:35,523 DEBUG : Generating results file: dromaeo_css 04:07:35 INFO - 2015-11-17 04:07:35,525 DEBUG : Working with test: kraken 04:07:35 INFO - 2015-11-17 04:07:35,525 DEBUG : Generating results file: kraken 04:07:35 INFO - 2015-11-17 04:07:35,525 INFO : javascript benchmark 04:07:35 INFO - 2015-11-17 04:07:35,525 DEBUG : Working with test: v8_7 04:07:35 INFO - 2015-11-17 04:07:35,525 DEBUG : Generating results file: v8_7 04:07:35 INFO - 2015-11-17 04:07:35,526 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:35 INFO - 2015-11-17 04:07:35,599 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 04:07:35 INFO - 2015-11-17 04:07:35,599 DEBUG : process_Request line: dromaeo_css 6924.88 graph.html#tests=[[72,1,35]] 04:07:35 INFO - 2015-11-17 04:07:35,599 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:35 INFO - 2015-11-17 04:07:35,633 DEBUG : process_Request line: kraken 1493.90 graph.html#tests=[[232,1,35]] 04:07:35 INFO - 2015-11-17 04:07:35,633 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:35 INFO - 2015-11-17 04:07:35,666 DEBUG : process_Request line: v8_7 20926.33 graph.html#tests=[[230,1,35]] 04:07:35 INFO - 2015-11-17 04:07:35,667 INFO : javascript benchmark 04:07:35 INFO - 2015-11-17 04:07:35,671 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.54124555586634, 348.16787876974035, 348.5817019576508, 350.0, 351.0609120602388, 13712.382942767574, 13941.302934853242, 16222.432214872482, 16550.503484895456, 17673.82326176738, 16572.171391430442, 16899.746503802424, 17018.0, 17569.73645395317, 17591.29634814609, 5239.0, 5368.865778355534, 5387.434319396466, 5420.5934554908345, 5425.37608175059, 3873.767573945572, 3983.960160398388, 5416.0, 5825.330087040003, 6017.578769486116, 5918.437748413894, 5942.316633587149, 5942.5840191186635, 5973.790917317895, 5975.223220981266, 5798.42015798421, 5952.3154837193415, 5952.791652292149, 5955.315138759033, 5961.284645842505, 5198.090334191539, 5276.630635855492, 5282.867928301785, 5288.603354748371, 5300.443453437372, 20706.585868282702, 20724.689129663067, 20885.895570522203, 21082.472938176667, 21121.366359009255, 2078.5842831433624, 2087.926922557718, 2143.178298446324, 2147.5704859028256, 2170.967435488469, 12995.805062924064, 13106.737865242641, 13227.669308267274, 13321.533746318832, 13469.191848489025, 1778.262021261175, 1801.234475347985, 1802.6034272460038, 1808.620189760152, 1883.0772921268617, 60776.0, 61291.693541532455, 61657.0, 62061.37938620601, 62476.0, 9510.239180865514, 9862.65480708186, 9876.753081172885, 9911.513273009106, 9930.354526955725, 12712.982961363068, 12750.426230819636, 12814.615561533168, 12840.357982101044, 12842.293673847842, 7565.0, 7592.620368981528, 7627.656755446018, 7764.805879853049, 7777.494462859896, 7416.85166296671, 7510.399168066541, 7512.887306690404, 7762.379009679212, 7822.295993360625, 5962.731677074542, 6001.339852616209, 6003.369646187175, 6006.189164462829, 6033.637981721023, 1616.4504068616727, 1683.2677785163494, 1693.5088824240831, 1698.2273065755298, 1704.7783788107467, 855.1747563601155, 882.5498995512206, 904.742148487691, 918.1552971266451, 966.3042609321277, 11565.935027217794, 12435.191712538655, 17389.65220695579, 17493.65012699739, 17892.10539473021, 497.420505111541, 497.8232727381727, 505.72943475241306, 509.17005281391096, 528.5058470330254, 6475.190601174853, 6610.0, 6620.569662971891, 6633.668316584151, 6738.19141702989, 565712.0, 569771.0, 571130.0, 574184.0, 576897.0, 70208.64895675489, 77285.0, 78749.0, 79279.60360198162, 79602.6019869897, 556.1435389500206, 567.1917517537493, 567.9034564124108, 568.1364326224199, 568.590614757374, 11079.224454288122, 11423.143264255048, 11557.01765349921, 11657.300561966309, 11666.76666466683, 35733.82133089318, 35763.0, 36118.27763444664, 36856.44715329219, 37090.0, 47775.0, 48533.0, 48661.0, 49533.50466495289, 49575.256371155185, 6686.83282917931, 6722.428593569602, 6784.76253331131, 6791.04925310447, 6791.796246112624, 8784.824303513766, 11770.705732356759, 11876.465559050037, 12110.51557937708, 12451.937740311241, 10685.626003089854, 10779.461026948464, 10875.836862446911, 10928.508217130408, 10941.23411361197, 10159.288849780445, 10448.081969261528, 10509.684709458728, 10549.947250264007, 10969.0, 8845.292376609726, 8849.24781393563, 10892.128629709763, 10985.560577576807, 11228.326300422, 6760.222574404006, 6848.2466928638805, 6873.862522749417, 6885.862282754217, 6918.965405172942, 10720.0, 10763.327244765507, 10909.83635245456, 10958.342499450058, 11046.944765276123], "dojo.html": [3253.446914024616, 3314.701676849083, 3361.226917808904, 3370.427027405341, 3376.6285708572054, 5412.4587541245855, 5522.0336441122845, 5541.196526503654, 5691.08942569189, 5697.373288938219, 5479.123340265558, 5563.944360556393, 5626.606137570372, 5634.014047541674, 5650.5479561635075, 4961.776720047588, 4973.254011898217, 4982.9252561211615, 5035.823746168885, 5038.345015148026, 4953.281774142747, 5143.177091665334, 5160.14857548504, 5225.242339860718, 5244.213367994793, 5034.672746271499, 5082.79668813247, 5128.102582048164, 5136.563392111675, 5165.251038599419, 5105.412877519096, 5197.610179236534, 5203.349581302337, 5212.556932660728, 5253.028189784902, 4909.361782968227, 5024.296598476216, 5122.410922743895, 5152.407473140599, 5167.379914410257, 5333.759980800874, 5416.566674666017, 5460.563154947635, 5474.096774032319, 5491.28613280275, 6105.572609917308, 6107.206063211798, 6113.755449782004, 6114.357992410777, 6114.510839132903, 5956.255468066492, 6072.210612620375, 6154.476869466101, 6172.47533959614, 6180.134781130645, 5590.664560126405, 5670.461306175906, 5764.193012978187, 5801.53587712982, 5803.245578074823, 6229.2524897012645, 6246.843828904313, 6247.875042499125, 6250.249970003629, 6253.937460625427, 6005.669688167105, 6012.819615411545, 6012.947734146507, 6015.3383127855905, 6021.458068773832, 5880.94119058804, 5907.320658124285, 5982.40175982407, 5984.7606095756555, 6039.66781826995, 5995.940040599626, 6011.308699499614, 6068.362821903725, 6073.635581865014, 6084.969575152096, 6108.908366374508, 6113.327533971348, 6119.173911521976, 6123.601965872204, 6128.816135515942, 4483.0, 4492.348609451677, 4584.266517357207, 4587.311903214478, 4607.493175750665, 4018.0758425562285, 4062.207869465426, 4062.9187416252103, 4095.9385609215888, 4098.672106231495, 5505.972470137704, 5787.102999035156, 5787.913181302284, 5789.3052833659385, 5795.768169273266, 5993.880122397528, 6017.398260173947, 6051.515878729691, 6061.6666083365835, 6129.448349648553, 5759.769609215668, 5855.707214639337, 5855.912161317584, 5856.736446859902, 5859.20900678403, 5054.873628159252, 5303.549198318109, 5317.1492561190025, 5319.654222475604, 5320.813771517978, 6002.0, 6051.969740151271, 6057.515398768176, 6101.84745381369, 6128.95807712681, 6033.607815491979, 6042.0332746760305, 6046.395360463918, 6047.818565443044, 6128.4790792783115, 5880.500157486662, 6014.518838492998, 6158.630482171084, 6163.876722465436, 6188.319284878749, 5999.130126131774, 6112.723886728499, 6113.266408031065, 6117.663528505975, 6127.234095738033, 6176.938230617637, 6191.5665903388135, 6195.411435913581, 6201.441870231521, 6202.627842329474, 5780.132980053026, 5826.70866456684, 5916.55625828056, 6068.757249710139, 6074.969625152023, 5923.259592550931, 5951.880962380815, 5960.374160713236, 5967.403259674172, 5970.641761494324, 5823.5923485355615, 5866.2960444746905, 5867.677277749594, 5870.383609720918, 5876.382979787061, 5764.711764411679, 5766.192733017297, 5871.647701137946, 5934.19888315072, 5947.940520594739, 5828.883422331445, 5843.590948633555, 5844.824655260349, 5845.853853653693, 5866.120081987736], "mootools.html": [1337.959861204163, 1708.632643981544, 1768.3103589600057, 1785.6964316066267, 1799.424184261036, 7045.978333141691, 7761.107472640648, 7852.528848269108, 7882.330001949841, 7891.36869050476, 7606.657700403482, 7771.378289736822, 7787.454878158531, 7788.805279867992, 7790.259925307101, 1988.8309493693052, 2035.155410504639, 2248.2580748353084, 2296.334063121693, 2326.1044497868356, 2276.635738281875, 2282.463621049052, 2286.3598192506124, 2287.691161693175, 2289.53064621753, 2224.232639739287, 2299.9310020699404, 2301.5857145713767, 2301.7698230177016, 2301.8964146613444, 1999.820016198542, 2037.1749441476227, 2219.5782801267787, 2249.6513040478753, 2251.5271792923504, 2271.943201419978, 2274.5337205872756, 2303.285981345788, 2304.7003889494426, 2340.9180678676166, 7788.260115289038, 7871.921280787176, 7875.684972601089, 7889.053313602347, 7890.250426209501, 4669.649776266793, 4739.0758802033615, 4743.0988112258565, 4746.430428348585, 4781.019890922353, 3118.5322201669705, 3133.7934895065337, 3161.3045130071346, 3177.9682203177904, 3231.579894613709, 1024.8052869954686, 1025.0979138358198, 1042.6246551241547, 1060.8355704865758, 1080.6060182364818, 10903.781924361547, 10906.072983796386, 10915.126789856793, 10920.726981825517, 10927.978324010084, 4162.708610397243, 4282.464691913511, 4286.099919016979, 4299.484061912591, 4380.189664912002, 9386.15524602789, 9422.575984080733, 9429.622815087458, 9434.528273586293, 9436.764080897896, 4734.076855013308, 4736.550027747358, 4783.473817880031, 4783.7129772213775, 4783.760811959388, 4330.437043184366, 4342.761148136883, 4343.3484977253665, 4344.087741574304, 4348.130373925228, 3696.8706095287075, 3740.382836831947, 3747.100695833035, 3760.9059773505883, 3779.4141908004303, 1180.2092597959388, 1197.060307658484, 1212.1393810394718, 1213.5327898759042, 1219.0552321950559, 1014.3356101753363, 1280.7630588341187, 1286.0, 1290.4193113099143, 1362.8500864904852, 6409.775657851953, 7627.199144089902, 7768.456208065494, 7768.65041073153, 7769.339606133542, 692.9341712537301, 694.6804469943883, 704.2745971649107, 706.3854446631361, 709.4395427612128, 5504.889902201933, 5560.221568980346, 5581.553475721932, 5616.045272303718, 5620.606557541015, 9418.858717119248, 9450.054994500633, 9475.0, 9629.470379129076, 9656.32405731606, 9293.303002274857, 9395.530223488799, 9474.526273686288, 9512.762180945532, 9532.666356677482, 7315.012473316035, 7343.926560734431, 7396.778096657109, 7405.111386633531, 7417.629118544159, 6964.895526567004, 7131.42948564124, 7148.17795953472, 7159.856802863809, 7194.2086370498155, 8179.263866252066, 8259.091499935123, 8452.070272270168, 8460.619272132892, 8461.111583283913, 8435.746927592181, 8516.74449766508, 8661.523616200917, 8668.219860212359, 8775.166359195866, 7058.188308344401, 7084.681189346388, 7128.144622645315, 7137.714491420285, 7154.284571543012, 7472.77581672529, 7664.425168112302, 7671.462997590115, 7733.4973226740085, 7757.92242077572, 7125.964370178116, 7182.8563428730085, 7251.492395532473, 7314.0, 7316.231795661379, 7111.7866464006165, 7125.501214915113, 7158.176809666955, 7250.782476525713, 7313.707451701873, 6570.47436205112, 6593.736250549924, 6637.734490620514, 6668.933310666831, 6672.165979252593, 6241.095041219089, 6481.254655714464, 6641.203055633355, 6642.269350371552, 6648.501362397937, 6409.775657851953, 6469.061986012096, 6469.547131700736, 6486.610803351814, 6487.675616219264], "ext.html": [595.062776127599, 599.6402158704777, 600.0099835271801, 607.204562023749, 612.3631423319748, 31586.0, 38917.0, 39550.0, 39574.208515829705, 39735.403968940416, 42713.0, 43139.78430107853, 43205.35191972115, 43206.56793432065, 43227.78386108073, 7485.251474852498, 7618.580978046205, 8627.65489380424, 8791.164839340252, 8798.340124490656, 7614.238576142397, 10329.948350258239, 10409.68770936873, 10499.212559058064, 10552.472376381189, 10169.491525423698, 10248.641297554586, 10270.897291027106, 10274.589016439333, 10289.948550257239, 7732.574708391036, 7916.208379162038, 10115.089641932225, 10212.591496340137, 10217.540210690537, 10312.071913527743, 10574.841377379345, 10577.682669519927, 10580.68257952255, 10582.206334524864, 40498.190036199114, 40512.392314115314, 40543.972801359814, 40564.0, 41151.1769764606, 3296.703296703284, 3891.0855948851995, 3966.0283230608397, 3967.0677390813134, 4003.779792111433, 30442.54336184959, 30465.0, 30858.691413085806, 32036.679633203836, 32363.352732945208, 3552.3326753102474, 3558.1104723819044, 3610.151614370621, 3616.2044350242904, 3639.927201455956, 275797.0, 276469.0, 277095.0, 277670.22329776647, 278296.60851695813, 57279.42720572824, 58295.41704582985, 58972.0, 59477.810443790884, 59499.405005950255, 63421.682891585246, 64190.35809641844, 64212.0, 64325.35674643287, 64524.67737661282, 15410.768838467431, 15705.764413533807, 15757.763633545506, 15785.842141578667, 15809.525714228592, 12330.383480825923, 12423.378831058411, 12430.067744919168, 12437.502499900083, 12445.564405245954, 18944.52638684044, 19001.334953276568, 19135.521611959535, 19659.508512287306, 19730.802691973182, 7340.559566426032, 7557.735479258309, 7595.772126836204, 7610.467267291237, 7643.4267429942975, 930.2325581395403, 942.5240253671989, 947.7393716727955, 991.5240684471494, 1025.6256466389714, 28497.355077702236, 28621.71378286232, 28658.85670571634, 28942.42115157685, 29148.85425572901, 1045.785613949154, 1052.5737076484036, 1115.6318414923219, 1125.926814757038, 1200.4237965776476, 14734.189619570812, 14838.0, 15183.620409489851, 15230.847691523164, 16073.758893616605, 320355.0, 324163.0, 325295.0, 326846.0, 327255.0, 53321.0, 53506.46493535015, 53560.19659705107, 53582.73208633932, 53636.0, 1325.118796000668, 1346.3402932562974, 1347.5148946379295, 1361.0200655528201, 1363.2842757552364, 26106.608400874382, 28597.571036434885, 28769.100296082255, 29224.123276301743, 29716.0, 46789.76605116953, 47017.764911175225, 47142.29286560773, 47206.76396617995, 47259.0, 279106.0, 282002.0, 282839.0, 283156.0, 283301.0, 27747.0, 28267.43465130645, 31135.84432077825, 31704.365912681154, 31950.360992779548, 38468.807655961544, 38610.42084368681, 38920.221595568495, 39245.80377098211, 39583.0, 34900.0, 35111.824440878656, 35380.29239415146, 35451.46822797608, 35741.46387804133, 34846.12884677904, 35065.12337191489, 35268.64731352756, 35555.0, 35866.64133358633, 35375.29249415049, 35604.0, 35612.28775424529, 36364.636353636124, 36687.04724862109, 31413.52879706852, 32164.0, 32316.0, 32362.676373235965, 32460.350792983536, 24919.626205607292, 25129.497410052063, 25132.12037578676, 25267.113880996716, 25436.745632543436], "prototype.html": [326.5183853815622, 326.8398484742476, 333.3483040655519, 335.6593058046084, 339.84197348233084, 5865.442782935625, 5929.34777174511, 5992.520598352126, 6029.969850150748, 6096.390360963901, 5866.6480011199255, 5940.465358117768, 5995.790147344844, 6016.067509536018, 6025.427584379488, 4652.976735116336, 4654.4880063193195, 4656.0687862427485, 4661.836835710751, 4666.090112428078, 4355.956440435587, 4435.534268901767, 4530.456345238576, 4640.0, 4665.346851440784, 4563.5664611861985, 4565.931511027337, 4588.77056147193, 4590.380298659688, 4628.259478483444, 4630.467496237942, 4635.281531362611, 4637.049404871993, 4637.814487420499, 4646.3495110684535, 4048.352263637804, 4052.53395859477, 4053.4527838741687, 4054.553999060101, 4061.1268577256033, 5604.187392828057, 5691.9146212806845, 5727.484526392603, 5728.198052272685, 5741.138829175616, 5332.120200166968, 5368.570514358842, 5372.059889519358, 5377.327834020747, 5386.78452861885, 6063.787767428119, 6389.105525226472, 6396.0725694774, 6396.93603063968, 6404.583702059398, 4343.500497442803, 4405.074934263808, 4454.866354009385, 4489.551044895517, 4492.124035813018, 6584.604923704593, 6627.138471998657, 6628.370304821035, 6630.038644396535, 6643.368879956396, 4584.083183363274, 4585.472670642852, 4588.357629931812, 4590.242609969385, 4590.334401511829, 4391.099824536026, 4509.616682582017, 4528.932066019012, 4650.627949764011, 4667.043256132485, 5267.394249661262, 5276.208568714724, 5288.735563221823, 5289.809792796667, 5297.364316282071, 6364.904526432108, 6453.096566480603, 6453.741850326029, 6460.063290822804, 6465.2564955030775, 1585.484717466828, 1606.6063814365555, 1607.9196040198178, 1609.3562574969872, 1609.3562574970106, 1050.821360368739, 1064.302881612545, 1067.2795862792584, 1068.124138206663, 1092.4428541443763, 6236.594621349598, 6239.407256310643, 6240.251169859646, 6242.625442473466, 6247.312795592481, 6661.2006559213205, 6669.566478179, 6672.366125218096, 6673.666316684146, 6677.933220667828, 6065.909011364833, 6228.750849966042, 6236.438720515175, 6238.563300568917, 6244.687765611701, 3583.8566457341412, 3617.149969757105, 3617.1680513482047, 3617.565892092966, 3623.1847834237615, 6784.559003664845, 6788.253292137861, 6792.864142717118, 6793.490488213305, 6801.7619383322335, 6684.63234522106, 6814.0, 6827.1807383113355, 6829.726810927507, 6830.077939478107, 6779.017042528806, 6801.829954251084, 6807.115075040312, 6814.250432452426, 6818.0, 6394.680265986775, 6520.282768895323, 6596.406323430914, 6638.634875081917, 6648.9002664961035, 6568.343165683394, 6611.471082313499, 6626.304238054935, 6628.83427914306, 6640.369164929324, 6861.965690171517, 6865.588064716133, 6866.519343645897, 6870.0, 6873.896891546531, 4368.4321038264825, 4476.328550717419, 4481.708688935209, 4516.977415112903, 4525.094981003746, 6628.304028077176, 6639.136912201383, 6644.235912870082, 6648.867022659423, 6649.434798042221, 6443.09796628463, 6466.288708241996, 6480.25477070143, 6482.416582507597, 6486.610803351814, 6368.872622547616, 6472.741090356333, 6482.805515834532, 6564.376384243489, 6571.178602674666, 6425.6827350394, 6436.0, 6439.613623182624, 6440.162778838721, 6443.645599491885, 6598.10925525048, 6598.967005164944, 6599.109120268894, 6600.1089852869245, 6611.107500487373, 6185.567010309415, 6389.8722025560155, 6394.296627371078, 6398.648074355955, 6412.294647588855], "yui.html": [786.1892101966959, 846.5132548784443, 852.6035393542002, 856.5503110866795, 858.9914100858994, 13278.93360533196, 13363.866361336395, 13620.931895340522, 13651.863481365184, 13655.453781848726, 12492.437840297185, 12528.624141275777, 12633.55782547611, 12638.810417843717, 12655.810162847565, 682.8224661587973, 697.8883378659416, 818.9803694400465, 820.7168526858254, 823.9505629662209, 823.2508417340222, 842.9072801991776, 843.3169133002287, 846.2172490446343, 850.7915560687641, 878.5343767803074, 883.849745543256, 885.4731434796286, 886.0829041941591, 886.5434301334818, 712.7612249896291, 730.4704089535071, 868.8392647360258, 871.4074429388014, 874.1695389380114, 643.4498503779295, 644.5745807766851, 645.4416929356073, 645.5932762359683, 645.8288553533317, 13396.933015334958, 13484.460621575125, 13529.255890925995, 13545.0, 13549.661258468519, 11203.663890083311, 11821.34982575958, 11838.408079595985, 12130.332831694253, 12432.0, 9673.371230870041, 9810.362326448758, 9916.157126644244, 9954.104130628279, 9994.400335979864, 3594.4967704521387, 3624.1664417184197, 3631.4734363517405, 3642.9981755017316, 3651.5070465487083, 44644.0, 45108.0, 45164.774176129235, 45536.3169552457, 46890.76554617205, 9530.428174309563, 9538.189253913357, 9595.376300540582, 9602.519874006271, 9738.756531086638, 12491.87508124907, 12613.180143290656, 12617.0, 12625.810612840814, 12631.621051368473, 6681.064650948871, 6903.792886213421, 7039.577625342394, 7096.822579435556, 7147.035150254753, 4310.0, 4323.610875021263, 4323.697341186087, 4335.826566937287, 4363.410939523187, 2948.1450379390167, 2974.449726800549, 2984.940301193964, 2985.387995460925, 3003.7897347185926, 447.29550957242475, 451.9231730605805, 465.60423639906486, 466.28658153025924, 466.36108531312317, 633.3381616210978, 656.1306269193337, 671.4829581222432, 681.7681988124061, 701.4423533290944, 8010.239027292398, 8249.876251856227, 8791.164839340252, 8794.34042446819, 8924.375293729376, 542.6879544262065, 568.464647671382, 606.9787557435469, 705.982350441243, 719.4675939804507, 3818.4272359145793, 3904.531456225271, 4021.698372622065, 4042.43405923171, 4148.647364973951, 51415.0, 54693.179602305994, 54875.72562137164, 54920.725396373564, 55123.44876551183, 49054.50945490571, 49169.0, 50481.0, 50936.74531627318, 51393.486065139616, 45448.77275613601, 46223.76888115538, 46710.76644616755, 47000.0, 47296.97975672038, 8287.0, 8525.916308798662, 8694.434861733967, 8715.0, 9019.113883557198, 34772.82613587017, 34852.30295394129, 35452.0, 35512.64487355093, 35615.82192089126, 41444.58555414528, 41571.0, 43050.569494304655, 44887.77556112198, 45402.54597453983, 7867.134615192439, 8287.41988060854, 8297.917020829715, 8343.123971983097, 8356.749297521084, 9948.40494872958, 11385.658430247106, 11488.885111148782, 11667.241629294069, 12102.0, 10827.643430536558, 10961.287516311415, 11323.15076369259, 11399.544018239509, 11673.766524669629, 10351.482425878827, 10555.894441055798, 10983.780324393627, 11371.43142842871, 11505.194636375374, 7309.707611695685, 9652.613895444385, 10583.31208471447, 10787.298825576312, 11085.334879907232, 9420.246380289424, 9495.335326527353, 9583.304458018625, 9686.0, 9762.56068476906, 9630.0, 9813.214942804701, 9841.163501102486, 9896.851547226654, 9948.55231514598]}, "summary": {"lowerIsBetter": false, "suite": 6924.8807523942, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8023.363536228586, "unit": "ms", "value": 8023.363536228586}, "dojo.html": {"lowerIsBetter": false, "filtered": 5569.346059764902, "unit": "ms", "value": 5569.346059764902}, "mootools.html": {"lowerIsBetter": false, "filtered": 4481.034279124705, "unit": "ms", "value": 4481.034279124705}, "ext.html": {"lowerIsBetter": false, "filtered": 18797.792161433306, "unit": "ms", "value": 18797.792161433306}, "prototype.html": {"lowerIsBetter": false, "filtered": 4837.01738220913, "unit": "ms", "value": 4837.01738220913}, "yui.html": {"lowerIsBetter": false, "filtered": 6056.378914235973, "unit": "ms", "value": 6056.378914235973}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447760844, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 164.0, 162.0, 159.0, 162.0, 160.0, 160.0, 161.0, 162.0, 162.0], "ai-astar": [108.0, 110.0, 107.0, 110.0, 114.0, 113.0, 100.0, 109.0, 110.0, 106.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [150.0, 124.0, 151.0, 159.0, 125.0, 150.0, 151.0, 125.0, 164.0, 129.0], "json-stringify-tinderbox": [68.0, 69.0, 70.0, 70.0, 71.0, 71.0, 70.0, 70.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [137.0, 146.0, 151.0, 146.0, 150.0, 141.0, 139.0, 149.0, 141.0, 140.0], "json-parse-financial": [55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 59.0, 68.0, 55.0, 55.0], "stanford-crypto-sha256-iterative": [66.0, 67.0, 67.0, 71.0, 67.0, 65.0, 70.0, 67.0, 68.0, 65.0], "audio-fft": [71.0, 73.0, 86.0, 93.0, 73.0, 73.0, 73.0, 122.0, 90.0, 72.0], "imaging-darkroom": [148.0, 148.0, 146.0, 146.0, 145.0, 148.0, 147.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [117.0, 118.0, 122.0, 112.0, 123.0, 116.0, 117.0, 118.0, 125.0, 115.0], "audio-oscillator": [90.0, 91.0, 134.0, 90.0, 91.0, 91.0, 138.0, 90.0, 91.0, 134.0], "stanford-crypto-aes": [91.0, 85.0, 86.0, 85.0, 84.0, 86.0, 85.0, 85.0, 85.0, 85.0], "imaging-desaturate": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1493.9, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.6, "unit": "ms", "value": 82.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 142.8, "unit": "ms", "value": 142.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.3, "unit": "ms", "value": 118.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.0, "unit": "ms", "value": 57.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.0, "unit": "ms", "value": 104.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.7, "unit": "ms", "value": 108.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.7, "unit": "ms", "value": 85.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.1, "unit": "ms", "value": 96.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447760844, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.51468585878234], "Encrypt": [286.61507595299514], "NavierStokes": [4830.917874396136], "Decrypt": [5076.1421319796955], "Splay": [582.4111822947001], "Richards": [171.0863986313088], "RegExp": [26025.641025641027], "Earley": [819.672131147541], "Boyer": [12084.33734939759], "RayTrace": [1101.3215859030836]}, "summary": {"lowerIsBetter": false, "suite": 20926.33103293825, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 339.9126379999999, "unit": "score", "value": 339.9126379999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 928.7055090000001, "unit": "score", "value": 928.7055090000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.43765699999998, "unit": "score", "value": 52.43765699999998}, "Splay": {"lowerIsBetter": false, "filtered": 139.92004699999995, "unit": "score", "value": 139.92004699999995}, "RegExp": {"lowerIsBetter": false, "filtered": 35.003364532019674, "unit": "score", "value": 35.003364532019674}, "Richards": {"lowerIsBetter": false, "filtered": 206.34019000000004, "unit": "score", "value": 206.34019000000004}, "Earley": {"lowerIsBetter": false, "filtered": 813.08486, "unit": "score", "value": 813.08486}, "Boyer": {"lowerIsBetter": false, "filtered": 55.150976071784655, "unit": "score", "value": 55.150976071784655}, "RayTrace": {"lowerIsBetter": false, "filtered": 671.910012, "unit": "score", "value": 671.910012}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-057"}, "testrun": {"date": 1447760844, "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": "20151117013036", "branch": "Firefox", "revision": "e61e64f29a004f9a3042810a093b24dabbf56731"}}] 04:07:35 INFO - RETURN: dromaeo_css: 6924.88 04:07:35 INFO - RETURN: kraken: 1493.90 04:07:35 INFO - RETURN: v8_7: 20926.33 04:07:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20926.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1493.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6924.88"}}} 04:07:35 INFO - Return code: 0 04:07:35 INFO - # TBPL SUCCESS # 04:07:35 INFO - Running post-action listener: _resource_record_post_action 04:07:35 INFO - Running post-run listener: _resource_record_post_run 04:07:36 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 511643648; Read time: 548; Write time: 529384 04:07:36 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 241442816; Read time: 264; Write time: 310224 04:07:36 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 266321920; Read time: 284; Write time: 176220 04:07:36 INFO - Running post-run listener: _upload_blobber_files 04:07:36 INFO - Blob upload gear active. 04:07:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:36 INFO - Copying logs to upload dir... 04:07:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.709786 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-17 04:07:36.220707) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:36.224348) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010124 build_url: 'https://queue.taskcluster.net/v1/task/vDnpw1RBSy6QjhrWlnjyJg/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-17 04:07:36.275129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:36.275520) ========= 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-1447760371.53378-2055380518 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 04:07:36.326101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:07:36.326452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 04:07:36.326778) ========= ========= Total master_lag: 0.22 =========